clueless

I: caps.c: Limited capabilities successfully to CAP_SYS_NICE.I: caps.c: Dropping root privileges.I: caps.c: Limited capabilities successfully to CAP_SYS_NICE.D: main.c: Started as real root: no, suid root: yesI: main.c: We're in the group 'pulse-rt', allowing high-priority scheduling.I: main.c: RLIMIT_RTPRIO is set to 20, allowing real-time scheduling.I: main.c: RLIMIT_NICE is set to 40, allowing high-priority scheduling.I: core-util.c: Successfully gained nice level -11.D: main.c: Can realtime: yes, can high-priority: yesI: main.c: Giving up CAP_NICED: main.c: Can realtime: yes, can high-priority: yesI: main.c: This is PulseAudio 0.9.14D: main.c: Compilation host: x86_64-redhat-linux-gnuD: main.c: Compilation CFLAGS: -ggdb -Wall -W -Wextra -pedantic -pipe -Wno-long-long -Wvla -Wno-overlength-strings -Wconversion -Wundef -Wformat -Wlogical-op -Wpacked -Wformat-security -Wmissing-include-dirs -Wformat-nonliteral -Wold-style-definition -Wdeclaration-after-statement -Wfloat-equal -Wmissing-declarations -Wmissing-prototypes -Wstrict-prototypes -Wredundant-decls -Wmissing-noreturn -Wshadow -Wendif-labels -Wpointer-arith -Wcast-align -Wwrite-strings -Wno-unused-parameter -ffast-mathD: main.c: Running on host: Linux x86_64 2.6.28.1-16.fc10.x86_64 #1 SMP Tue Jan 20 00:31:38 EST 2009I: main.c: Page size is 4096 bytesD: main.c: Compiled with Valgrind support: noD: main.c: Running in valgrind mode: noD: main.c: Optimized build: noI: main.c: Machine ID is ddbc4243f21f31ca7bd44de7496fffbe.I: main.c: Using runtime directory /home/xbmc/.pulse/ddbc4243f21f31ca7bd44de7496fffbe:runtime.I: main.c: Using state directory /home/xbmc/.pulse.I: main.c: Running in system mode: noI: main.c: Fresh high-resolution timers available! Bon appetit!D: 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 65472I: module-device-restore.c: Sucessfully opened database file '/home/xbmc/.pulse/ddbc4243f21f31ca7bd44de7496fffbe:device-volumes.x86_64-redhat-linux-gnu.gdbm'.I: module.c: Loaded "module-device-restore" (index: #0; argument: "").I: module-stream-restore.c: Sucessfully opened database file '/home/xbmc/.pulse/ddbc4243f21f31ca7bd44de7496fffbe:stream-volumes.x86_64-redhat-linux-gnu.gdbm'.I: module.c: Loaded "module-stream-restore" (index: #1; argument: "").D: cli-command.c: Checking for existance of '/usr/lib64/pulse-0.9/modules/module-hal-detect.so': successI: module-hal-detect.c: Trying capability alsaD: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/computer_alsa_timerD: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/computer_alsa_sequencerD: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_4383_sound_card_0_alsa_capture_2D: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_4383_sound_card_0_alsa_playback_1D: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_4383_sound_card_0_alsa_capture_1D: module-hal-detect.c: Loading module-alsa-sink with arguments 'device_id=0 sink_name=alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 tsched=1'D: alsa-util.c: Trying front:0 with SND_PCM_NO_AUTO_FORMAT ...D: alsa-util.c: Maximum hw buffer size is 371 msI: module-alsa-sink.c: Successfully opened device front:0.I: module-alsa-sink.c: Successfully enabled mmap() mode.I: module-alsa-sink.c: Successfully enabled timer-based scheduling mode.I: (alsa-lib)control.c: Invalid CTL front:0I: alsa-util.c: Unable to attach to mixer front:0: No such file or directoryI: alsa-util.c: Successfully attached to mixer 'hw:0'I: alsa-util.c: Using mixer control "Master".I: module-device-restore.c: Restoring volume for sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.I: module-device-restore.c: Restoring mute state for sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.I: sink.c: Created sink 0 "alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0" with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: module-device-restore.c: Restoring volume for source alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.monitor.I: module-device-restore.c: Restoring mute state for source alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.monitor.I: source.c: Created source 0 "alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.monitor" with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: module-alsa-sink.c: Using 2 fragments of size 32768 bytes, buffer time is 371.52msI: module-alsa-sink.c: Time scheduling watermark is 20.00msD: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=62005I: module-alsa-sink.c: Volume ranges from 0 to 64.I: module-alsa-sink.c: Volume ranges from -64.00 dB to 0.00 dB.I: alsa-util.c: ALSA device lacks independant volume controls for each channel.I: module-alsa-sink.c: Using hardware volume control. Hardware dB scale supported.D: alsa-util.c: snd_pcm_dump():D: alsa-util.c: Soft volume PCMD: alsa-util.c: Control: PCM Playback VolumeD: alsa-util.c: min_dB: -51D: alsa-util.c: max_dB: 0D: alsa-util.c: resolution: 256D: alsa-util.c: Its setup is:D: alsa-util.c:   stream       : PLAYBACKD: alsa-util.c:   access       : MMAP_INTERLEAVEDD: alsa-util.c:   format       : S16_LED: alsa-util.c:   subformat    : STDD: alsa-util.c:   channels     : 2D: alsa-util.c:   rate         : 44100D: alsa-util.c:   exact rate   : 44100 (44100/1)D: alsa-util.c:   msbits       : 16D: alsa-util.c:   buffer_size  : 16384D: alsa-util.c:   period_size  : 8192D: alsa-util.c:   period_time  : 185759D: alsa-util.c:   tstamp_mode  : NONED: alsa-util.c:   period_step  : 1D: alsa-util.c:   avail_min    : 62005D: alsa-util.c:   period_event : 0D: alsa-util.c:   start_threshold  : -1D: alsa-util.c:   stop_threshold   : -1D: alsa-util.c:   silence_threshold: 0D: alsa-util.c:   silence_size : 0D: alsa-util.c:   boundary     : 4611686018427387904D: alsa-util.c: Slave: Hardware PCM card 0 'HDA ATI SB' device 0 subdevice 0D: alsa-util.c: Its setup is:D: alsa-util.c:   stream       : PLAYBACKD: alsa-util.c:   access       : MMAP_INTERLEAVEDD: alsa-util.c:   format       : S16_LED: alsa-util.c:   subformat    : STDD: alsa-util.c:   channels     : 2D: alsa-util.c:   rate         : 44100D: alsa-util.c:   exact rate   : 44100 (44100/1)D: alsa-util.c:   msbits       : 16D: alsa-util.c:   buffer_size  : 16384D: alsa-util.c:   period_size  : 8192D: alsa-util.c:   period_time  : 185759D: alsa-util.c:   tstamp_mode  : NONED: alsa-util.c:   period_step  : 1D: alsa-util.c:   avail_min    : 62005D: alsa-util.c:   period_event : 0D: alsa-util.c:   stD: module-alsa-sink.c: Requested volume: 0: 100% 1: 100%D: module-alsa-sink.c: Thread starting upD: module-alsa-sink.c: Got hardware volume: 0: 100% 1: 100%D: module-alsa-sink.c: Calculated software volume: 0: 100% 1: 100%D: rtpoll.c: Acquired POSIX realtime signal SIGRTMIN+29I: module-alsa-sink.c: Starting playback.I: module.c: Loaded "module-alsa-sink" (index: #2; argument: "device_id=0 sink_name=alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 tsched=1").D: module-hal-detect.c: Loading module-alsa-source with arguments 'device_id=0 source_name=alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0 tsched=1'D: alsa-util.c: Trying front:0 with SND_PCM_NO_AUTO_FORMAT ...D: alsa-util.c: Maximum hw buffer size is 371 msI: module-alsa-source.c: Successfully opened device front:0.I: module-alsa-source.c: Successfully enabled mmap() mode.I: module-alsa-source.c: Successfully enabled timer-based scheduling mode.I: (alsa-lib)control.c: Invalid CTL front:0I: alsa-util.c: Unable to attach to mixer front:0: No such file or directoryI: alsa-util.c: Successfully attached to mixer 'hw:0'I: alsa-util.c: Using mixer control "Capture".I: module-device-restore.c: Restoring volume for source alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0.I: module-device-restore.c: Restoring mute state for source alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0.I: source.c: Created source 1 "alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0" with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: module-alsa-source.c: Using 2 fragments of size 32768 bytes, buffer time is 371.52msI: module-alsa-source.c: Time scheduling watermark is 20.00msD: module-alsa-source.c: hwbuf_unused_frames=0D: module-alsa-source.c: setting avail_min=62005I: module-alsa-source.c: Volume ranges from 0 to 46.I: module-alsa-source.c: Volume ranges from -16.00 dB to 30.00 dB.I: alsa-util.c: All 2 channels can be mapped to mixer channels.I: module-alsa-source.c: Using hardware volume control. Hardware dB scale supported.D: alsa-util.c: snd_pcm_dump():D: alsa-util.c: Soft volume PCMD: alsa-util.c: Control: PCM Playback VolumeD: alsa-util.c: min_dB: -51D: alsa-util.c: max_dB: 0D: alsa-util.c: resolution: 256D: alsa-util.c: Its setup is:D: alsa-util.c:   stream       : CAPTURED: alsa-util.c:   access       : MMAP_INTERLEAVEDD: alsa-util.c:   format       : S16_LED: alsa-util.c:   subformat    : STDD: alsa-util.c:   channels     : 2D: alsa-util.c:   rate         : 44100D: alsa-util.c:   exact rate   : 44100 (44100/1)D: alsa-util.c:   msbits       : 16D: alsa-util.c:   buffer_size  : 16384D: alsa-util.c:   period_size  : 8192D: alsa-util.c:   period_time  : 185759D: alsa-util.c:   tstamp_mode  : NONED: alsa-util.c:   period_step  : 1D: alsa-util.c:   avail_min    : 62005D: alsa-util.c:   period_event : 0D: alsa-util.c:   start_threshold  : -1D: alsa-util.c:   stop_threshold   : -1D: alsa-util.c:   silence_threshold: 0D: alsa-util.c:   silence_size : 0D: alsa-util.c:   boundary     : 4611686018427387904D: alsa-util.c: Slave: Hardware PCM card 0 'HDA ATI SB' device 0 subdevice 0D: alsa-util.c: Its setup is:D: alsa-util.c:   stream       : CAPTURED: alsa-util.c:   access       : MMAP_INTERLEAVEDD: alsa-util.c:   format       : S16_LED: alsa-util.c:   subformat    : STDD: alsa-util.c:   channels     : 2D: alsa-util.c:   rate         : 44100D: alsa-util.c:   exact rate   : 44100 (44100/1)D: alsa-util.c:   msbits       : 16D: alsa-util.c:   buffer_size  : 16384D: alsa-util.c:   period_size  : 8192D: alsa-util.c:   period_time  : 185759D: alsa-util.c:   tstamp_mode  : NONED: alsa-util.c:   period_step  : 1D: alsa-util.c:   avail_min    : 62005D: alsa-util.c:   period_event : 0D: alsa-util.c:   starD: module-alsa-source.c: Thread starting upD: module-alsa-source.c: Requested volume: 0:  83% 1:  83%D: rtpoll.c: Acquired POSIX realtime signal SIGRTMIN+28D: module-alsa-source.c: Got hardware volume: 0:  83% 1:  83%D: module-alsa-source.c: Calculated software volume: 0: 100% 1: 100%I: module.c: Loaded "module-alsa-source" (index: #3; argument: "device_id=0 source_name=alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0 tsched=1").D: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_4383_sound_card_0_alsa_hw_specific_0D: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_4383_sound_card_0_alsa_control__1D: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_960f_sound_card_0_alsa_playback_3D: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_960f_sound_card_0_alsa_hw_specific_0D: module-hal-detect.c: Not loaded device /org/freedesktop/Hal/devices/pci_1002_960f_sound_card_0_alsa_control__1I: module-hal-detect.c: Loaded 2 modules.I: module.c: Loaded "module-hal-detect" (index: #4; argument: "").D: cli-command.c: Checking for existance of '/usr/lib64/pulse-0.9/modules/module-esound-protocol-unix.so': successI: module.c: Loaded "module-esound-protocol-unix" (index: #5; argument: "").I: module.c: Loaded "module-native-protocol-unix" (index: #6; argument: "").I: module-default-device-restore.c: Restored default sink 'alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0'.D: core-subscribe.c: Dropped redundant event due to change event.I: module-default-device-restore.c: Restored default source 'alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0'.I: module.c: Loaded "module-default-device-restore" (index: #7; argument: "").I: module.c: Loaded "module-rescue-streams" (index: #8; argument: "").I: module.c: Loaded "module-always-sink" (index: #9; argument: "").D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-suspend-on-idle.c: Source alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.monitor becomes idle.D: module-suspend-on-idle.c: Source alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0 becomes idle.I: module.c: Loaded "module-suspend-on-idle" (index: #10; argument: "").I: client.c: Created 0 "ConsoleKit Session /org/freedesktop/ConsoleKit/Session5"D: module-console-kit.c: Added new session /org/freedesktop/ConsoleKit/Session5I: module.c: Loaded "module-console-kit" (index: #11; argument: "").I: module.c: Loaded "module-position-event-sounds" (index: #12; argument: "").D: cli-command.c: Checking for existance of '/usr/lib64/pulse-0.9/modules/module-gconf.so': successI: module.c: Loaded "module-gconf" (index: #13; argument: "").I: main.c: Daemon startup complete.D: module-hal-detect.c: dbus: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=NameAcquiredD: module-console-kit.c: dbus: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=NameAcquiredI: client.c: Created 1 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:Test stream.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:Test stream.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:Test stream, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: resampler.c: Channel matrix:D: resampler.c:        I00 D: resampler.c:     +------D: resampler.c: O00 | 1.000D: resampler.c: O01 | 1.000I: resampler.c: Using resampler 'speex-float-3'I: resampler.c: Using float32le as working format.I: resampler.c: Choosing speex quality setting 3.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 0 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec u8 1ch 11025Hz and channel map monoI: protocol-native.c: Requested tlength=249.98 ms, minreq=20.05 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0I: protocol-native.c: Final latency 459.86 ms = 209.89 ms + 2*20.05 ms + 209.89 msD: module-alsa-sink.c: latency set to 209.89msD: module-alsa-sink.c: hwbuf_unused_frames=7128D: module-alsa-sink.c: setting avail_min=40625D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 54660 bytes.D: module-alsa-sink.c: before: 13665D: module-alsa-sink.c: after: 13665D: module-alsa-sink.c: Rewound 54660 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 54660 bytes on render memblockq.D: source.c: Processing rewind...D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=62005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 33100 bytes.I: sink-input.c: Freeing input 0 "Simple DirectMedia Layer"D: module-alsa-sink.c: before: 8275D: module-alsa-sink.c: after: 8275D: module-alsa-sink.c: Rewound 33100 bytes.D: sink.c: Processing rewind...D: source.c: Processing rewind...I: client.c: Freed 1 "Test stream"I: protocol-native.c: Connection died.I: client.c: Created 2 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:xbmc.bin.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:xbmc.bin.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:xbmc.bin, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 1 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=185.76 ms, minreq=92.88 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0I: protocol-native.c: Final latency 185.76 ms = 0.00 ms + 2*92.88 ms + 0.00 msD: module-alsa-sink.c: latency set to 4.00msD: module-alsa-sink.c: hwbuf_unused_frames=16208D: module-alsa-sink.c: setting avail_min=16561D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 65084 bytes.D: module-alsa-sink.c: before: 16271D: module-alsa-sink.c: after: 16271D: module-alsa-sink.c: Rewound 65084 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 65084 bytes on render memblockq.D: source.c: Processing rewind...D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 192 bytes.D: module-alsa-sink.c: before: 48D: module-alsa-sink.c: after: 48D: module-alsa-sink.c: Rewound 192 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 192 bytes on render memblockq.D: source.c: Processing rewind...I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-suspend-on-idle.c: Source alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.monitor idle for too long, suspending ...I: module-suspend-on-idle.c: Source alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0 idle for too long, suspending ...I: module-alsa-source.c: Device suspended...I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 76 bytes.D: module-alsa-sink.c: before: 19I: sink-input.c: Freeing input 1 "Simple DirectMedia Layer"D: module-alsa-sink.c: after: 19D: module-alsa-sink.c: Rewound 76 bytes.D: sink.c: Processing rewind...I: client.c: Freed 2 "xbmc.bin"I: protocol-native.c: Connection died.I: client.c: Created 3 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:XBMC.D: module-stream-restore.c: Not restoring volume for sink input sink-input-by-application-name:XBMC, because already set.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:XBMC, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.I: resampler.c: Using resampler 'speex-float-3'I: resampler.c: Using float32le as working format.I: resampler.c: Choosing speex quality setting 3.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 2 "audio stream" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 48000Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=250.00 ms, minreq=20.00 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=48000, base=4, prebuf=48000, minreq=3840 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=48000, base=4, prebuf=48000, minreq=3840 maxrewind=0I: protocol-native.c: Final latency 460.00 ms = 210.00 ms + 2*20.00 ms + 210.00 msD: module-alsa-sink.c: latency set to 210.00msD: module-alsa-sink.c: hwbuf_unused_frames=7123D: module-alsa-sink.c: setting avail_min=43640D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63900 bytes.I: module-stream-restore.c: Storing volume/mute/device for stream sink-input-by-application-name:XBMC.D: module-alsa-sink.c: before: 15975D: module-alsa-sink.c: after: 15975D: module-alsa-sink.c: Rewound 63900 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63900 bytes on render memblockq.I: module-stream-restore.c: Storing volume/mute/device for stream sink-input-by-application-name:XBMC.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65532 bytes.D: module-alsa-sink.c: Limited to 35748 bytes.D: module-alsa-sink.c: before: 8937D: module-alsa-sink.c: after: 8937D: module-alsa-sink.c: Rewound 35748 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 35748 bytes on render memblockq.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 60564 bytes.D: module-alsa-sink.c: Limited to 34928 bytes.D: module-alsa-sink.c: before: 8732D: module-alsa-sink.c: after: 8732D: module-alsa-sink.c: Rewound 34928 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 34928 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 35084 bytes.I: sink-input.c: Freeing input 2 "audio stream"D: module-alsa-sink.c: before: 8771D: module-alsa-sink.c: after: 8771D: module-alsa-sink.c: Rewound 35084 bytes.D: sink.c: Processing rewind...I: client.c: Freed 3 "XBMC"I: protocol-native.c: Connection died.I: client.c: Created 4 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:Test stream.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:Test stream.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:Test stream, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: resampler.c: Channel matrix:D: resampler.c:        I00 D: resampler.c:     +------D: resampler.c: O00 | 1.000D: resampler.c: O01 | 1.000I: resampler.c: Using resampler 'speex-float-3'I: resampler.c: Using float32le as working format.I: resampler.c: Choosing speex quality setting 3.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 3 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec u8 1ch 11025Hz and channel map monoI: protocol-native.c: Requested tlength=249.98 ms, minreq=20.05 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0I: protocol-native.c: Final latency 459.86 ms = 209.89 ms + 2*20.05 ms + 209.89 msD: module-alsa-sink.c: latency set to 209.89msD: module-alsa-sink.c: hwbuf_unused_frames=7128D: module-alsa-sink.c: setting avail_min=43625D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63436 bytes.D: module-alsa-sink.c: before: 15859D: module-alsa-sink.c: after: 15859D: module-alsa-sink.c: Rewound 63436 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63436 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 36396 bytes.I: sink-input.c: Freeing input 3 "Simple DirectMedia Layer"D: module-alsa-sink.c: before: 9099D: module-alsa-sink.c: after: 9099D: module-alsa-sink.c: Rewound 36396 bytes.D: sink.c: Processing rewind...I: client.c: Freed 4 "Test stream"I: protocol-native.c: Connection died.I: client.c: Created 5 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:xbmc.bin.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:xbmc.bin.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:xbmc.bin, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 4 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=185.76 ms, minreq=92.88 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0I: protocol-native.c: Final latency 185.76 ms = 0.00 ms + 2*92.88 ms + 0.00 msD: module-alsa-sink.c: latency set to 4.00msD: module-alsa-sink.c: hwbuf_unused_frames=16208D: module-alsa-sink.c: setting avail_min=16561D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63420 bytes.D: module-alsa-sink.c: before: 15855D: module-alsa-sink.c: after: 15855D: module-alsa-sink.c: Rewound 63420 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63420 bytes on render memblockq.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 236 bytes.D: module-alsa-sink.c: before: 59D: module-alsa-sink.c: after: 59D: module-alsa-sink.c: Rewound 236 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 236 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 124 bytes.D: module-alsa-sink.c: before: 31I: sink-input.c: Freeing input 4 "Simple DirectMedia Layer"D: module-alsa-sink.c: after: 31D: module-alsa-sink.c: Rewound 124 bytes.D: sink.c: Processing rewind...I: client.c: Freed 5 "xbmc.bin"I: protocol-native.c: Connection died.I: client.c: Created 6 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:Test stream.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:Test stream.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:Test stream, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: resampler.c: Channel matrix:D: resampler.c:        I00 D: resampler.c:     +------D: resampler.c: O00 | 1.000D: resampler.c: O01 | 1.000I: resampler.c: Using resampler 'speex-float-3'I: resampler.c: Using float32le as working format.I: resampler.c: Choosing speex quality setting 3.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 5 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec u8 1ch 11025Hz and channel map monoI: protocol-native.c: Requested tlength=249.98 ms, minreq=20.05 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0I: protocol-native.c: Final latency 459.86 ms = 209.89 ms + 2*20.05 ms + 209.89 msD: module-alsa-sink.c: latency set to 209.89msD: module-alsa-sink.c: hwbuf_unused_frames=7128D: module-alsa-sink.c: setting avail_min=43625D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 64004 bytes.D: module-alsa-sink.c: before: 16001D: module-alsa-sink.c: after: 16001D: module-alsa-sink.c: Rewound 64004 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 64004 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 36404 bytes.I: sink-input.c: Freeing input 5 "Simple DirectMedia Layer"D: module-alsa-sink.c: before: 9101D: module-alsa-sink.c: after: 9101D: module-alsa-sink.c: Rewound 36404 bytes.I: client.c: Freed 6 "Test stream"D: sink.c: Processing rewind...I: protocol-native.c: Connection died.I: client.c: Created 7 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:xbmc.bin.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:xbmc.bin.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:xbmc.bin, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 6 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=185.76 ms, minreq=92.88 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0I: protocol-native.c: Final latency 185.76 ms = 0.00 ms + 2*92.88 ms + 0.00 msD: module-alsa-sink.c: latency set to 4.00msD: module-alsa-sink.c: hwbuf_unused_frames=16208D: module-alsa-sink.c: setting avail_min=16561D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63380 bytes.D: module-alsa-sink.c: before: 15845D: module-alsa-sink.c: after: 15845D: module-alsa-sink.c: Rewound 63380 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63380 bytes on render memblockq.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 272 bytes.D: module-alsa-sink.c: before: 68D: module-alsa-sink.c: after: 68D: module-alsa-sink.c: Rewound 272 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 272 bytes on render memblockq.I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-stream-restore.c: Synced.I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 24 bytes.I: sink-input.c: Freeing input 6 "Simple DirectMedia Layer"D: module-alsa-sink.c: before: 6D: module-alsa-sink.c: after: 6D: module-alsa-sink.c: Rewound 24 bytes.D: sink.c: Processing rewind...I: client.c: Freed 7 "xbmc.bin"I: protocol-native.c: Connection died.I: client.c: Created 8 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:XBMC.D: module-stream-restore.c: Not restoring volume for sink input sink-input-by-application-name:XBMC, because already set.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:XBMC, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 7 "audio stream" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=250.00 ms, minreq=20.00 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=44100, base=4, prebuf=44100, minreq=3528 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=44100, base=4, prebuf=44100, minreq=3528 maxrewind=0I: protocol-native.c: Final latency 460.00 ms = 210.00 ms + 2*20.00 ms + 210.00 msD: module-alsa-sink.c: latency set to 210.00msD: module-alsa-sink.c: hwbuf_unused_frames=7123D: module-alsa-sink.c: setting avail_min=43640D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63696 bytes.D: module-alsa-sink.c: before: 15924D: module-alsa-sink.c: after: 15924D: module-alsa-sink.c: Rewound 63696 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63696 bytes on render memblockq.I: module-stream-restore.c: Storing volume/mute/device for stream sink-input-by-application-name:XBMC.I: module-stream-restore.c: Storing volume/mute/device for stream sink-input-by-application-name:XBMC.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 24236 bytes.D: module-alsa-sink.c: before: 6059D: module-alsa-sink.c: after: 6059D: module-alsa-sink.c: Rewound 24236 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 24236 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 36336 bytes.D: module-alsa-sink.c: before: 9084D: module-alsa-sink.c: after: 9084D: module-alsa-sink.c: Rewound 36336 bytes.D: sink.c: Processing rewind...D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.I: sink-input.c: Freeing input 7 "audio stream"I: client.c: Freed 8 "XBMC"I: protocol-native.c: Connection died.I: client.c: Created 9 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:Test stream.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:Test stream.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:Test stream, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: resampler.c: Channel matrix:D: resampler.c:        I00 D: resampler.c:     +------D: resampler.c: O00 | 1.000D: resampler.c: O01 | 1.000I: resampler.c: Using resampler 'speex-float-3'I: resampler.c: Using float32le as working format.I: resampler.c: Choosing speex quality setting 3.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 8 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec u8 1ch 11025Hz and channel map monoI: protocol-native.c: Requested tlength=249.98 ms, minreq=20.05 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0I: protocol-native.c: Final latency 459.86 ms = 209.89 ms + 2*20.05 ms + 209.89 msD: module-alsa-sink.c: latency set to 209.89msD: module-alsa-sink.c: hwbuf_unused_frames=7128D: module-alsa-sink.c: setting avail_min=43625D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63020 bytes.D: module-alsa-sink.c: before: 15755D: module-alsa-sink.c: after: 15755D: module-alsa-sink.c: Rewound 63020 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63020 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 36260 bytes.I: sink-input.c: Freeing input 8 "Simple DirectMedia Layer"D: module-alsa-sink.c: before: 9065D: module-alsa-sink.c: after: 9065D: module-alsa-sink.c: Rewound 36260 bytes.D: sink.c: Processing rewind...I: client.c: Freed 9 "Test stream"I: protocol-native.c: Connection died.I: client.c: Created 10 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:xbmc.bin.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:xbmc.bin.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:xbmc.bin, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 9 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=185.76 ms, minreq=92.88 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0I: protocol-native.c: Final latency 185.76 ms = 0.00 ms + 2*92.88 ms + 0.00 msD: module-alsa-sink.c: latency set to 4.00msD: module-alsa-sink.c: hwbuf_unused_frames=16208D: module-alsa-sink.c: setting avail_min=16561D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63452 bytes.D: module-alsa-sink.c: before: 15863D: module-alsa-sink.c: after: 15863D: module-alsa-sink.c: Rewound 63452 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63452 bytes on render memblockq.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 204 bytes.D: module-alsa-sink.c: before: 51D: module-alsa-sink.c: after: 51D: module-alsa-sink.c: Rewound 204 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 204 bytes on render memblockq.I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-stream-restore.c: Synced.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 32 bytes.D: module-alsa-sink.c: before: 8I: sink-input.c: Freeing input 9 "Simple DirectMedia Layer"D: module-alsa-sink.c: after: 8D: module-alsa-sink.c: Rewound 32 bytes.D: sink.c: Processing rewind...I: client.c: Freed 10 "xbmc.bin"I: protocol-native.c: Connection died.I: client.c: Created 11 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:Test stream.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:Test stream.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:Test stream, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: resampler.c: Channel matrix:D: resampler.c:        I00 D: resampler.c:     +------D: resampler.c: O00 | 1.000D: resampler.c: O01 | 1.000I: resampler.c: Using resampler 'speex-float-3'I: resampler.c: Using float32le as working format.I: resampler.c: Choosing speex quality setting 3.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 10 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec u8 1ch 11025Hz and channel map monoI: protocol-native.c: Requested tlength=249.98 ms, minreq=20.05 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0I: protocol-native.c: Final latency 459.86 ms = 209.89 ms + 2*20.05 ms + 209.89 msD: module-alsa-sink.c: latency set to 209.89msD: module-alsa-sink.c: hwbuf_unused_frames=7128D: module-alsa-sink.c: setting avail_min=43625D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63168 bytes.D: module-alsa-sink.c: before: 15792D: module-alsa-sink.c: after: 15792D: module-alsa-sink.c: Rewound 63168 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63168 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.I: sink-input.c: Freeing input 10 "Simple DirectMedia Layer"I: client.c: Freed 11 "Test stream"I: protocol-native.c: Connection died.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 36104 bytes.D: module-alsa-sink.c: before: 9026D: module-alsa-sink.c: after: 9026D: module-alsa-sink.c: Rewound 36104 bytes.D: sink.c: Processing rewind...I: client.c: Created 12 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:xbmc.bin.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:xbmc.bin.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:xbmc.bin, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 11 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=185.76 ms, minreq=92.88 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0I: protocol-native.c: Final latency 185.76 ms = 0.00 ms + 2*92.88 ms + 0.00 msD: module-alsa-sink.c: latency set to 4.00msD: module-alsa-sink.c: hwbuf_unused_frames=16208D: module-alsa-sink.c: setting avail_min=16561D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63632 bytes.D: module-alsa-sink.c: before: 15908D: module-alsa-sink.c: after: 15908D: module-alsa-sink.c: Rewound 63632 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63632 bytes on render memblockq.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 320 bytes.D: module-alsa-sink.c: before: 80D: module-alsa-sink.c: after: 80D: module-alsa-sink.c: Rewound 320 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 320 bytes on render memblockq.I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 44 bytes.I: sink-input.c: Freeing input 11 "Simple DirectMedia Layer"D: module-alsa-sink.c: before: 11D: module-alsa-sink.c: after: 11D: module-alsa-sink.c: Rewound 44 bytes.D: sink.c: Processing rewind...I: client.c: Freed 12 "xbmc.bin"I: protocol-native.c: Connection died.I: client.c: Created 13 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:Test stream.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:Test stream.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:Test stream, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: resampler.c: Channel matrix:D: resampler.c:        I00 D: resampler.c:     +------D: resampler.c: O00 | 1.000D: resampler.c: O01 | 1.000I: resampler.c: Using resampler 'speex-float-3'I: resampler.c: Using float32le as working format.I: resampler.c: Choosing speex quality setting 3.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 12 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec u8 1ch 11025Hz and channel map monoI: protocol-native.c: Requested tlength=249.98 ms, minreq=20.05 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=2756, base=1, prebuf=2756, minreq=221 maxrewind=0I: protocol-native.c: Final latency 459.86 ms = 209.89 ms + 2*20.05 ms + 209.89 msD: module-alsa-sink.c: latency set to 209.89msD: module-alsa-sink.c: hwbuf_unused_frames=7128D: module-alsa-sink.c: setting avail_min=43625D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 63024 bytes.D: module-alsa-sink.c: before: 15756D: module-alsa-sink.c: after: 15756D: module-alsa-sink.c: Rewound 63024 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 63024 bytes on render memblockq.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: module-alsa-sink.c: Limited to 36432 bytes.I: sink-input.c: Freeing input 12 "Simple DirectMedia Layer"D: module-alsa-sink.c: before: 9108D: module-alsa-sink.c: after: 9108D: module-alsa-sink.c: Rewound 36432 bytes.D: sink.c: Processing rewind...I: client.c: Freed 13 "Test stream"I: protocol-native.c: Connection died.I: client.c: Created 14 "Native client (UNIX socket client)"D: protocol-native.c: Protocol version: remote 14, local 14I: protocol-native.c: Got credentials: uid=501 gid=501 success=1D: protocol-native.c: SHM possible: yesD: protocol-native.c: Negotiated SHM: yesI: module-stream-restore.c: Restoring device for stream sink-input-by-application-name:xbmc.bin.I: module-stream-restore.c: Restoring volume for sink input sink-input-by-application-name:xbmc.bin.D: module-stream-restore.c: Not restoring mute state for sink input sink-input-by-application-name:xbmc.bin, because already set.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes busy.D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0I: sink-input.c: Created input 13 "Simple DirectMedia Layer" on alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: protocol-native.c: Requested tlength=185.76 ms, minreq=92.88 msD: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.D: memblockq.c: memblockq requested: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0D: memblockq.c: memblockq sanitized: maxlength=32768, tlength=32768, base=4, prebuf=32768, minreq=16384 maxrewind=0I: protocol-native.c: Final latency 185.76 ms = 0.00 ms + 2*92.88 ms + 0.00 msD: module-alsa-sink.c: latency set to 4.00msD: module-alsa-sink.c: hwbuf_unused_frames=16208D: module-alsa-sink.c: setting avail_min=16561D: module-alsa-sink.c: Requesting rewind due to latency change.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 62476 bytes.D: module-alsa-sink.c: before: 15619D: module-alsa-sink.c: after: 15619D: module-alsa-sink.c: Rewound 62476 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 62476 bytes on render memblockq.D: protocol-native.c: Requesting rewind due to end of underrun.D: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 312 bytes.D: module-alsa-sink.c: before: 78D: module-alsa-sink.c: after: 78D: module-alsa-sink.c: Rewound 312 bytes.D: sink.c: Processing rewind...D: sink-input.c: Have to rewind 312 bytes on render memblockq.I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: main.c: Got signal SIGINT.I: main.c: Exiting.I: main.c: Daemon shutdown initiated.I: module.c: Unloading "module-device-restore" (index: #0).I: module.c: Unloaded "module-device-restore" (index: #0).I: module.c: Unloading "module-stream-restore" (index: #1).I: module-alsa-sink.c: Underrun!I: module-alsa-sink.c: Underrun!I: module.c: Unloaded "module-stream-restore" (index: #1).I: module.c: Unloading "module-alsa-sink" (index: #2).D: module-always-sink.c: Autoloading null-sink as no other sinks detected.I: sink.c: Created sink 1 "auto_null" with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightI: source.c: Created source 2 "auto_null.monitor" with sample spec s16le 2ch 44100Hz and channel map front-left,front-rightD: module-null-sink.c: Thread starting upD: rtpoll.c: Acquired POSIX realtime signal SIGRTMIN+27D: module-suspend-on-idle.c: Source auto_null.monitor becomes idle.D: module-suspend-on-idle.c: Sink auto_null becomes idle.I: module.c: Loaded "module-null-sink" (index: #14; argument: "sink_name=auto_null").D: module-suspend-on-idle.c: Sink auto_null becomes busy.D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: sink-input.c: Have to rewind 644 bytes on render memblockq.D: sink-input.c: Have to rewind 644 bytes on implementor.D: module-alsa-sink.c: hwbuf_unused_frames=0D: module-alsa-sink.c: setting avail_min=65005D: sink.c: Requesting rewind due to started moveD: module-alsa-sink.c: Requested to rewind 65536 bytes.D: module-alsa-sink.c: Limited to 40 bytes.D: module-alsa-sink.c: before: 10D: module-alsa-sink.c: after: 10D: module-alsa-sink.c: Rewound 40 bytes.D: sink.c: Processing rewind...D: module-suspend-on-idle.c: Sink alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 becomes idle.D: sink.c: Requesting rewind due to finished moveD: module-null-sink.c: Requested to rewind 352800 bytes.D: sink.c: Processing rewind...I: protocol-native.c: Requested tlength=185.76 ms, minreq=92.88 msD: sink-input.c: Have to rewind 352800 bytes on render memblockq.D: protocol-native.c: Adjust latency mode enabled, configuring sink latency to half of overall latency.D: source.c: Processing rewind...D: module-null-sink.c: Rewound 352800 bytes.D: sink-input.c: Successfully moved sink input 13 from alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0 to auto_null.I: module-rescue-streams.c: Sucessfully moved sink input 13 "xbmc.bin" to auto_null.D: module-rescue-streams.c: No source outputs to move away.D: module-alsa-sink.c: Thread shutting downI: sink.c: Freeing sink 0 "alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0"I: source.c: Freeing source 0 "alsa_output.pci_1002_4383_sound_card_0_alsa_playback_0.monitor"I: module.c: Unloaded "module-alsa-sink" (index: #2).I: module.c: Unloading "module-alsa-source" (index: #3).D: module-rescue-streams.c: No source outputs to move away.D: module-alsa-source.c: Thread shutting downI: source.c: Freeing source 1 "alsa_input.pci_1002_4383_sound_card_0_alsa_capture_0"I: module.c: Unloaded "module-alsa-source" (index: #3).I: module.c: Unloading "module-hal-detect" (index: #4).I: module.c: Unloaded "module-hal-detect" (index: #4).I: module.c: Unloading "module-esound-protocol-unix" (index: #5).I: module.c: Unloaded "module-esound-protocol-unix" (index: #5).I: module.c: Unloading "module-native-protocol-unix" (index: #6).D: module-suspend-on-idle.c: Sink auto_null becomes idle.D: core-subscribe.c: Dropped redundant event due to remove event.D: module-suspend-on-idle.c: Sink auto_null becomes idle.D: module-null-sink.c: Requested to rewind 352800 bytes.I: sink-input.c: Freeing input 13 "Simple DirectMedia Layer"D: sink.c: Processing rewind...D: source.c: Processing rewind...D: module-null-sink.c: Rewound 38604 bytes.I: client.c: Freed 14 "xbmc.bin"I: module.c: Unloaded "module-native-protocol-unix" (index: #6).I: module.c: Unloading "module-default-device-restore" (index: #7).I: module.c: Unloaded "module-default-device-restore" (index: #7).I: module.c: Unloading "module-rescue-streams" (index: #8).I: module.c: Unloaded "module-rescue-streams" (index: #8).I: module.c: Unloading "module-always-sink" (index: #9).I: module.c: Unloaded "module-always-sink" (index: #9).I: module.c: Unloading "module-suspend-on-idle" (index: #10).I: module.c: Unloaded "module-suspend-on-idle" (index: #10).I: module.c: Unloading "module-console-kit" (index: #11).D: module-console-kit.c: Removing session /org/freedesktop/ConsoleKit/Session5I: client.c: Freed 0 "ConsoleKit Session /org/freedesktop/ConsoleKit/Session5"I: module.c: Unloaded "module-console-kit" (index: #11).I: module.c: Unloading "module-position-event-sounds" (index: #12).I: module.c: Unloaded "module-position-event-sounds" (index: #12).I: module.c: Unloading "module-gconf" (index: #13).I: module.c: Unloaded "module-gconf" (index: #13).I: module.c: Unloading "module-null-sink" (index: #14).D: core-subscribe.c: Dropped redundant event due to remove event.D: core-subscribe.c: Dropped redundant event due to remove event.D: module-null-sink.c: Thread shutting downI: sink.c: Freeing sink 1 "auto_null"I: source.c: Freeing source 2 "auto_null.monitor"I: module.c: Unloaded "module-null-sink" (index: #14).D: core-subscribe.c: Dropped redundant event due to remove event.I: main.c: Daemon terminated.