I: client.c: Created 6 "Native client (UNIX socket client)" D: protocol-native.c: Protocol version: remote 16, local 16 I: protocol-native.c: Got credentials: uid=1000 gid=1000 success=1 D: protocol-native.c: SHM possible: yes D: protocol-native.c: Negotiated SHM: yes D: module-augment-properties.c: Looking for .desktop file for klettres D: module-intended-roles.c: Not setting device for stream audio stream, because already set. D: sink.c: Suspend cause of sink alsa_output.pci-0000_00_1b.0.analog-stereo is 0x0000, resuming D: reserve-wrap.c: Successfully acquired reservation lock on device 'Audio0' I: alsa-sink.c: Trying resume... D: alsa-util.c: Maximum hw buffer size is 371 ms D: alsa-util.c: Set buffer size first (to 16384 samples), period size second (to 8192 samples). D: alsa-sink.c: hwbuf_unused=0 D: alsa-sink.c: setting avail_min=15502 I: alsa-sink.c: Resumed successfully... D: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo becomes idle, timeout in 5 seconds. I: alsa-sink.c: Starting playback. D: alsa-sink.c: Cutting sleep time for the initial iterations by half. D: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo becomes busy. I: resampler.c: Forcing resampler 'copy', because of fixed, identical sample rates. I: resampler.c: Using resampler 'copy' I: resampler.c: Using float32le as working format. D: alsa-sink.c: Cutting sleep time for the initial iterations by half. D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0 D: memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0 I: sink-input.c: Created input 1 "audio stream" on alsa_output.pci-0000_00_1b.0.analog-stereo with sample spec float32le 2ch 44100Hz and channel map front-left,front-right I: sink-input.c: media.name = "audio stream" I: sink-input.c: application.name = "(LibVLC 1.1.11)" I: sink-input.c: native-protocol.peer = "UNIX socket client" I: sink-input.c: native-protocol.version = "16" I: sink-input.c: media.role = "game" I: sink-input.c: phonon.streamid = "{c0671d5a-44f8-49cd-aeac-315b53c4c38a}" I: sink-input.c: application.process.id = "13901" I: sink-input.c: application.process.user = "james" I: sink-input.c: application.process.host = "jasper.nurealm.net" I: sink-input.c: application.process.binary = "klettres" I: sink-input.c: application.language = "en_US.UTF-8" I: sink-input.c: window.x11.display = ":0" I: sink-input.c: application.process.machine_id = "073685f648d341cbadf4d37b00003b7c" I: sink-input.c: application.process.session_id = "073685f648d341cbadf4d37b00003b7c-1313681536.362833-334375271" I: sink-input.c: application.icon_name = "klettres" I: sink-input.c: module-stream-restore.id = "sink-input-by-media-role:game" I: protocol-native.c: Requested tlength=1500.00 ms, minreq=20.00 ms D: protocol-native.c: Adjust latency mode enabled, configuring sink latency to half of overall latency. D: alsa-sink.c: Cutting sleep time for the initial iterations by half. D: alsa-sink.c: Cutting sleep time for the initial iterations by half. D: memblockq.c: memblockq requested: maxlength=4194304, tlength=398136, base=8, prebuf=176400, minreq=7056 maxrewind=0 D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=398136, base=8, prebuf=176400, minreq=7056 maxrewind=0 I: protocol-native.c: Final latency 1500.02 ms = 1088.50 ms + 2*20.00 ms + 371.52 ms D: alsa-sink.c: Requested volume: 0: 22% 1: 22% D: alsa-sink.c: Got hardware volume: 0: 22% 1: 22% D: alsa-sink.c: Calculated software volume: 0: 96% 1: 96% (accurate-enough=no) D: alsa-sink.c: Cutting sleep time for the initial iterations by half. D: alsa-sink.c: Latency set to 371.52ms D: alsa-sink.c: hwbuf_unused=4 D: alsa-sink.c: setting avail_min=15503 D: alsa-sink.c: Requesting rewind due to latency change. D: alsa-sink.c: Requested to rewind 65536 bytes. D: alsa-sink.c: Limited to 64864 bytes. D: alsa-sink.c: before: 16216 D: alsa-sink.c: after: 16216 D: alsa-sink.c: Rewound 64864 bytes. D: sink.c: Processing rewind... D: sink-input.c: Have to rewind 64864 bytes on render memblockq. D: source.c: Processing rewind... D: reserve-wrap.c: Device lock status of reserve-monitor-wrapper@Audio0 changed: not busy D: sink-input.c: Requesting rewind due to uncorking D: alsa-sink.c: Requested to rewind 65536 bytes. D: alsa-sink.c: Limited to 64124 bytes. D: alsa-sink.c: before: 16031 D: alsa-sink.c: after: 16031 D: alsa-sink.c: Rewound 64124 bytes. D: sink.c: Processing rewind... D: source.c: Processing rewind... D: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo becomes busy. D: protocol-native.c: Requesting rewind due to end of underrun. D: alsa-sink.c: Requested to rewind 65536 bytes. D: alsa-sink.c: Limited to 57340 bytes. D: alsa-sink.c: before: 14335 D: alsa-sink.c: after: 14335 D: alsa-sink.c: Rewound 57340 bytes. D: sink.c: Processing rewind... D: sink-input.c: Have to rewind 57340 bytes on render memblockq. D: source.c: Processing rewind... D: alsa-sink.c: Requested volume: 0: 22% 1: 22% D: alsa-sink.c: Got hardware volume: 0: 22% 1: 22% D: alsa-sink.c: Calculated software volume: 0: 96% 1: 96% (accurate-enough=no) D: alsa-sink.c: hwbuf_unused=0 D: alsa-sink.c: setting avail_min=15502 D: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo becomes idle, timeout in 5 seconds. D: alsa-sink.c: Requested to rewind 65536 bytes. D: alsa-sink.c: Limited to 65148 bytes. D: alsa-sink.c: before: 16287 D: alsa-sink.c: after: 16287 D: alsa-sink.c: Rewound 65148 bytes. D: sink.c: Processing rewind... D: source.c: Processing rewind... D: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo becomes idle, timeout in 5 seconds. D: core.c: Hmm, no streams around, trying to vacuum. I: sink-input.c: Freeing input 1 "audio stream" I: protocol-native.c: Connection died. I: client.c: Freed 6 "(LibVLC 1.1.11)" I: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo idle for too long, suspending ... D: sink.c: Suspend cause of sink alsa_output.pci-0000_00_1b.0.analog-stereo is 0x0004, suspending I: alsa-sink.c: Device suspended... D: reserve-wrap.c: Device lock status of reserve-monitor-wrapper@Audio0 changed: not busy D: module-udev-detect.c: /dev/snd/controlC0 is accessible: yes