(   0.000|   0.000) I: [pulseaudio] main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not permitted
(   0.000|   0.000) I: [pulseaudio] main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not permitted
(   0.000|   0.000) D: [pulseaudio] core-rtclock.c: Timer slack is set to 50 us.
(   0.016|   0.016) I: [pulseaudio] core-util.c: Failed to acquire high-priority scheduling: No such file or directory
(   0.016|   0.000) I: [pulseaudio] main.c: This is PulseAudio 5.0
(   0.016|   0.000) D: [pulseaudio] main.c: Compilation host: x86_64-pc-linux-gnu
(   0.016|   0.000) D: [pulseaudio] main.c: Compilation CFLAGS: -g -O0 -ggdb -Wall -W -Wextra -pipe -Wno-long-long -Wno-overlength-strings -Wunsafe-loop-optimizations -Wundef -Wformat=2 -Wlogical-op -Wsign-compare -Wformat-security -Wmissing-include-dirs -Wformat-nonliteral -Wpointer-arith -Winit-self -Wdeclaration-after-statement -Wfloat-equal -Wmissing-prototypes -Wredundant-decls -Wmissing-declarations -Wmissing-noreturn -Wshadow -Wendif-labels -Wcast-align -Wstrict-aliasing -Wwrite-strings -Wno-unused-parameter -ffast-math -fno-common -fdiagnostics-show-option
(   0.016|   0.000) D: [pulseaudio] main.c: Running on host: Linux x86_64 3.14.7-tuxonice #4 SMP PREEMPT Tue Jun 24 16:39:08 EEST 2014
(   0.016|   0.000) D: [pulseaudio] main.c: Found 4 CPUs.
(   0.016|   0.000) I: [pulseaudio] main.c: Page size is 4096 bytes
(   0.016|   0.000) D: [pulseaudio] main.c: Compiled with Valgrind support: yes
(   0.016|   0.000) D: [pulseaudio] main.c: Running in valgrind mode: no
(   0.016|   0.000) D: [pulseaudio] main.c: Running in VM: no
(   0.016|   0.000) D: [pulseaudio] main.c: Optimized build: no
(   0.016|   0.000) D: [pulseaudio] main.c: All asserts enabled.
(   0.017|   0.000) I: [pulseaudio] main.c: Machine ID is dc37b48e722e923c72194e0851465379.
(   0.017|   0.000) I: [pulseaudio] main.c: Using runtime directory /home/username/.pulse/dc37b48e722e923c72194e0851465379-runtime.
(   0.017|   0.000) I: [pulseaudio] main.c: Using state directory /home/username/.pulse.
(   0.017|   0.000) I: [pulseaudio] main.c: Using modules directory /usr/lib64/pulse-5.0/modules.
(   0.017|   0.000) I: [pulseaudio] main.c: Running in system mode: no
(   0.017|   0.000) I: [pulseaudio] main.c: Fresh high-resolution timers available! Bon appetit!
(   0.017|   0.000) D: [pulseaudio] memblock.c: Using shared memory pool with 1024 slots of size 64.0 KiB each, total size is 64.0 MiB, maximum usable slot size is 65472
(   0.017|   0.000) I: [pulseaudio] cpu-x86.c: CPU flags: CMOV MMX SSE SSE2 SSE3 MMXEXT 3DNOW 3DNOWEXT 
(   0.017|   0.000) I: [pulseaudio] svolume_mmx.c: Initialising MMX optimized volume functions.
(   0.017|   0.000) I: [pulseaudio] remap_mmx.c: Initialising MMX optimized remappers.
(   0.017|   0.000) I: [pulseaudio] svolume_sse.c: Initialising SSE2 optimized volume functions.
(   0.017|   0.000) I: [pulseaudio] remap_sse.c: Initialising SSE2 optimized remappers.
(   0.017|   0.000) I: [pulseaudio] sconv_sse.c: Initialising SSE2 optimized conversions.
(   0.017|   0.000) I: [pulseaudio] svolume_orc.c: Initialising ORC optimized volume functions.
(   0.085|   0.067) D: [pulseaudio] alsa-util.c: Trying default with SND_PCM_NO_AUTO_FORMAT ...
(   0.086|   0.001) D: [pulseaudio] alsa-util.c: Managed to open default
(   0.087|   0.000) I: [pulseaudio] alsa-util.c: Disabling tsched mode since BATCH flag is set
(   0.087|   0.000) D: [pulseaudio] alsa-util.c: Maximum hw buffer size is 10922 ms
(   0.090|   0.003) D: [pulseaudio] alsa-util.c: Set buffer size first (to 4797 samples), period size second (to 1199 samples).
(   0.090|   0.000) I: [pulseaudio] alsa-util.c: Device default doesn't support 44100 Hz, changed to 48000 Hz.
(   0.090|   0.000) I: [pulseaudio] alsa-util.c: Device default doesn't support 2 channels, changed to 1.
(   0.094|   0.003) I: [pulseaudio] alsa-source.c: Successfully opened device default.
(   0.094|   0.000) I: [pulseaudio] alsa-source.c: Cannot enable timer-based scheduling, falling back to sound IRQ scheduling.
(   0.094|   0.000) I: [pulseaudio] alsa-source.c: Successfully enabled mmap() mode.
(   0.137|   0.043) W: [pulseaudio] source.c: Default and alternate sample rates are the same.
(   0.137|   0.000) I: [pulseaudio] source.c: Created source 0 "alsa_input.default" with sample spec s16le 1ch 48000Hz and channel map mono
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.resolution_bits = "16"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.api = "alsa"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.class = "sound"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.class = "generic"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.subclass = "generic-mix"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.name = "USB Audio"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.id = "USB Audio"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.subdevice = "0"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.subdevice_name = "subdevice #0"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.device = "0"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.card = "2"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.card_name = "USB Device 0x46d:0x805"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.long_card_name = "USB Device 0x46d:0x805 at usb-0000:00:12.2-6, high speed"
(   0.137|   0.000) I: [pulseaudio] source.c:     alsa.driver_name = "snd_usb_audio"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.bus_path = "pci-0000:00:12.2-usb-0:6:1.2"
(   0.137|   0.000) I: [pulseaudio] source.c:     sysfs.path = "/devices/pci0000:00/0000:00:12.2/usb1/1-6/1-6:1.2/sound/card2"
(   0.137|   0.000) I: [pulseaudio] source.c:     udev.id = "usb-046d_0805_E8569B60-02-U0x46d0x805"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.bus = "usb"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.vendor.id = "046d"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.vendor.name = "Logitech, Inc."
(   0.137|   0.000) I: [pulseaudio] source.c:     device.product.id = "0805"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.product.name = "Webcam C300"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.serial = "046d_0805_E8569B60"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.form_factor = "webcam"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.string = "default"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.buffering.buffer_size = "9594"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.buffering.fragment_size = "2398"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.access_mode = "mmap"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.description = "Webcam C300"
(   0.137|   0.000) I: [pulseaudio] source.c:     device.icon_name = "camera-web-usb"
(   0.138|   0.000) I: [pulseaudio] alsa-source.c: Using 4.0 fragments of size 2398 bytes (24.98ms), buffer size is 9594 bytes (99.94ms)
(   0.138|   0.000) D: [pulseaudio] alsa-source.c: hwbuf_unused=0
(   0.138|   0.000) D: [pulseaudio] alsa-source.c: setting avail_min=1
(   0.138|   0.000) D: [pulseaudio] alsa-util.c: snd_pcm_dump():
(   0.138|   0.000) D: [pulseaudio] alsa-util.c: Plug PCM: Hardware PCM card 2 'USB Device 0x46d:0x805' device 0 subdevice 0
(   0.138|   0.000) D: [pulseaudio] alsa-util.c: Its setup is:
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   stream       : CAPTURE
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   access       : MMAP_INTERLEAVED
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   format       : S16_LE
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   subformat    : STD
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   channels     : 1
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   rate         : 48000
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   exact rate   : 48000 (48000/1)
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   msbits       : 16
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   buffer_size  : 4797
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   period_size  : 1199
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   period_time  : 24979
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   tstamp_mode  : ENABLE
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   period_step  : 1
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   avail_min    : 1199
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   period_event : 1
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   start_threshold  : -1
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   stop_threshold   : 5400941853124067328
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   silence_threshold: 0
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   silence_size : 0
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   boundary     : 5400941853124067328
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   appl_ptr     : 0
(   0.138|   0.000) D: [pulseaudio] alsa-util.c:   hw_ptr       : 0
(   0.139|   0.000) D: [alsa-source-USB Audio] alsa-source.c: Thread starting up
(   0.148|   0.009) I: [alsa-source-USB Audio] core-util.c: Failed to acquire real-time scheduling: No such file or directory
(   0.148|   0.000) I: [alsa-source-USB Audio] alsa-source.c: Starting capture.
(   0.148|   0.000) I: [pulseaudio] module.c: Loaded "module-alsa-source" (index: #0; argument: "device="default" tsched=1").
(   0.165|   0.017) D: [pulseaudio] alsa-util.c: Trying default with SND_PCM_NO_AUTO_FORMAT ...
(   0.187|   0.022) D: [pulseaudio] alsa-util.c: Managed to open default
(   0.187|   0.000) I: [pulseaudio] alsa-util.c: Trying to disable ALSA period wakeups, using timers only
(   0.187|   0.000) D: [pulseaudio] alsa-util.c: snd_pcm_hw_params_set_format(Signed 16 bit Little Endian) failed: Invalid argument
(   0.187|   0.000) D: [pulseaudio] alsa-util.c: snd_pcm_hw_params_set_format(Signed 16 bit Big Endian) failed: Invalid argument
(   0.188|   0.000) D: [pulseaudio] alsa-util.c: snd_pcm_hw_params_set_format(Float 32 bit Little Endian) failed: Invalid argument
(   0.188|   0.000) D: [pulseaudio] alsa-util.c: snd_pcm_hw_params_set_format(Float 32 bit Big Endian) failed: Invalid argument
(   0.188|   0.000) D: [pulseaudio] alsa-util.c: Maximum hw buffer size is 341 ms
(   0.188|   0.000) D: [pulseaudio] alsa-util.c: Set buffer size first (to 96000 samples), period size second (to 96000 samples).
(   0.188|   0.000) I: [pulseaudio] alsa-util.c: Device default doesn't support 44100 Hz, changed to 48000 Hz.
(   0.188|   0.000) I: [pulseaudio] alsa-util.c: Device default doesn't support sample format s16le, changed to s32le.
(   0.188|   0.000) I: [pulseaudio] alsa-util.c: ALSA period wakeups disabled
(   0.188|   0.000) I: [pulseaudio] alsa-sink.c: Successfully opened device default.
(   0.188|   0.000) I: [pulseaudio] alsa-sink.c: Successfully enabled mmap() mode.
(   0.188|   0.000) I: [pulseaudio] alsa-sink.c: Successfully enabled timer-based scheduling mode.
(   0.188|   0.000) W: [pulseaudio] sink.c: Default and alternate sample rates are the same.
(   0.188|   0.000) I: [pulseaudio] sink.c: Created sink 0 "alsa_output.default" with sample spec s32le 2ch 48000Hz and channel map front-left,front-right
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.resolution_bits = "32"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.api = "alsa"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.class = "sound"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.class = "generic"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.subclass = "generic-mix"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.name = "ALC887 Analog"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.id = "ALC887 Analog"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.subdevice = "0"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.subdevice_name = "subdevice #0"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.device = "0"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.card = "0"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.card_name = "HDA ATI SB"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.long_card_name = "HDA ATI SB at 0xfe024000 irq 16"
(   0.188|   0.000) I: [pulseaudio] sink.c:     alsa.driver_name = "snd_hda_intel"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.bus_path = "pci-0000:00:14.2"
(   0.188|   0.000) I: [pulseaudio] sink.c:     sysfs.path = "/devices/pci0000:00/0000:00:14.2/sound/card0"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.bus = "pci"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.vendor.id = "1002"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.vendor.name = "Advanced Micro Devices, Inc. [AMD/ATI]"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.product.id = "4383"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.product.name = "SBx00 Azalia (Intel HDA)"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.form_factor = "internal"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.string = "default"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.buffering.buffer_size = "131072"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.buffering.fragment_size = "8192"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.access_mode = "mmap+timer"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.description = "Built-in Audio"
(   0.188|   0.000) I: [pulseaudio] sink.c:     device.icon_name = "audio-card-pci"
(   0.188|   0.000) I: [pulseaudio] source.c: Created source 1 "alsa_output.default.monitor" with sample spec s32le 2ch 48000Hz and channel map front-left,front-right
(   0.188|   0.000) I: [pulseaudio] source.c:     device.description = "Monitor of Built-in Audio"
(   0.188|   0.000) I: [pulseaudio] source.c:     device.class = "monitor"
(   0.188|   0.000) I: [pulseaudio] source.c:     device.icon_name = "audio-input-microphone"
(   0.189|   0.000) I: [pulseaudio] alsa-sink.c: Using 16.0 fragments of size 8192 bytes (21.33ms), buffer size is 131072 bytes (341.33ms)
(   0.189|   0.000) I: [pulseaudio] alsa-sink.c: Time scheduling watermark is 9.21ms
(   0.189|   0.000) D: [pulseaudio] alsa-sink.c: hwbuf_unused=0
(   0.189|   0.000) D: [pulseaudio] alsa-sink.c: setting avail_min=15943
(   0.189|   0.000) D: [pulseaudio] alsa-util.c: snd_pcm_dump():
(   0.189|   0.000) D: [pulseaudio] alsa-util.c: Plug PCM: Direct Stream Mixing PCM
(   0.189|   0.000) D: [pulseaudio] alsa-util.c: Its setup is:
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   stream       : PLAYBACK
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   access       : MMAP_INTERLEAVED
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   format       : S32_LE
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   subformat    : STD
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   channels     : 2
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   rate         : 48000
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   exact rate   : 48000 (48000/1)
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   msbits       : 32
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   buffer_size  : 16384
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_size  : 1024
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_time  : 21333
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   tstamp_mode  : ENABLE
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_step  : 1
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   avail_min    : 15943
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_event : 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   start_threshold  : -1
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   stop_threshold   : 4611686018427387904
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   silence_threshold: 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   silence_size : 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   boundary     : 4611686018427387904
(   0.189|   0.000) D: [pulseaudio] alsa-util.c: Hardware PCM card 0 'HDA ATI SB' device 0 subdevice 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c: Its setup is:
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   stream       : PLAYBACK
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   access       : MMAP_INTERLEAVED
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   format       : S32_LE
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   subformat    : STD
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   channels     : 2
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   rate         : 48000
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   exact rate   : 48000 (48000/1)
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   msbits       : 32
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   buffer_size  : 16384
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_size  : 1024
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_time  : 21333
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   tstamp_mode  : ENABLE
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_step  : 1
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   avail_min    : 1024
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   period_event : 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   start_threshold  : 1
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   stop_threshold   : 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   silence_threshold: 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   silence_size : 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   boundary     : 4611686018427387904
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   appl_ptr     : 0
(   0.189|   0.000) D: [pulseaudio] alsa-util.c:   hw_ptr       : 8138786
(   0.189|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Thread starting up
(   0.197|   0.007) I: [alsa-sink-ALC887 Analog] core-util.c: Failed to acquire real-time scheduling: No such file or directory
(   0.198|   0.000) I: [alsa-sink-ALC887 Analog] alsa-sink.c: Starting playback.
(   0.199|   0.001) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.199|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.199|   0.000) I: [pulseaudio] module.c: Loaded "module-alsa-sink" (index: #1; argument: "device="default" tsched=1 ").
(   0.199|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.212|   0.013) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.230|   0.017) I: [pulseaudio] module.c: Loaded "module-native-protocol-unix" (index: #2; argument: "").
(   0.230|   0.000) D: [pulseaudio] module.c: Checking for existence of '/usr/lib64/pulse-5.0/modules/module-x11-publish.so': success
(   0.234|   0.003) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.250|   0.016) I: [pulseaudio] module.c: Loaded "module-x11-publish" (index: #3; argument: "").
(   0.255|   0.004) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.262|   0.006) D: [pulseaudio] dbus-util.c: Successfully connected to D-Bus session bus bfd95ad5872c5947a54e579953a980f1 as :1.295
(   0.262|   0.000) D: [pulseaudio] main.c: Got org.PulseAudio1!
(   0.263|   0.000) D: [pulseaudio] main.c: Got org.pulseaudio.Server!
(   0.263|   0.000) I: [pulseaudio] main.c: Daemon startup complete.
(   0.276|   0.013) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.298|   0.021) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.319|   0.021) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.340|   0.021) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(   0.361|   0.021) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Cutting sleep time for the initial iterations by half.
(  49.612|  49.250) D: [alsa-source-USB Audio] alsa-util.c: Got POLLERR from ALSA
(  49.612|   0.000) W: [alsa-source-USB Audio] alsa-util.c: Got POLLNVAL from ALSA
(  49.612|   0.000) D: [alsa-source-USB Audio] alsa-util.c: PCM state is DISCONNECTED
(  49.612|   0.000) W: [alsa-source-USB Audio] alsa-util.c: Could not recover from POLLERR|POLLNVAL|POLLHUP with snd_pcm_prepare(): No such device
(  49.612|   0.000) I: [alsa-sink-ALC887 Analog] alsa-sink.c: Scheduling delay of 39174.92 ms > 9.21 ms, you might want to investigate this to improve latency...
(  49.612|   0.000) D: [alsa-sink-ALC887 Analog] alsa-util.c: Got POLLERR from ALSA
(  49.612|   0.000) D: [alsa-sink-ALC887 Analog] alsa-util.c: Got POLLOUT from ALSA
(  49.612|   0.000) D: [alsa-sink-ALC887 Analog] alsa-util.c: PCM state is SUSPENDED
(  49.613|   0.000) I: [pulseaudio] module.c: Unloading "module-alsa-source" (index: #0).
(  49.613|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c: snd_pcm_avail() returned a value that is exceptionally large: 18446744073640624112 bytes (384306988703 ms).
(  49.613|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c: Most likely this is a bug in the ALSA driver 'snd_hda_intel'. Please report this issue to the ALSA developers.
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c: snd_pcm_dump():
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c: Plug PCM: Direct Stream Mixing PCM
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c: Its setup is:
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   stream       : PLAYBACK
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   access       : MMAP_INTERLEAVED
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   format       : S32_LE
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   subformat    : STD
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   channels     : 2
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   rate         : 48000
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   exact rate   : 48000 (48000/1)
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   msbits       : 32
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   buffer_size  : 16384
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_size  : 1024
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_time  : 21333
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   tstamp_mode  : ENABLE
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_step  : 1
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   avail_min    : 15943
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_event : 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   start_threshold  : -1
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   stop_threshold   : 4611686018427387904
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   silence_threshold: 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   silence_size : 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   boundary     : 4611686018427387904
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c: Hardware PCM card 0 'HDA ATI SB' device 0 subdevice 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c: Its setup is:
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   stream       : PLAYBACK
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   access       : MMAP_INTERLEAVED
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   format       : S32_LE
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   subformat    : STD
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   channels     : 2
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   rate         : 48000
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   exact rate   : 48000 (48000/1)
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   msbits       : 32
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   buffer_size  : 16384
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_size  : 1024
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_time  : 21333
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   tstamp_mode  : ENABLE
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_step  : 1
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   avail_min    : 1024
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   period_event : 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   start_threshold  : 1
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   stop_threshold   : 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   silence_threshold: 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   silence_size : 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   boundary     : 4611686018427387904
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   appl_ptr     : 0
(  49.614|   0.000) E: [alsa-sink-ALC887 Analog] alsa-util.c:   hw_ptr       : 2
(  49.614|   0.000) I: [alsa-sink-ALC887 Analog] alsa-sink.c: Starting playback.
(  49.614|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.614|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  49.874|   0.256) D: [alsa-source-USB Audio] alsa-source.c: Thread shutting down
(  49.874|   0.000) I: [pulseaudio] source.c: Freeing source 0 "alsa_input.default"
(  49.874|   0.000) I: [pulseaudio] module.c: Unloaded "module-alsa-source" (index: #0).
(  54.614|   4.740) D: [alsa-sink-ALC887 Analog] ratelimit.c: 17003 events suppressed
(  54.614|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  54.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.615|   4.997) D: [alsa-sink-ALC887 Analog] ratelimit.c: 17041 events suppressed
(  59.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  59.618|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.615|   4.996) D: [alsa-sink-ALC887 Analog] ratelimit.c: 17055 events suppressed
(  64.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.615|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.616|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.617|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.618|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  64.618|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Wakeup from ALSA!
(  65.118|   0.500) I: [pulseaudio] main.c: Got signal SIGINT.
(  65.118|   0.000) I: [pulseaudio] main.c: Exiting.
(  65.118|   0.000) I: [pulseaudio] main.c: Daemon shutdown initiated.
(  65.119|   0.000) I: [pulseaudio] module.c: Unloading "module-x11-publish" (index: #3).
(  65.122|   0.003) I: [pulseaudio] module.c: Unloaded "module-x11-publish" (index: #3).
(  65.122|   0.000) I: [pulseaudio] module.c: Unloading "module-native-protocol-unix" (index: #2).
(  65.134|   0.011) I: [pulseaudio] module.c: Unloaded "module-native-protocol-unix" (index: #2).
(  65.134|   0.000) I: [pulseaudio] module.c: Unloading "module-alsa-sink" (index: #1).
(  65.134|   0.000) D: [alsa-sink-ALC887 Analog] alsa-sink.c: Thread shutting down
(  65.134|   0.000) I: [pulseaudio] sink.c: Freeing sink 0 "alsa_output.default"
(  65.134|   0.000) I: [pulseaudio] source.c: Freeing source 1 "alsa_output.default.monitor"
(  65.135|   0.000) I: [pulseaudio] module.c: Unloaded "module-alsa-sink" (index: #1).
(  65.151|   0.015) I: [pulseaudio] main.c: Daemon terminated.