[pulseaudio-discuss] Pulseaudio “Snd_PCM_delay” not returing correct value and false underrun is reported
Vikrant Bhangay
Vikrant.Bhangay at kpit.com
Wed Oct 12 11:19:04 UTC 2016
Hello,
I am using Pulseaudio 6.0 and 3rd party Media player for embedded application. It is observed that some times Audio is choppy. As per media engine supplier
Pulseaudio “Snd_PCM_delay” not returning correct value and false underrun is reported. Some times even if around 90 msec data is written on device underrun is reported.
I tried multiple values for default-fragments, default-fragment-size-msec, but probability of this problem reduces but does not give 100 % fix.
Pulseaudio logs given below. I am trying to understand why false underrun is reported? Any inputs to fix this problem ?
51.324| 45.822) D: [pulseaudio] protocol-native.c: Resuming of sink main requested by client 0.
( 51.326| 0.002) I: [pulseaudio] client.c: Created 1 "Native client (UNIX socket client)"
( 51.327| 0.001) D: [pulseaudio] protocol-native.c: Protocol version: remote 30, local 30
( 51.328| 0.000) I: [pulseaudio] protocol-native.c: Got credentials: uid=2007 gid=2015 success=1
( 51.328| 0.000) D: [pulseaudio] protocol-native.c: SHM possible: no
( 51.328| 0.000) D: [pulseaudio] protocol-native.c: Negotiated SHM: no
( 51.329| 0.000) D: [pulseaudio] protocol-native.c: Disabling srbchannel, reason: Must be enabled by module parameter
( 51.333| 0.004) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 51.334| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 51.334| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 51.334| 0.000) D: [pulseaudio] sink.c: Suspend cause of sink main is 0x0000, resuming
( 51.334| 0.000) I: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Trying resume...
( 51.336| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-util.c: Maximum hw buffer size is 170 ms
( 51.337| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-util.c: Set buffer size first (to 4800 samples), period size second (to 1200 samples).
( 51.337| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: hwbuf_unused=0
( 51.337| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: setting avail_min=1
( 51.337| 0.000) I: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Resumed successfully...
( 51.337| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 51.337| 0.000) I: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Starting playback.
( 51.338| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 51.338| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 51.338| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 51.338| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 51.338| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 51.339| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 51.339| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 51.339| 0.000) I: [pulseaudio] sink-input.c: Created input 0 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 51.339| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 51.339| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 51.339| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 51.340| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 51.340| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 51.340| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 51.340| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=8192, minreq=8192 maxrewind=0
( 51.340| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=8192, minreq=8192 maxrewind=0
( 51.340| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 51.403| 0.062) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 51.403| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 51.403| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 51.403| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 51.404| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 51.404| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 51.404| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.404| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 51.404| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 51.405| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 51.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.406| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.407| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.412| 0.005) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.424| 0.011) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.424| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.424| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.437| 0.013) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 51.452| 0.015) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 18960 bytes.
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 51.453| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 51.454| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 51.454| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.454| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.455| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.456| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.456| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.456| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 51.462| 0.005) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.482| 0.020) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.482| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 51.487| 0.004) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 51.514| 0.026) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 51.514| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 51.515| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 51.516| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.516| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.516| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.517| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.517| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.517| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.517| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.518| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.518| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 51.537| 0.019) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 16184 bytes ago (3016 bytes ahead in playback buffer)
( 51.552| 0.014) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 16184 bytes ago (3016 bytes ahead in playback buffer)
( 51.552| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 16184 bytes ago (3016 bytes ahead in playback buffer)
( 51.564| 0.011) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 51.564| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 51.566| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 51.566| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3192 bytes ago (16008 bytes ahead in playback buffer)
( 51.567| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3192 bytes ago (16008 bytes ahead in playback buffer)
( 51.567| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3192 bytes ago (16008 bytes ahead in playback buffer)
( 51.568| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3192 bytes ago (16008 bytes ahead in playback buffer)
( 51.569| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3192 bytes ago (16008 bytes ahead in playback buffer)
( 51.587| 0.018) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 7992 bytes ago (11208 bytes ahead in playback buffer)
( 51.601| 0.014) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 7992 bytes ago (11208 bytes ahead in playback buffer)
( 51.602| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 7992 bytes ago (11208 bytes ahead in playback buffer)
( 51.612| 0.010) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 12792 bytes ago (6408 bytes ahead in playback buffer)
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 12792 bytes ago (6408 bytes ahead in playback buffer)
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 12800 bytes.
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 12800 bytes.
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 3200
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 3200
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 12800 bytes.
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 12800 bytes on render memblockq.
( 51.613| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 51.614| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 51.615| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3204 bytes ago (15996 bytes ahead in playback buffer)
( 51.615| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3204 bytes ago (15996 bytes ahead in playback buffer)
( 51.615| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3204 bytes ago (15996 bytes ahead in playback buffer)
( 51.616| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3204 bytes ago (15996 bytes ahead in playback buffer)
( 51.616| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 3204 bytes ago (15996 bytes ahead in playback buffer)
( 51.637| 0.020) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 8004 bytes ago (11196 bytes ahead in playback buffer)
( 51.652| 0.014) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 8004 bytes ago (11196 bytes ahead in playback buffer)
( 51.652| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 8004 bytes ago (11196 bytes ahead in playback buffer)
( 51.662| 0.010) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 12804 bytes ago (6396 bytes ahead in playback buffer)
( 51.663| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 12804 bytes ago (6396 bytes ahead in playback buffer)
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 12804 bytes ago (6396 bytes ahead in playback buffer)
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 12812 bytes.
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 12812 bytes.
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 3203
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 3203
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 12812 bytes.
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 12812 bytes on render memblockq.
( 51.664| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 51.665| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 51.666| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2540 bytes ago (16660 bytes ahead in playback buffer)
( 51.666| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2540 bytes ago (16660 bytes ahead in playback buffer)
( 51.667| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2540 bytes ago (16660 bytes ahead in playback buffer)
( 51.667| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2540 bytes ago (16660 bytes ahead in playback buffer)
( 51.667| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2540 bytes ago (16660 bytes ahead in playback buffer)
( 51.687| 0.019) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 7340 bytes ago (11860 bytes ahead in playback buffer)
( 51.692| 0.004) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 7340 bytes ago (11860 bytes ahead in playback buffer)
( 51.692| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 7340 bytes ago (11860 bytes ahead in playback buffer)
( 51.702| 0.010) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 7340 bytes ago (11860 bytes ahead in playback buffer)
( 51.702| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 51.702| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 51.702| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 51.702| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 51.702| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 51.703| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.703| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 51.703| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 51.703| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 51.703| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 51.704| 0.000) I: [pulseaudio] sink-input.c: Freeing input 0 "ALSA Playback"
( 51.705| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 51.705| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 51.705| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 51.705| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 51.706| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 51.706| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 51.706| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 51.706| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 51.706| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 51.706| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 51.706| 0.000) I: [pulseaudio] sink-input.c: Created input 1 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 51.706| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 51.706| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 51.707| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 51.707| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 51.707| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 51.707| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 51.707| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 51.708| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 51.708| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 51.854| 0.146) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 51.855| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 52.613| 0.757) E: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: ALSA woke us up to write new data to the device, but there was actually nothing to write!
( 52.613| 0.757) E: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Most likely this is a bug in the ALSA driver '(null)'. Please report this issue to the ALSA developers.
( 52.613| 0.757) E: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: We were woken up with POLLOUT set -- however a subsequent snd_pcm_avail() returned 0 or another value < min_avail.
( 56.963| 4.350) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 56.964| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.964| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.964| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.965| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.965| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.966| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.982| 0.016) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.982| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 196 bytes ago (19004 bytes ahead in playback buffer)
( 56.988| 0.005) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4996 bytes ago (14204 bytes ahead in playback buffer)
( 57.012| 0.024) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4996 bytes ago (14204 bytes ahead in playback buffer)
( 57.012| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4996 bytes ago (14204 bytes ahead in playback buffer)
( 57.013| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9796 bytes ago (9404 bytes ahead in playback buffer)
( 57.038| 0.025) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14596 bytes ago (4604 bytes ahead in playback buffer)
( 57.062| 0.024) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14596 bytes ago (4604 bytes ahead in playback buffer)
( 57.062| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14596 bytes ago (4604 bytes ahead in playback buffer)
( 82.926| 25.864) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Requesting rewind due to corking
( 82.926| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 0 bytes.
( 82.926| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Mhmm, actually there is nothing to rewind.
( 82.927| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 82.932| 0.005) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hSink main becomes idRequested to rewind 19200
bytes.
( 82.932| 0.000) D: [alsa-sink-SSI00-SAF7Hmm, no streams around, trying to vacuLim
ted to 18944 bytes.
( 82.932| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 82.932| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 82.932| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 82.932| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 82.932| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 82.933| 0.000) I: [pulseaudio] sink-input.c: Freeing input 1 "ALSA Playback"
( 82.933| 0.000) I: [pulseaudio] client.c: Freed 1 "ALSA plug-in [ksvc-mediaserver]"
( 82.933| 0.000) I: [pulseaudio] protocol-native.c: Connection died.
( 82.965| 0.031) D: [pulseaudio] protocol-native.c: Suspending of sink main requested by client 0.
( 82.965| 0.000) D: [pulseaudio] sink.c: Suspend cause of sink main is 0x0001, suspending
( 82.966| 0.000) I: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Device suspended...
( 87.951| 4.984) I: [pulseaudio] module-suspend-on-idle.c: Sink main idle for too long, suspending ...
( 87.951| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 90.912| 2.961) I: [pulseaudio] client.c: Created 2 "Native client (UNIX socket client)"
( 90.914| 0.002) D: [pulseaudio] protocol-native.c: Protocol version: remote 30, local 30
( 90.915| 0.000) I: [pulseaudio] protocol-native.c: Got credentials: uid=2007 gid=2015 success=1
( 90.915| 0.000) D: [pulseaudio] protocol-native.c: SHM possible: no
( 90.915| 0.000) D: [pulseaudio] protocol-native.c: Negotiated SHM: no
( 90.916| 0.000) D: [pulseaudio] protocol-native.c: Disabling srbchannel, reason: Must be enabled by module parameter
( 90.919| 0.003) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 90.919| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 90.920| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 90.920| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 90.920| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 90.920| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 90.920| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 90.920| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 90.920| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 90.920| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 90.920| 0.000) I: [pulseaudio] sink-input.c: Created input 2 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 90.920| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 90.920| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 90.922| 0.001) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 90.922| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 90.922| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 90.922| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 90.922| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=8192, minreq=8192 maxrewind=0
( 90.922| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=8192, minreq=8192 maxrewind=0
( 90.923| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 90.945| 0.022) D: [pulseaudio] protocol-native.c: Resuming of sink main requested by client 0.
( 90.945| 0.000) D: [pulseaudio] sink.c: Suspend cause of sink main is 0x0000, resuming
( 90.945| 0.000) I: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Trying resume...
( 90.947| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-util.c: Maximum hw buffer size is 170 ms
( 90.948| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-util.c: Set buffer size first (to 4800 samples), period size second (to 1200 samples).
( 90.948| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: hwbuf_unused=0
( 90.948| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: setting avail_min=1
( 90.948| 0.000) I: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Resumed successfully...
( 90.948| 0.000) I: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Starting playback.
( 90.974| 0.026) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 90.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 90.976| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 90.976| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 90.977| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 90.977| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 90.977| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 90.998| 0.020) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.001| 0.003) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.002| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.007| 0.005) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.007| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.023| 0.015) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.023| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 91.023| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 14156 bytes.
( 91.023| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 14144 bytes.
( 91.023| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 3536
( 91.023| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 3536
( 91.023| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 14144 bytes.
( 91.024| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.024| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 14144 bytes on render memblockq.
( 91.024| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 91.025| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 91.025| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 91.025| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 91.026| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 91.026| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 91.027| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 91.027| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 9348 bytes ago (9852 bytes ahead in playback buffer)
( 91.048| 0.021) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.053| 0.004) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.053| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.053| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.054| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 14148 bytes ago (5052 bytes ahead in playback buffer)
( 91.073| 0.019) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.073| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.074| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.074| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.074| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.074| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 18948 bytes ago (252 bytes ahead in playback buffer)
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 18960 bytes.
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 91.075| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 91.076| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.076| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 91.076| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 91.077| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 91.077| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 91.077| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 91.078| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 91.078| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 91.078| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 91.079| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 91.079| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 11384 bytes ago (7816 bytes ahead in playback buffer)
( 91.079| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 91.079| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hSink main becomes idLimited to 18944 bytes.
( 91.079| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 91.079| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 91.079| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 91.080| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.080| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 91.080| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.080| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 91.082| 0.001) I: [pulseaudio] sink-input.c: Freeing input 2 "ALSA Playback"
( 91.083| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 91.084| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 91.084| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 91.084| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.084| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 91.084| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 91.084| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 91.084| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 91.084| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 91.084| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 91.084| 0.000) I: [pulseaudio] sink-input.c: Created input 3 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 91.084| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 91.084| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 91.085| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 91.085| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 91.085| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 91.086| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 91.086| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 91.086| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 91.086| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 91.305| 0.219) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 91.306| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 91.398| 0.092) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 91.399| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2520 bytes ago (16680 bytes ahead in playback buffer)
( 91.400| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2520 bytes ago (16680 bytes ahead in playback buffer)
( 91.400| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2520 bytes ago (16680 bytes ahead in playback buffer)
( 91.402| 0.002) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2520 bytes ago (16680 bytes ahead in playback buffer)
( 91.403| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2520 bytes ago (16680 bytes ahead in playback buffer)
( 91.404| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 2520 bytes ago (16680 bytes ahead in playback buffer)
( 91.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 91.405| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 91.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 91.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 91.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 91.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.405| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 91.405| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.405| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 91.406| 0.000) I: [pulseaudio] sink-input.c: Freeing input 3 "ALSA Playback"
( 91.408| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 91.408| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 91.408| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 91.408| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.408| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 91.408| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 91.408| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 91.408| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 91.408| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 91.409| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 91.409| 0.000) I: [pulseaudio] sink-input.c: Created input 4 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 91.409| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 91.409| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 91.410| 0.001) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 91.410| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 91.412| 0.001) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 91.412| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 91.412| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 91.412| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 91.412| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 91.654| 0.241) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 91.654| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 91.654| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 91.654| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 91.654| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 91.654| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 91.655| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.655| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 91.655| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 91.749| 0.093) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 91.749| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 91.750| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 91.750| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 91.752| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 91.752| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 91.753| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 91.753| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 91.753| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 91.753| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 91.753| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 91.754| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 91.754| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.754| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 91.754| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.754| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.754| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 91.755| 0.000) I: [pulseaudio] sink-input.c: Freeing input 4 "ALSA Playback"
( 91.756| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 91.757| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 91.757| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 91.757| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 91.757| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 91.757| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 91.757| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 91.757| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 91.757| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 91.757| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 91.758| 0.000) I: [pulseaudio] sink-input.c: Created input 5 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 91.758| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 91.758| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 91.758| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 91.758| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 91.759| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 91.759| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 91.759| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 91.759| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 91.759| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 91.995| 0.236) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 91.995| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 91.995| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 91.996| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 91.996| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 91.996| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 91.996| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 91.996| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 91.996| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 92.073| 0.077) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 92.074| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.074| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.074| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.093| 0.018) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.093| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 92.093| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 92.093| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 92.093| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 92.093| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 92.093| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 92.093| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 92.094| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.094| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.094| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 92.095| 0.000) I: [pulseaudio] sink-input.c: Freeing input 5 "ALSA Playback"
( 92.096| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 92.096| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 92.097| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 92.097| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.097| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 92.097| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 92.097| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 92.097| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 92.097| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 92.097| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 92.097| 0.000) I: [pulseaudio] sink-input.c: Created input 6 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 92.097| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 92.097| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 92.098| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 92.098| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 92.099| 0.001) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 92.100| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 92.100| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 92.100| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 92.100| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 92.344| 0.243) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 92.344| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 92.423| 0.078) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 92.424| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.425| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.425| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.443| 0.017) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.443| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4556 bytes ago (14644 bytes ahead in playback buffer)
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 92.444| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 92.444| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.445| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.445| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 92.445| 0.000) I: [pulseaudio] sink-input.c: Freeing input 6 "ALSA Playback"
( 92.449| 0.003) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 92.449| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 92.449| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 92.450| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.450| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 92.450| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 92.450| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 92.450| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 92.450| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 92.450| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 92.450| 0.000) I: [pulseaudio] sink-input.c: Created input 7 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 92.450| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 92.450| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 92.451| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 92.451| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 92.452| 0.001) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 92.452| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 92.452| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 92.453| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 92.453| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 92.645| 0.192) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 92.646| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 92.748| 0.102) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 92.749| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 92.750| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 92.750| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 92.750| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 92.750| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 92.762| 0.012) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 92.763| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 92.763| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.763| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 92.763| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 92.763| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 92.763| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 92.763| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 92.763| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 92.763| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.763| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 92.764| 0.000) I: [pulseaudio] sink-input.c: Freeing input 7 "ALSA Playback"
( 92.766| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 92.766| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 92.766| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 92.766| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 92.766| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 92.767| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 92.767| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 92.767| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 92.767| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 92.767| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 92.768| 0.000) I: [pulseaudio] sink-input.c: Created input 8 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 92.768| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 92.768| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 92.768| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 92.768| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 92.768| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 92.769| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 92.769| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 92.769| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 92.769| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 92.974| 0.205) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 92.974| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 92.974| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 92.974| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 92.974| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 92.974| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 92.974| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 92.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 92.975| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 93.098| 0.123) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 93.099| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.100| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.100| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.121| 0.021) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.122| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.123| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.123| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 93.123| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 14144 bytes.
( 93.123| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 3536
( 93.123| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 3536
( 93.123| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 sec
nds.
( 93.123| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 93.123| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 93.124| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.124| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 93.124| 0.000) I: [pulseaudio] sink-input.c: Freeing input 8 "ALSA Playback"
( 93.126| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 93.126| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 93.126| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 93.126| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.126| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 93.126| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 93.126| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 93.126| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 93.127| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 93.127| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 93.127| 0.000) I: [pulseaudio] sink-input.c: Created input 9 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 93.127| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 93.127| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 93.128| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 93.128| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 93.128| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 93.128| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 93.128| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 93.128| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 93.128| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 93.365| 0.236) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 93.365| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 93.473| 0.107) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 93.474| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.474| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.474| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.475| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.475| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.482| 0.007) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 93.483| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 93.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 93.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 93.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 93.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 93.483| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 93.483| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.483| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 93.484| 0.000) I: [pulseaudio] sink-input.c: Freeing input 9 "ALSA Playback"
( 93.486| 0.002) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 93.486| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 93.486| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 93.487| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.487| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 93.487| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 93.487| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 93.487| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 93.487| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 93.487| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 93.487| 0.000) I: [pulseaudio] sink-input.c: Created input 10 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 93.487| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 93.487| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 93.488| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 93.488| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 93.488| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 93.488| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 93.489| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 93.489| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 93.489| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 93.705| 0.215) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 93.705| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 93.824| 0.118) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Implicit underrun of 'ALSA Playback'
( 93.824| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.825| 0.001) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.825| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.842| 0.017) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Found underrun 4560 bytes ago (14640 bytes ahead in playback buffer)
( 93.843| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 93.843| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.843| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 93.843| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 93.843| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 93.843| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 93.843| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 93.843| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] source.c: Processing rewind...
( 93.843| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.843| 0.000) D: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 93.844| 0.000) I: [pulseaudio] sink-input.c: Freeing input 10 "ALSA Playback"
( 93.846| 0.001) D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 93.846| 0.000) I: [pulseaudio] sink-input.c: Trying to change sample rate
( 93.846| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes busy, resuming.
( 93.846| 0.000) D: [pulseaudio] module-suspend-on-idle.c: Sink main becomes idle, timeout in 5 seconds.
( 93.846| 0.000) D: [pulseaudio] resampler.c: Resampler:
( 93.846| 0.000) D: [pulseaudio] resampler.c: rate 44100 -> 48000 (method trivial)
( 93.846| 0.000) D: [pulseaudio] resampler.c: format s16le -> s16le (intermediate s16le)
( 93.846| 0.000) D: [pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 93.847| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 93.847| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 93.847| 0.000) I: [pulseaudio] sink-input.c: Created input 11 "ALSA Playback" on main with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 93.847| 0.000) I: [pulseaudio] sink-input.c: media.name = "ALSA Playback"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: application.name = "ALSA plug-in [ksvc-mediaserver]"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: native-protocol.version = "30"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: application.process.id = "343"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: application.process.user = "i3l_btc"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: application.process.host = "info3-low"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: application.process.binary = "ksvc-mediaserver"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: application.language = "C"
( 93.847| 0.000) I: [pulseaudio] sink-input.c: application.process.machine_id = "12345678901234567890123456789012"
( 93.848| 0.000) I: [pulseaudio] protocol-native.c: Requested tlength=139.32 ms, minreq=46.44 ms
( 93.848| 0.000) D: [pulseaudio] protocol-native.c: Early requests mode enabled, configuring sink latency to minreq.
( 93.848| 0.000) D: [pulseaudio] protocol-native.c: Could not configure a sufficiently low latency. Early requests might not be satisifed.
( 93.848| 0.000) D: [pulseaudio] protocol-native.c: Requested latency=46.44 ms, Received latency=100.00 ms
( 93.849| 0.000) D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 93.849| 0.000) D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=34024, base=4, prebuf=25836, minreq=8192 maxrewind=0
( 93.849| 0.000) I: [pulseaudio] protocol-native.c: Final latency 292.88 ms = 100.00 ms + 2*46.44 ms + 100.00 ms
( 94.056| 0.206) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] protocol-native.c: Requesting rewind due to end of underrun.
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Requested to rewind 19200 bytes.
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Limited to 18944 bytes.
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: before: 4736
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: after: 4736
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] alsa-sink.c: Rewound 18944 bytes.
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink.c: Processing rewind...
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sink-input.c: Have to rewind 18944 bytes on render memblockq.
( 94.056| 0.000) D: [alsa-sink-SSI00-SAF7755-MAIN saf7755-hifi-0] sou
Best Regards,
vvb
This message contains information that may be privileged or confidential and is the property of the KPIT Technologies Ltd. It is intended only for the person to whom it is addressed. If you are not the intended recipient, you are not authorized to read, print, retain copy, disseminate, distribute, or use this message or any part thereof. If you receive this message in error, please notify the sender immediately and delete all copies of this message. KPIT Technologies Ltd. does not accept any liability for virus infected mails.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/pulseaudio-discuss/attachments/20161012/aa69c2d6/attachment-0001.html>
More information about the pulseaudio-discuss
mailing list