On 30.03.2016 18:06, Tanu Kaskinen wrote:
On Tue, 2016-03-29 at 20:29 +0200, Georg Chini wrote:
On 29.03.2016 05:56, Georg Chini wrote:
On 29.03.2016 02:13, Pierre-Louis Bossart wrote:
On 3/28/16 12:38 PM, Georg Chini wrote:
On 28.03.2016 17:18, Georg Chini wrote:
On 28.03.2016 16:16, Pierre-Louis Bossart wrote:
On 3/22/16 4:11 AM, Georg Chini wrote:
Hi,

Ups, looks like I misread your sentence above. You are right, in
software you can't
see the output. But what you can see is the time between dispatching
the
audio
to the USB bus and the time when the bus reports back that the audio
was
played.

I am not sure if I read the code right, I don't know anything about
USB,
but if the
URB's you are submitting to the bus in the prepare step are handled in
chronological
order, it means that
a) you have to wait for the next URB to retire before you can send any
real audio
b) after you submitted the first audio, it is at the end of the queue
and all the other
URB's containing silence will be processed first.
The USB driver will submit N silence URBs on startup in the prepare
and you will have to wait for those URBs to retire before the samples
are queued. There is very little 'USB processing'. If you want to
reduce this delay you have to use smaller periods, it'll decrease the
size of the URBs. I guess it could be possible to change the URB size
after the start but that's not implemented atm.

I don't want to shorten the latency. I only want the latency reported
correctly. To me it still
looks like the real latency of the driver is not what it reports,
because the time that the
audio spends in the URB's is not taken into account. What I am seeing
is, that the real
latency is around 10ms longer than expected.
OK, I thought about it another time and I believe I figured out what the
problem is.

(Sometimes I feel like I am talking Chinese to you - I seem not to be
able to express
myself in a way that others can understand, sorry for that. I'll try my
best now.
If we would sit in one room it would probably be sorted out in half an
hour.)

The starting point is the observation, that with module-loopback and an
USB sink
the real end-to-end latency is about 10ms longer than configured. This
cannot be
observed with a HDA sink. Let's go through the sequence of events when
module-loopback is started:
I'm interested in what delay values alsa reports, so I'll write what I
expect the delay to be after each step. One unclear thing is that can
the driver report the delay at higher granularity than one URB (= 5 ms
in this example)? I'll assume here that it can report the latency with
one sample accuracy.

I had one big mistake in my thinking - it does not matter at all
when the source starts delivering samples to module-loopback.
The samples that the source provides are buffered in the memblockq
and in the end module-loopback adjusts the memblockq so that
sink latency + source latency + buffer = configured loopback latency.
That means that even in your previous example where you start with
8 seconds initial latency, the controller in module-loopback would
correct it after some time.
The latency that is made up by the contents of the memblockq
(and the render memblockq's on the sink input/source output side)
can be exactly calculated, so if the resulting overall latency is wrong,
the error must be on the source or sink side. In this case it must be
the sink side because changing the source has no impact.
Nevertheless the sequence below is interesting, because it shows,
how the latency is calculated on the alsa side. I'll attach a log with
some debugging information, numbers without units are usec.


I'll also assume that audio is moved from the ring buffer to the URBs
atomically, so the ring buffer fill level jumps by 5 ms every time a
URB is filled.

1) The module sets up a buffer and fills it with silence up to the
configured loopback latency.
Sink and source are configured to 1/3 of the loopback latency. In this
example, we will use
30ms as loopback latency, so that sink and source are configured to 10ms.
I suppose prepare() has not been called in the sink yet, so currently
the delay is undefined.

2) Source and sink are started. For simplicity we assume that the source
starts delivering
samples immediately.
I guess the sink still hasn't called prepare()?
Somewhere here the sink calls prepare.

3) As long as sink_input_pop() has not been called, module-loopback
drops the audio
coming in from the source.

4) On the alsa side, the preparation has been done. Again, to simplify
we assume 2 URB's
with 5ms each have been set up and submitted to the USB bus. The first
URB starts
playing silence to the speakers now.
prepare() has been called. If we assume that the DAC has not yet
consumed anything from the first URB, the "USB bus" latency is 10 ms.
PulseAudio hasn't written anything yet to the ring buffer. Expected
delay: 10 ms.
I think the delay is still undefined here. No audio has been sent
and the stream is not even started.


5) The pulseaudio sink code takes the first 10ms of audio out of the
loopback buffer,
writes it to the alsa buffer and calls snd_pcm_start().
If the sink takes something from the loopback buffer, this means that
the first pop() call has been made. Assuming no time has passed since
the previous step, the USB bus is still full, and so is the ring
buffer. Expected delay: 20 ms.

Reported delay is exactly the amount of audio that was written to
the buffer.


6) Now sink_input_pop() is called, and that is where things go wrong,
because the
audio from the source is buffered from now on.
Is this already the second pop() call? That means that at least one URB
has been filled from the ring buffer, otherwise pop() wouldn't have
been called due to the ring buffer being full.

No, the order was wrong, I meant the first pop() callback. But
this does not matter anyway - see above.


During the pop() call the ring buffer contains 0 ms of audio, if two
URBs have been filled from the ring buffer, or 5 ms, if only one has
been filled.

Expected delay during the pop() call: 0 or 5 ms + whatever the DAC
hasn't yet consumed from the USB bus. Expected delay after the sink has
finished rendering and writing to the ring buffer: 10 ms + whatever the
DAC hasn't yet consumed from the USB bus.

Since I got it wrong and we are still at the first pop() call, the
delay is still 10ms.


7) On the alsa side nothing has happened yet. The reported delay is what
is in the alsa
buffer - 10ms. Alsa has to wait for the first URB to expire before any
sample can be
submitted to the bus.
How can nothing have happened yet on the alsa side? pop() has been
called twice already, which means that the alsa driver has already
consumed audio from the ring buffer. I'd count that as something
happening.
See above - my mistake. But it looks like pop() is really called
a second time before the delay starts going down - you can see
in the attached log, that first there are two writes to the alsa
buffer - one to fill up to the configured sink latency and then
another one that shouldn't be there. I could not figure out
why this happens. The code looks fine and you already checked
yourself that this shouldn't happen. The second write to the
alsa buffer increases the delay to 19ms, which is a lot more
than the configured 13 ms, but the 6 ms difference still
not account for what I measure. Without using my "startup delay"
I am about 15 ms off.


If the first URB hasn't yet expired (ignoring the conflicting
information that pop() has been called twice already), it doesn't make
sense that alsa would report 10 ms delay. The two submitted URBs add 10
ms to the delay, minus everything that the DAC has consumed at this
point, which I assume to be very little. On top of that there's 10 ms
of audio written to the ring buffer. If alsa reports the full delay to
be 10 ms, that's wrong, don't you think? It should report 20 ms (or
something close to that to account for whatever the DAC has consumed).
No, it doesn't. It reports exactly the delay that is made up of the
audio written to the alsa buffer and nothing more.


8) Now the first URB has retired and can be filled with audio. After the
URB is submitted to
the bus, the alsa delay is NOT updated and still shows 10ms. The second
URB starts playing
silence for 5ms. Because the buffer seems filled to the correct level,
the pulseaudio sink
code will wait until the fill level gets lower.
When the first URB is retired and filled with audio from the ring
buffer, that's when the ring buffer fill level jumps from 10 ms to 5
ms. You seem to be saying that after this has happened, the alsa sink
doesn't fill up the ring buffer. Why is that? 5 ms is half of the full
buffer, and that should be low enough to trigger a refill.

Maybe the ring buffer fill level changes at that point - I did not check.
That could be the reason for the refill I mentioned above and also
the reason why there is no underrun later.


9) The second URB has retired, is filled with audio and submitted to the
bus. Still the
delay is NOT updated, but from now on, it is correct, since a sample
that would now be
submitted to the alsa buffer would take 10 ms to the speakers. The first
real audio starts
playing.
Here you seem to be describing a situation where the ring buffer is
empty, and indeed, in that situation the reported delay should be 10
ms. I just don't understand why the ring buffer would be empty (that
is, why didn't pulseaudio refill the ring buffer after the first URB
was consumed from the ring buffer).
It looks like it did - see above. But still the delay shows the same
value.


10) Meanwhile the source has been producing samples that have been queued in
the loopback buffer and that make up the extra latency I have been
observing. In
this example it would be 5ms from the second URB plus the time that was left
from the first URB when snd_pcm_start() was called.

11) The first URB-full of audio has been played and the URB retires. Now
the alsa
delay is adjusted to reflect that the first 5ms have been played and the
audio flow
is completely set up.
If the ring buffer was empty in the previous step, and we didn't write
anything after that, then the retirement of an URB now would cause an
underrun, since the retired URB can't be refilled from the ring buffer.
Yes that was also bothering me a while after I wrote this mail. But
it looks like the explanation is that the alsa driver does change the
ring buffer fill level, but not the delay.


If the first sink_input_pop() would be called at this point, everything
would be fine.
So the problem seems to be that sink_input_pop() is called too early.
I don't know, your description contained many strange parts. I don't
know what is really happening. But if module-loopback heavily relies on
the configured latency to be the same as the real latency, then that's
going to cause trouble anyway, because they just aren't the same thing,
even if the alsa driver is reporting everything perfectly.

Module loopback relies on the reported latencies, the configured
latencies are only used during setup. If the reported latencies
don't match the configured it does not matter.

The attached logs are with my own smoother code, but I have
changed nothing else in the alsa sink, so the timing is the same.
BTW, do you think the debug output of module-loopback is
better now?
The reports of write count / delay reported by alsa stop at the
point where there is the jump in the delay that I mentioned in
another mail. In this log it is not that obvious, but the strange
thing is, that the card time goes on linear and the system time
shows the jump. No idea what is happening there.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] client.c: Created 31 "UNIX socket client"
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-stream-restore.c: Restoring device for stream sink-input-by-media-role:abstract.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-intended-roles.c: Not setting device for stream (null), because already set.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink-input.c: Negotiated format: pcm, format.rate = "44100"
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-stream-restore.c: Restoring mute state for sink input sink-input-by-media-role:abstract.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo becomes busy, resuming.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink.c: Suspend cause of sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo is 0x0000, resuming
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] reserve-wrap.c: Successfully acquired reservation lock on device 'Audio1'
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Trying resume...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: Cannot disable ALSA period wakeups
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: Maximum hw buffer size is 5461 ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: Set buffer size first (to 88200 samples), period size second (to 44100 samples).
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: ALSA period wakeups were not disabled
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: hwbuf_unused=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: setting avail_min=87721
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time scheduling watermark is 18,38ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Resumed successfully...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 1837500
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Starting playback.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo becomes idle, timeout in 5 seconds.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] ratelimit.c: 322 events suppressed
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo becomes idle, timeout in 5 seconds.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c: Resampler:
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   rate 44100 -> 48000 (method speex-float-5)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   format s16le -> s16le (intermediate float32le)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   channels 2 -> 2 (resampling 2)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] speex.c: Choosing speex quality setting 5.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink-input.c: Created input 14 "(null)" on alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink-input.c:     media.role = "abstract"
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink-input.c:     module-stream-restore.id = "sink-input-by-media-role:abstract"
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Minimum possible latency: 2,50
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-stream-restore.c: Restoring device for stream source-output-by-media-role:abstract.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-intended-roles.c: Not setting device for stream (null), because already set.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source-output.c: Negotiated format: pcm, format.sample_format = "\"s16le\""  format.rate = "44100"  format.channels = "2"  format.channel_map = "\"front-left,front-right\""
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source-output.c: Trying to change sample rate
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source.c: Suspending source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono due to changing the sample rate.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] alsa-source.c: Updating rate for device hw:1, new rate is 44100
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source.c: Changed sampling rate successfully
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source-output.c: Rate changed to 44100 Hz
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-stream-restore.c: Restoring volume for source output source-output-by-media-role:abstract.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono becomes busy, resuming.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source.c: Suspend cause of source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono is 0x0000, resuming
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Trying resume...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-util.c: Cannot disable ALSA period wakeups
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-util.c: Maximum hw buffer size is 11888 ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-util.c: Set buffer size first (to 88200 samples), period size second (to 44100 samples).
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-util.c: ALSA period wakeups were not disabled
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: hwbuf_unused=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: setting avail_min=87721
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: hwbuf_unused=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: setting avail_min=86437
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Time scheduling watermark is 40,00ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Resumed successfully...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Starting capture.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono becomes idle, timeout in 5 seconds.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono becomes idle, timeout in 5 seconds.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c: Forcing resampler 'copy', because of fixed, identical sample rates.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c: Resampler:
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   rate 44100 -> 44100 (method copy)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   format s16le -> s16le (intermediate s16le)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   channels 1 -> 2 (resampling 1)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c: Channel matrix:
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:        I00 
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:     +------
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c: O00 | 1,000
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c: O01 | 1,000
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] remap_sse.c: Using SSE2 mono to stereo remapping
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=2, prebuf=0, minreq=1 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=2, prebuf=0, minreq=2 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source-output.c: Created output 14 "(null)" on alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source-output.c:     media.role = "abstract"
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source-output.c:     module-stream-restore.id = "source-output-by-media-role:abstract"
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Minimum possible latency: 3,75
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=0 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Adding 7056 bytes of silence to queue
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Latency set to 13,33ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: hwbuf_unused=350244
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: setting avail_min=87882
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] module-loopback.c: Max request changed
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Requesting rewind due to latency change.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] module-loopback.c: Max request changed
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Requested volume: front-left: 65536 / 100% / 0,00 dB,   front-right: 65536 / 100% / 0,00 dB
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Got hardware volume: front-left: 65536 / 100% / 0,00 dB,   front-right: 65536 / 100% / 0,00 dB
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Calculated software volume: front-left: 65536 / 100% / 0,00 dB,   front-right: 65536 / 100% / 0,00 dB (accurate-enough=yes)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: Volume not changing
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Requested to rewind 352800 bytes.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Limited to 351392 bytes.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: before: 87848
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: after: 87848
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Rewound 351392 bytes.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: Processing rewind...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 10000,000, time offset: 0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: latency = 0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink-input.c: Have to rewind 351392 bytes on render memblockq.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] module-loopback.c: Got sink rewind 0 ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] source.c: Processing rewind...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 25312, Delay: 19312
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Stream is running
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: latency set to 13,33ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: hwbuf_unused=175226
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: setting avail_min=295
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: latency set to 13,33ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: hwbuf_unused=175226
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: setting avail_min=295
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Requested volume: mono: 17957 /  27% / -33,73 dB
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Got hardware volume: mono: 26281 /  40% / -23,81 dB
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Calculated software volume: mono: 44779 /  68% / -9,92 dB (accurate-enough=no)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-source-USB Audio] source.c: Volume not changing
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink.c: Suspending sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo due to changing the sample rate.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink.c: Suspend cause of sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo is 0x0020, suspending
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] module-loopback.c: Max request changed
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Device suspended...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] alsa-sink.c: Updating rate for device front:1, new rate is 44100
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source.c: Suspending source alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo.monitor due to changing the sample rate.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] source.c: Changed sampling rate successfully
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink.c: Changed sampling rate successfully
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c: Resampler:
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   rate 44100 -> 44100 (method speex-float-5)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   format s16le -> s16le (intermediate float32le)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] resampler.c:   channels 2 -> 2 (resampling 2)
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] speex.c: Choosing speex quality setting 5.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink-input.c: Updated resampler for sink input 14
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] sink.c: Suspend cause of sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo is 0x0000, resuming
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Trying resume...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: Cannot disable ALSA period wakeups
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: Maximum hw buffer size is 5944 ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: Set buffer size first (to 88200 samples), period size second (to 44100 samples).
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-util.c: ALSA period wakeups were not disabled
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Latency set to 13,33ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: hwbuf_unused=350452
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: setting avail_min=87908
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] module-loopback.c: Max request changed
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Latency set to 13,33ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: hwbuf_unused=350452
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: setting avail_min=87908
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Latency set to 13,33ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: hwbuf_unused=350452
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: setting avail_min=87908
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time scheduling watermark is 6,67ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Resumed successfully...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo becomes idle, timeout in 5 seconds.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 13310
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Starting playback.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono becomes busy, resuming.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Cutting sleep time for the initial iterations by half.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink-input.c: Requesting rewind due to uncorking
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Requested to rewind 352800 bytes.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Limited to 2092 bytes.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: before: 523
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: after: 523
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Rewound 2092 bytes.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: Processing rewind...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 10000,000, time offset: 0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: latency = 0
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] module-loopback.c: Got sink rewind 0 ms
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] source.c: Processing rewind...
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 13310, Delay: 13310
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo becomes busy, resuming.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module.c: Loaded "module-loopback" (index: #41; argument: "rate=44100 adjust_time=500 latency_msec=40").
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] cli.c: CLI got EOF from user.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] client.c: Freed 31 "UNIX socket client"
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-udev-detect.c: /dev/snd/controlC1 is accessible: yes
Mar 30 21:46:01 pico1 pulseaudio[11846]: [pulseaudio] module-udev-detect.c: Resuming all sinks and sources of card alsa_card.usb-0d8c_C-Media_USB_Headphone_Set-00.
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 19319, Delay: 19319
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 25328, Delay: 17324
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Stream is running
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 31315, Delay: 17324, System time: 6304,00, Card time: 5986,00, System time - card time: 318,00
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 37324, Delay: 16326, System time: 13130,00, Card time: 12993,00, System time - card time: 137,00
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 43310, Delay: 19297, System time: 16881,00, Card time: 16009,00, System time - card time: 872,00
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 49319, Delay: 18321, System time: 23375,00, Card time: 22993,00, System time - card time: 382,00
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 55328, Delay: 17324, System time: 30170,00, Card time: 30000,00, System time - card time: 170,00
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 61315, Delay: 17324, System time: 36938,00, Card time: 35986,01, System time - card time: 951,99
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 67324, Delay: 19319, System time: 40427,00, Card time: 40000,02, System time - card time: 426,98
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 73310, Delay: 18299, System time: 47276,00, Card time: 47006,02, System time - card time: 269,98
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 79319, Delay: 18321, System time: 53041,00, Card time: 52993,04, System time - card time: 47,96
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 85328, Delay: 18321, System time: 59805,00, Card time: 59002,05, System time - card time: 802,95
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 91315, Delay: 17324, System time: 66611,00, Card time: 65986,08, System time - card time: 624,92
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 97324, Delay: 19319, System time: 70364,00, Card time: 70000,10, System time - card time: 363,90
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 103310, Delay: 19297, System time: 76798,00, Card time: 76009,13, System time - card time: 788,87
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 109319, Delay: 18321, System time: 83623,00, Card time: 82993,17, System time - card time: 629,83
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 115328, Delay: 18321, System time: 89406,00, Card time: 89002,22, System time - card time: 403,78
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 121315, Delay: 17324, System time: 96288,00, Card time: 95986,27, System time - card time: 301,73
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 127324, Delay: 16326, System time: 103110,00, Card time: 102993,35, System time - card time: 116,65
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 133310, Delay: 19297, System time: 106544,00, Card time: 106009,42, System time - card time: 534,58
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 139319, Delay: 18321, System time: 113345,00, Card time: 112993,48, System time - card time: 351,52
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 145328, Delay: 17324, System time: 120185,00, Card time: 120000,59, System time - card time: 184,41
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 151315, Delay: 17324, System time: 126934,00, Card time: 125986,70, System time - card time: 947,30
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 157324, Delay: 19319, System time: 130711,00, Card time: 130000,82, System time - card time: 710,18
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 163310, Delay: 18299, System time: 137159,00, Card time: 137006,92, System time - card time: 152,08
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 169319, Delay: 17324, System time: 143980,00, Card time: 143991,07, System time - card time: -11,07
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 175328, Delay: 17324, System time: 150789,00, Card time: 150001,24, System time - card time: 787,76
Mar 30 21:46:01 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 181315, Delay: 19319, System time: 154280,00, Card time: 153991,41, System time - card time: 288,59
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 187324, Delay: 16326, System time: 163455,00, Card time: 162994,57, System time - card time: 460,43
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 193310, Delay: 19297, System time: 166903,00, Card time: 166010,82, System time - card time: 892,18
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 199319, Delay: 18321, System time: 173694,00, Card time: 172994,98, System time - card time: 699,02
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 205328, Delay: 17324, System time: 180490,00, Card time: 180002,25, System time - card time: 487,75
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 211315, Delay: 19319, System time: 184273,00, Card time: 183992,49, System time - card time: 280,51
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 217324, Delay: 19319, System time: 190694,00, Card time: 190002,69, System time - card time: 691,31
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 223310, Delay: 18299, System time: 197536,00, Card time: 197009,00, System time - card time: 527,00
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 229319, Delay: 17324, System time: 204292,00, Card time: 203993,35, System time - card time: 298,65
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 235328, Delay: 16326, System time: 211204,00, Card time: 211000,72, System time - card time: 203,28
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 241315, Delay: 19319, System time: 214610,00, Card time: 213994,04, System time - card time: 615,96
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 247324, Delay: 18321, System time: 221394,00, Card time: 221001,32, System time - card time: 392,68
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 253310, Delay: 17301, System time: 228207,00, Card time: 228008,75, System time - card time: 198,25
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 259319, Delay: 16326, System time: 235030,00, Card time: 234993,22, System time - card time: 36,78
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 265328, Delay: 19319, System time: 238777,00, Card time: 238009,62, System time - card time: 767,38
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 271315, Delay: 18321, System time: 245195,00, Card time: 244993,97, System time - card time: 201,03
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 277324, Delay: 17324, System time: 252049,00, Card time: 252001,49, System time - card time: 47,51
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 283310, Delay: 17301, System time: 258840,00, Card time: 258011,03, System time - card time: 828,97
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 289319, Delay: 19319, System time: 262323,00, Card time: 262002,54, System time - card time: 320,46
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 295328, Delay: 18321, System time: 269140,00, Card time: 269009,95, System time - card time: 130,05
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 301315, Delay: 18321, System time: 275912,00, Card time: 274996,56, System time - card time: 915,44
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 307324, Delay: 17324, System time: 282722,00, Card time: 282004,23, System time - card time: 717,77
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 313310, Delay: 19297, System time: 286476,00, Card time: 286018,83, System time - card time: 457,17
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 319319, Delay: 19319, System time: 292907,00, Card time: 292005,30, System time - card time: 901,70
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 325328, Delay: 18321, System time: 299742,00, Card time: 299013,02, System time - card time: 728,98
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 331315, Delay: 17324, System time: 306530,00, Card time: 305997,80, System time - card time: 532,20
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 337324, Delay: 16326, System time: 313364,00, Card time: 313005,62, System time - card time: 358,38
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 343310, Delay: 19297, System time: 316547,00, Card time: 316022,31, System time - card time: 524,69
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 907224,079, time offset: 13098
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: 0,58 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 15,17 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 31,67 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 47,26 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 7261,00 usec
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 0,00 usec
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 78 Hz
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 349319, Delay: 17324, System time: 324294,00, Card time: 324003,91, System time - card time: 290,09
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 355328, Delay: 16326, System time: 331011,00, Card time: 331011,90, System time - card time: -0,90
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 361315, Delay: 18321, System time: 335108,00, Card time: 335003,70, System time - card time: 104,30
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 367324, Delay: 18321, System time: 341199,00, Card time: 341013,36, System time - card time: 185,64
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 373310, Delay: 17301, System time: 348089,00, Card time: 348021,29, System time - card time: 67,71
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 379319, Delay: 17324, System time: 354820,00, Card time: 354008,27, System time - card time: 811,73
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 385328, Delay: 17324, System time: 360689,00, Card time: 360019,28, System time - card time: 669,72
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 391315, Delay: 16326, System time: 367533,00, Card time: 367004,28, System time - card time: 528,72
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 397324, Delay: 19319, System time: 370967,00, Card time: 370021,18, System time - card time: 945,82
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 403310, Delay: 18299, System time: 377767,00, Card time: 377027,97, System time - card time: 739,03
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 409319, Delay: 17324, System time: 384512,00, Card time: 384013,15, System time - card time: 498,85
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 415328, Delay: 19319, System time: 388585,00, Card time: 388028,19, System time - card time: 556,81
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 421315, Delay: 16326, System time: 397091,00, Card time: 397009,24, System time - card time: 81,76
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 427324, Delay: 18321, System time: 401190,00, Card time: 401023,54, System time - card time: 166,46
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 433310, Delay: 18299, System time: 407314,00, Card time: 407033,46, System time - card time: 280,54
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 439319, Delay: 17324, System time: 414180,00, Card time: 414018,72, System time - card time: 161,28
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 445328, Delay: 17324, System time: 420879,00, Card time: 420030,05, System time - card time: 848,95
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 451315, Delay: 17324, System time: 426768,00, Card time: 426017,39, System time - card time: 750,61
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 457324, Delay: 16326, System time: 433555,00, Card time: 433025,72, System time - card time: 529,28
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 463310, Delay: 18299, System time: 437104,00, Card time: 437039,99, System time - card time: 64,01
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 469319, Delay: 18321, System time: 443846,00, Card time: 443027,96, System time - card time: 818,04
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 475328, Delay: 17324, System time: 450649,00, Card time: 450036,51, System time - card time: 612,49
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 481315, Delay: 19319, System time: 454670,00, Card time: 454027,86, System time - card time: 642,14
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 487324, Delay: 19319, System time: 460853,00, Card time: 460038,97, System time - card time: 814,03
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 493310, Delay: 18299, System time: 467726,00, Card time: 467046,54, System time - card time: 679,46
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 499319, Delay: 17324, System time: 474454,00, Card time: 474032,24, System time - card time: 421,76
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 505328, Delay: 16326, System time: 481369,00, Card time: 481040,96, System time - card time: 328,04
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 511315, Delay: 19319, System time: 484701,00, Card time: 484035,38, System time - card time: 665,62
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 517324, Delay: 18321, System time: 491621,00, Card time: 491043,60, System time - card time: 577,40
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 523310, Delay: 18299, System time: 497344,00, Card time: 497054,36, System time - card time: 289,64
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 529319, Delay: 17324, System time: 504221,00, Card time: 504040,04, System time - card time: 180,96
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 535328, Delay: 17324, System time: 510919,00, Card time: 510051,86, System time - card time: 867,14
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 541315, Delay: 18321, System time: 515032,00, Card time: 515041,58, System time - card time: -9,58
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 547324, Delay: 18321, System time: 521131,00, Card time: 521051,96, System time - card time: 79,04
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 553310, Delay: 17301, System time: 528041,00, Card time: 528060,84, System time - card time: -19,84
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 559319, Delay: 17324, System time: 534785,00, Card time: 534048,80, System time - card time: 736,20
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 565328, Delay: 16326, System time: 541576,00, Card time: 541057,88, System time - card time: 518,12
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 571315, Delay: 18321, System time: 545079,00, Card time: 545050,66, System time - card time: 28,34
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 577324, Delay: 18321, System time: 551848,00, Card time: 551061,04, System time - card time: 786,96
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 583310, Delay: 17301, System time: 558646,00, Card time: 558070,23, System time - card time: 575,77
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 589319, Delay: 19319, System time: 562635,00, Card time: 562063,09, System time - card time: 571,91
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 595328, Delay: 19319, System time: 568914,00, Card time: 568073,64, System time - card time: 840,36
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 601315, Delay: 19319, System time: 574655,00, Card time: 574061,69, System time - card time: 593,31
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 607324, Delay: 18321, System time: 581553,00, Card time: 581070,79, System time - card time: 482,21
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 613310, Delay: 17301, System time: 588309,00, Card time: 588080,17, System time - card time: 228,83
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 619319, Delay: 16326, System time: 595265,00, Card time: 595066,56, System time - card time: 198,44
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 625328, Delay: 19319, System time: 598558,00, Card time: 598084,50, System time - card time: 473,50
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 631315, Delay: 18321, System time: 605493,00, Card time: 605070,18, System time - card time: 422,82
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 637324, Delay: 17324, System time: 612219,00, Card time: 612079,71, System time - card time: 139,29
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 643310, Delay: 16303, System time: 619092,00, Card time: 619089,23, System time - card time: 2,77
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 649319, Delay: 18321, System time: 623132,00, Card time: 623082,39, System time - card time: 49,61
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 655328, Delay: 18321, System time: 629275,00, Card time: 629093,20, System time - card time: 181,80
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 661315, Delay: 17324, System time: 636061,00, Card time: 636079,68, System time - card time: -18,68
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 667324, Delay: 17324, System time: 642888,00, Card time: 642091,20, System time - card time: 796,80
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 673310, Delay: 17301, System time: 648669,00, Card time: 648102,77, System time - card time: 566,23
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 679319, Delay: 16326, System time: 655551,00, Card time: 655089,26, System time - card time: 461,74
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 685328, Delay: 18321, System time: 659046,00, Card time: 659105,59, System time - card time: -59,59
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 691315, Delay: 18321, System time: 665744,00, Card time: 665093,41, System time - card time: 650,59
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 697324, Delay: 17324, System time: 672646,00, Card time: 672103,22, System time - card time: 542,78
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 703310, Delay: 19297, System time: 676637,00, Card time: 676119,63, System time - card time: 517,37
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 709319, Delay: 19319, System time: 682854,00, Card time: 682107,64, System time - card time: 746,36
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 715328, Delay: 18321, System time: 689569,00, Card time: 689117,42, System time - card time: 451,58
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 721315, Delay: 17324, System time: 696496,00, Card time: 696104,37, System time - card time: 391,63
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 727324, Delay: 16326, System time: 703266,00, Card time: 703114,41, System time - card time: 151,59
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 733310, Delay: 19297, System time: 706717,00, Card time: 706132,74, System time - card time: 584,26
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 739319, Delay: 18321, System time: 713475,00, Card time: 713118,90, System time - card time: 356,10
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 745328, Delay: 18321, System time: 719414,00, Card time: 719130,81, System time - card time: 283,19
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 751315, Delay: 17324, System time: 726126,00, Card time: 726117,70, System time - card time: 8,30
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 757324, Delay: 17324, System time: 732920,00, Card time: 732129,66, System time - card time: 790,34
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 763310, Delay: 18299, System time: 737004,00, Card time: 737143,49, System time - card time: -139,49
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 769319, Delay: 18321, System time: 743167,00, Card time: 743132,76, System time - card time: 34,24
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 775328, Delay: 17324, System time: 750009,00, Card time: 750142,83, System time - card time: -133,83
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 781315, Delay: 17324, System time: 756782,00, Card time: 756131,94, System time - card time: 650,06
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 787324, Delay: 16326, System time: 763657,00, Card time: 763142,25, System time - card time: 514,75
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 793310, Delay: 18299, System time: 767077,00, Card time: 767158,04, System time - card time: -81,04
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 799319, Delay: 18321, System time: 773920,00, Card time: 773147,23, System time - card time: 772,77
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 805328, Delay: 17324, System time: 780643,00, Card time: 780157,65, System time - card time: 485,35
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 811315, Delay: 19319, System time: 784708,00, Card time: 784150,45, System time - card time: 557,55
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 817324, Delay: 19319, System time: 790854,00, Card time: 790162,90, System time - card time: 691,10
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 823310, Delay: 19297, System time: 796724,00, Card time: 796174,99, System time - card time: 549,01
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 829319, Delay: 18321, System time: 803502,00, Card time: 803162,22, System time - card time: 339,78
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 835328, Delay: 17324, System time: 810395,00, Card time: 810172,77, System time - card time: 222,23
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 841315, Delay: 16326, System time: 817207,00, Card time: 817160,39, System time - card time: 46,61
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 6426711,508, time offset: 13098
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: 0,29 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 17,29 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 29,21 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 46,54 ms
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 6569,00 usec
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 76,25 usec
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:02 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 155 Hz
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 847324, Delay: 16326, System time: 823692,00, Card time: 823172,80, System time - card time: 519,20
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 853310, Delay: 17301, System time: 828394,00, Card time: 828186,91, System time - card time: 207,09
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 859319, Delay: 16326, System time: 835300,00, Card time: 835173,93, System time - card time: 126,07
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 865328, Delay: 19319, System time: 838643,00, Card time: 838192,77, System time - card time: 450,23
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 871315, Delay: 18321, System time: 845492,00, Card time: 845179,40, System time - card time: 312,60
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 877324, Delay: 18321, System time: 851307,00, Card time: 851191,94, System time - card time: 115,06
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 883310, Delay: 17301, System time: 858078,00, Card time: 858202,41, System time - card time: -124,41
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 889319, Delay: 17324, System time: 864838,00, Card time: 864191,98, System time - card time: 646,02
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 895328, Delay: 19319, System time: 868896,00, Card time: 868209,10, System time - card time: 686,90
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 901315, Delay: 18321, System time: 875120,00, Card time: 875196,07, System time - card time: -76,07
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 907324, Delay: 18321, System time: 881893,00, Card time: 881208,53, System time - card time: 684,47
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 913310, Delay: 18299, System time: 887714,00, Card time: 887221,19, System time - card time: 492,81
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 919319, Delay: 17324, System time: 894547,00, Card time: 894208,81, System time - card time: 338,19
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 925328, Delay: 16326, System time: 901404,00, Card time: 901219,79, System time - card time: 184,21
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 931315, Delay: 19319, System time: 904796,00, Card time: 904215,81, System time - card time: 580,19
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 937324, Delay: 18321, System time: 911633,00, Card time: 911225,69, System time - card time: 407,31
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 943310, Delay: 17301, System time: 918432,00, Card time: 918236,75, System time - card time: 195,25
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 949319, Delay: 16326, System time: 925244,00, Card time: 925224,82, System time - card time: 19,18
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 955328, Delay: 18321, System time: 929297,00, Card time: 929242,15, System time - card time: 54,85
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 961315, Delay: 18321, System time: 935469,00, Card time: 935231,07, System time - card time: 237,93
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 967324, Delay: 17324, System time: 942259,00, Card time: 942242,00, System time - card time: 17,00
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 973310, Delay: 16303, System time: 949066,00, Card time: 949253,17, System time - card time: -187,17
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 979319, Delay: 19319, System time: 952537,00, Card time: 952249,29, System time - card time: 287,71
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 985328, Delay: 16326, System time: 961642,00, Card time: 961254,90, System time - card time: 387,10
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 991315, Delay: 18321, System time: 965178,00, Card time: 965250,11, System time - card time: -72,11
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 997324, Delay: 17324, System time: 971966,00, Card time: 972260,24, System time - card time: -294,24
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 1003310, Delay: 17301, System time: 978754,00, Card time: 978273,25, System time - card time: 480,75
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 1009319, Delay: 19319, System time: 982783,00, Card time: 982267,71, System time - card time: 515,29
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 1013310, Delay: 17301, System time: 988836,00, Card time: 988279,79, System time - card time: 556,21
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Write count: 1019319, Delay: 19319, System time: 994807,00, Card time: 992274,03, System time - card time: 2532,97
Mar 30 21:46:02 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: USB Hack
Mar 30 21:46:03 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 3088590,811, time offset: 10286
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: 0,45 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 15,55 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 29,34 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 45,06 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 5119,00 usec
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 179,22 usec
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 212 Hz
Mar 30 21:46:03 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 2684170,620, time offset: 10286
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: -0,16 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 13,18 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 30,21 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 42,96 ms
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 3026,00 usec
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 266,19 usec
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:03 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 147 Hz
Mar 30 21:46:04 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 1496092,057, time offset: 10286
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: 0,72 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 12,59 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 28,42 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 41,53 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 1573,00 usec
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 285,42 usec
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 73 Hz
Mar 30 21:46:04 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 1236301,262, time offset: 10286
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: -0,49 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 12,81 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 28,89 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 40,80 ms
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 820,00 usec
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 257,55 usec
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:04 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 27 Hz
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 1401701,974, time offset: 10286
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: -0,48 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 13,57 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 27,84 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 40,52 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 523,00 usec
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 231,61 usec
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 15 Hz
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 1504536,256, time offset: 10286
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c: Loopback status alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono to alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo:
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Source latency: 0,04 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Buffer: 12,44 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Sink latency: 28,21 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     End-to-end latency: 40,28 ms
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from target latency at optimum rate: 284,00 usec
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Average prediction error: ± 226,41 usec
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Optimum rate: 44100,00 Hz
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-loopback.c:     Deviation from base rate: 9 Hz
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] client.c: Created 32 "UNIX socket client"
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module.c: Unloading "module-loopback" (index: #41).
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: hwbuf_unused=0
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: setting avail_min=87907
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Requested volume: mono: 17957 /  27% / -33,73 dB
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Got hardware volume: mono: 26281 /  40% / -23,81 dB
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Calculated software volume: mono: 44779 /  68% / -9,92 dB (accurate-enough=no)
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-source-USB Audio] source.c: Volume not changing
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono becomes idle, timeout in 5 seconds.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono becomes idle, timeout in 5 seconds.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] source-output.c: Freeing output 14 "Loopback to Audio Adapter Analog Stereo"
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: hwbuf_unused=0
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: setting avail_min=87907
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Requested volume: front-left: 65536 / 100% / 0,00 dB,   front-right: 65536 / 100% / 0,00 dB
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Got hardware volume: front-left: 65536 / 100% / 0,00 dB,   front-right: 65536 / 100% / 0,00 dB
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Calculated software volume: front-left: 65536 / 100% / 0,00 dB,   front-right: 65536 / 100% / 0,00 dB (accurate-enough=yes)
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: Volume not changing
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Requested to rewind 352800 bytes.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Limited to 2092 bytes.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: before: 523
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: after: 523
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Rewound 2092 bytes.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: Processing rewind...
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Time variance sink: 1504514,321, time offset: 10286
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] sink.c: latency = 17314
Mar 30 21:46:05 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] source.c: Processing rewind...
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo becomes idle, timeout in 5 seconds.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo becomes idle, timeout in 5 seconds.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] sink-input.c: Freeing input 14 "Loopback from Audio Adapter Analog Mono"
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] module.c: Unloaded "module-loopback" (index: #41).
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] cli.c: CLI got EOF from user.
Mar 30 21:46:05 pico1 pulseaudio[11846]: [pulseaudio] client.c: Freed 32 "UNIX socket client"
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono idle for too long, suspending ...
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] source.c: Suspend cause of source alsa_input.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-mono is 0x0004, suspending
Mar 30 21:46:10 pico1 pulseaudio[11846]: [alsa-source-USB Audio] alsa-source.c: Device suspended...
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo idle for too long, suspending ...
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] sink.c: Suspend cause of sink alsa_output.usb-0d8c_C-Media_USB_Headphone_Set-00.analog-stereo is 0x0004, suspending
Mar 30 21:46:10 pico1 pulseaudio[11846]: [alsa-sink-USB Audio] alsa-sink.c: Device suspended...
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] module-udev-detect.c: /dev/snd/controlC1 is accessible: yes
Mar 30 21:46:10 pico1 pulseaudio[11846]: [pulseaudio] module-udev-detect.c: Resuming all sinks and sources of card alsa_card.usb-0d8c_C-Media_USB_Headphone_Set-00.
_______________________________________________
pulseaudio-discuss mailing list
[email protected]
https://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss

Reply via email to