Asiosink produces popping sound; significant lags in command-line output

Tamas km212121 at gmail.com
Fri Mar 17 04:04:16 UTC 2023


Hi, I'd appreciate some help with asiosink.

Issue:
I'm trying to figure out how to produce a smooth playback on asiosink.
Asiosink produces popping noise while playing back from audiotestsrc.
Depending on buffer-size. Larger buffer sizes cause the CLI output to lag
significantly.

Explanation:

gst-launch-1.0.exe audiotestsrc ! audio/x-raw, samplerate=48000, channels=2
! audioconvert ! queue ! asiosink device-clsid={CLID here}
output-channels=0,1

The ASIO device I'm currently using is ASIO4ALL. The pipeline, with default
buffer-size settings produces a distorted noise. Depending on buffer-size,
there are popping sounds in the output. At smaller values, the pops are
frequent, at larger values infrequent. Buffer sizes in a "magic" range
around 1024 sound OK, without any pops, though I haven't tested it by
recording and analysing the waveform. However, there's also a lag - at
buffer sizes of a few 1000 (e.g. 16384), the pipeline freezes for a while
AFTER it's started playing (the clock appears, freezes at 0). Even at 1024,
the clock doesn't always update each second, but jumps sometimes.

My guess is that the command-line output lag at larger buffer sizes and how
the frequency of the popping sound depends on buffer size suggest that
there's some kind of (performance?) issue with filling the buffer - each
time the buffer needs to be refilled, the audio hardware doesn't get data
or something like that, which produces a pop.

Right now I don't have access to a "real" ASIO device so I'm using ASIO4ALL
for testing, which might not be ideal, but it works well with the
sounddevice Python package that I've been using so far for ASIO playback,
so I'm assuming the problem is somewhere in gstreamer.

My question is, how to set up asiosink for a smooth, pop-free, lag-free
playback? I've tried to change all sorts of settings in ASIO4ALL, but none
of those seem to have mattered. I've also tried to change some other
parameters in asiosink, such as blocksize, but haven't gotten any smarter,
and there isn't much documentation available.

I'm attaching 2 logs taken with GST_DEBUG=asio*:8, one for buffer size 1024
and another for 512. The latter one has frequent pops, but that doesn't
seem to appear in the logs. Before anyone asks, the pops come even with no
debug logging set.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/gstreamer-devel/attachments/20230317/62ece6b7/attachment-0001.htm>
-------------- next part --------------
>gst-launch audiotestsrc ! audio/x-raw, samplerate=48000, channels=2 ! audioconvert ! volume volume=0.2 ! queue ! asiosink device-clsid="\{232685C6-6548-49D8-846D-4141A3EF7560\}" output-channels=0,1 buffer-size=1024
0:00:00.073173000 23788 000001EA5A1B67E0 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, format=(string){ F64LE, F64BE, F32LE, F32BE, S32LE, S32BE, U32LE, U32BE, S24_32LE, S24_32BE, U24_32LE, U24_32BE, S24LE, S24BE, U24LE, U24BE, S20LE, S20BE, U20LE, U20BE, S18LE, S18BE, U18LE, U18BE, S16LE, S16BE, U16LE, U16BE, S8, U8 }, layout=(string)interleaved, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ]
0:00:00.082834000 23788 000001EA5A1B67E0 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, format=(string){ F64LE, F64BE, F32LE, F32BE, S32LE, S32BE, U32LE, U32BE, S24_32LE, S24_32BE, U24_32LE, U24_32BE, S24LE, S24BE, U24LE, U24BE, S20LE, S20BE, U20LE, U20BE, S18LE, S18BE, U18LE, U18BE, S16LE, S16BE, U16LE, U16BE, S8, U8 }, layout=(string)interleaved, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ]
Use Windows high-resolution clock, precision: 1 ms
Setting pipeline to PAUSED ...
0:00:00.095596000 23788 000001EA5A1B67E0 DEBUG               asiosink gstasiosink.cpp:245:gst_asio_sink_create_ringbuffer:<asiosink0> Create ringbuffer
0:00:00.099662000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:586:gst_asio_object_thread_func:<asioobject0> Enter loop, ThreadingModel: STA, driver-name: ASIO4ALL v2, driver-desc: ASIO4ALL v2
0:00:00.107810000 23788 000001EA5A1C2000 LOG               asioobject gstasioobject.cpp:434:gst_asio_object_create_internal_hwnd:<asioobject0> Register internal window class
0:00:00.136448000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:638:gst_asio_object_thread_func:<asioobject0> Input/Output channles: 2/2
0:00:00.140230000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:656:gst_asio_object_thread_func:<asioobject0> min-buffer-size 64, max-buffer-size 2048, preferred-buffer-size 128, buffer-size-granularity 8
0:00:00.145358000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 48000,0 is supported
0:00:00.149029000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 44100,0 is supported
0:00:00.153379000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 192000,0 is supported
0:00:00.156727000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 96000,0 is supported
0:00:00.160366000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:706:gst_asio_object_thread_func:<asioobject0> InputChannelInfo 0: isActive false, channelGroup 0, ASIOSampleType 18, name Not Connected 1
0:00:00.165973000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:706:gst_asio_object_thread_func:<asioobject0> InputChannelInfo 1: isActive false, channelGroup 0, ASIOSampleType 18, name Not Connected 2
0:00:00.170982000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:733:gst_asio_object_thread_func:<asioobject0> OutputChannelInfo 0: isActive false, channelGroup 0, ASIOSampleType 18, name Audio output with HAP 1
0:00:00.175381000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:733:gst_asio_object_thread_func:<asioobject0> OutputChannelInfo 1: isActive false, channelGroup 0, ASIOSampleType 18, name Audio output with HAP 2
0:00:00.181335000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:749:gst_asio_object_thread_func:<asioobject0> Current samplerate 48000,0
0:00:00.187746000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:474:gst_asio_object_main_loop_running_cb:<asioobject0> Main loop running now
0:00:00.191616000 23788 000001EA5A1B67E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:435:gst_asio_ring_buffer_configure:<asiosink0-asioringbuffer> Configure
0:00:00.194834000 23788 000001EA5A1B67E0 DEBUG             asioobject gstasioobject.cpp:1243:gst_asio_object_create_buffers:<asioobject0> Create buffers
0:00:00.198748000 23788 000001EA5A1B67E0 INFO              asioobject gstasioobject.cpp:1300:gst_asio_object_create_buffers:<asioobject0> occupy-all-channels mode, will allocate buffers for all channels
0:00:00.203803000 23788 000001EA5A1B67E0 INFO              asioobject gstasioobject.cpp:1375:gst_asio_object_create_buffers:<asioobject0> Creating buffer with size 1024
0:00:00.207159000 23788 000001EA5A1B67E0 INFO              asioobject gstasioobject.cpp:1389:gst_asio_object_create_buffers:<asioobject0> Selected buffer size 1024
0:00:00.210323000 23788 000001EA5A1B67E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:449:gst_asio_ring_buffer_configure:<asiosink0-asioringbuffer> configured buffer size: 1024
0:00:00.217372000 23788 000001EA5A1B67E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:128:gst_asio_ring_buffer_open_device:<asiosink0-asioringbuffer> Open
Pipeline is PREROLLING ...
0:00:00.222108000 23788 000001EA5A1C2080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
0:00:00.230202000 23788 000001EA5A1C2080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, samplerate=(int)48000, rate=(int)48000, format=(string)S32LE, channels=(int)2, layout=(string)interleaved
0:00:00.236093000 23788 000001EA5A1C2080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
0:00:00.241907000 23788 000001EA5A1C2080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, rate=(int)48000, samplerate=(int)48000, format=(string)S32LE, channels=(int)2, layout=(string)interleaved
0:00:00.249447000 23788 000001EA5A1C2080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
0:00:00.255870000 23788 000001EA5A1C2080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
0:00:00.263042000 23788 000001EA5A1C2080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
0:00:00.269854000 23788 000001EA5A1C2080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
0:00:00.277752000 23788 000001EA5A1C2040 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
0:00:00.283424000 23788 000001EA5A1C2040 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)2
Redistribute latency...
Pipeline is PREROLLED ...
Setting pipeline to PLAYING ...
0:00:00.293091000 23788 000001EA5A1C2040 DEBUG         asioringbuffer gstasioringbuffer.cpp:348:gst_asio_ring_buffer_start:<asiosink0-asioringbuffer> Start
Redistribute latency...
New clock: GstAudioSinkClock
0:00:00.584688000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 0, System Time: 3:24:28.755000000
0:00:00.591035000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.595889000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:00.601133000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 1024, System Time: 3:24:28.771000000
0:00:00.608394000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.613361000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:00.621386000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 2048, System Time: 3:24:28.792000000
0:00:00.627000000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.632377000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:00.700712000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 3072, System Time: 3:24:28.869000000
0:00:00.706837000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.713321000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:00.823389000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 4096, System Time: 3:24:28.993000000
0:00:00.829529000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.834277000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:00.903423000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 5120, System Time: 3:24:29.072000000
0:00:00.909528000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.916697000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:00.999397000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 6144, System Time: 3:24:29.169000000
0:00:01.006650000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.011471000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:01.100729000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 7168, System Time: 3:24:29.269000000
0:00:01.107762000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.113450000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:01.232706000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 8192, System Time: 3:24:29.402000000
0:00:01.238600000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.245026000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:01.334046000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 9216, System Time: 3:24:29.503000000
0:00:01.340551000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.345505000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:01.435381000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 10240, System Time: 3:24:29.605000000
0:00:01.442186000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.448593000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:01.536725000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 11264, System Time: 3:24:29.707000000
0:00:01.542821000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.547695000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:01.638075000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 12288, System Time: 3:24:29.807000000
0:00:01.643900000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.650238000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:01.723410000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 13312, System Time: 3:24:29.892000000
0:00:01.729538000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.735280000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:01.819418000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 14336, System Time: 3:24:29.989000000
0:00:01.825655000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.830376000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:01.894101000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 15360, System Time: 3:24:30.063000000
0:00:01.902135000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.907698000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:02.010115000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 16384, System Time: 3:24:30.179000000
0:00:02.016007000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:02.023654000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:02.132756000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 17408, System Time: 3:24:30.302000000
0:00:02.138582000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:02.143997000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:02.234105000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 18432, System Time: 3:24:30.403000000
0:00:02.240817000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:02.245330000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
0:00:02.346095000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 19456, System Time: 3:24:30.516000000
0:00:02.352241000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:02.357844000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 8192
0:00:02.495456000 23788 000001EA5A1C43C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 20480, System Time: 3:24:30.665000000
0:00:02.501244000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:02.506528000 23788 000001EA5A1C43C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 8192
handling interrupt.
Interrupt: Stopping pipeline ...
Execution ended after 0:00:02.226157000
Setting pipeline to NULL ...
0:00:02.522017000 23788 000001EA5A1B67E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:382:gst_asio_ring_buffer_stop:<asiosink0-asioringbuffer> Stop
0:00:02.525958000 23788 000001EA5A1B67E0 DEBUG             asioobject gstasioobject.cpp:1817:gst_asio_object_uninstall_callback:<asioobject0> Removing callback id 0
0:00:02.530208000 23788 000001EA5A1B67E0 DEBUG             asioobject gstasioobject.cpp:1846:gst_asio_object_uninstall_callback:<asioobject0> Found sink callback for id 0
0:00:02.536885000 23788 000001EA5A1B67E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:335:gst_asio_ring_buffer_release:<asiosink0-asioringbuffer> Release
0:00:02.541472000 23788 000001EA5A1B67E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:138:gst_asio_ring_buffer_close_device:<asiosink0-asioringbuffer> Close
0:00:02.552806000 23788 000001EA5A1C2000 INFO              asioobject gstasioobject.cpp:811:gst_asio_object_thread_func:<asioobject0> Exit loop
Freeing pipeline ...
-------------- next part --------------
>gst-launch audiotestsrc ! audio/x-raw, samplerate=48000, channels=2 ! audioconvert ! volume volume=0.2 ! queue ! asiosink device-clsid="\{232685C6-6548-49D8-846D-4141A3EF7560\}" output-channels=1 buffer-size=512
0:00:00.073456000 22400 000001285BA737E0 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, format=(string){ F64LE, F64BE, F32LE, F32BE, S32LE, S32BE, U32LE, U32BE, S24_32LE, S24_32BE, U24_32LE, U24_32BE, S24LE, S24BE, U24LE, U24BE, S20LE, S20BE, U20LE, U20BE, S18LE, S18BE, U18LE, U18BE, S16LE, S16BE, U16LE, U16BE, S8, U8 }, layout=(string)interleaved, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ]
0:00:00.083150000 22400 000001285BA737E0 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, format=(string){ F64LE, F64BE, F32LE, F32BE, S32LE, S32BE, U32LE, U32BE, S24_32LE, S24_32BE, U24_32LE, U24_32BE, S24LE, S24BE, U24LE, U24BE, S20LE, S20BE, U20LE, U20BE, S18LE, S18BE, U18LE, U18BE, S16LE, S16BE, U16LE, U16BE, S8, U8 }, layout=(string)interleaved, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ]
Use Windows high-resolution clock, precision: 1 ms
Setting pipeline to PAUSED ...
0:00:00.096242000 22400 000001285BA737E0 DEBUG               asiosink gstasiosink.cpp:245:gst_asio_sink_create_ringbuffer:<asiosink0> Create ringbuffer
0:00:00.100176000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:586:gst_asio_object_thread_func:<asioobject0> Enter loop, ThreadingModel: STA, driver-name: ASIO4ALL v2, driver-desc: ASIO4ALL v2
0:00:00.107035000 22400 000001285BA7F000 LOG               asioobject gstasioobject.cpp:434:gst_asio_object_create_internal_hwnd:<asioobject0> Register internal window class
0:00:00.135797000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:638:gst_asio_object_thread_func:<asioobject0> Input/Output channles: 2/2
0:00:00.139470000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:656:gst_asio_object_thread_func:<asioobject0> min-buffer-size 64, max-buffer-size 2048, preferred-buffer-size 128, buffer-size-granularity 8
0:00:00.144353000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 48000,0 is supported
0:00:00.147827000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 44100,0 is supported
0:00:00.153272000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 192000,0 is supported
0:00:00.156761000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:664:gst_asio_object_thread_func:<asioobject0> SampleRate 96000,0 is supported
0:00:00.160295000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:706:gst_asio_object_thread_func:<asioobject0> InputChannelInfo 0: isActive false, channelGroup 0, ASIOSampleType 18, name Not Connected 1
0:00:00.164492000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:706:gst_asio_object_thread_func:<asioobject0> InputChannelInfo 1: isActive false, channelGroup 0, ASIOSampleType 18, name Not Connected 2
0:00:00.170035000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:733:gst_asio_object_thread_func:<asioobject0> OutputChannelInfo 0: isActive false, channelGroup 0, ASIOSampleType 18, name Audio output with HAP 1
0:00:00.175120000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:733:gst_asio_object_thread_func:<asioobject0> OutputChannelInfo 1: isActive false, channelGroup 0, ASIOSampleType 18, name Audio output with HAP 2
0:00:00.180256000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:749:gst_asio_object_thread_func:<asioobject0> Current samplerate 48000,0
0:00:00.185269000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:474:gst_asio_object_main_loop_running_cb:<asioobject0> Main loop running now
0:00:00.189451000 22400 000001285BA737E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:435:gst_asio_ring_buffer_configure:<asiosink0-asioringbuffer> Configure
0:00:00.192811000 22400 000001285BA737E0 DEBUG             asioobject gstasioobject.cpp:1243:gst_asio_object_create_buffers:<asioobject0> Create buffers
0:00:00.196728000 22400 000001285BA737E0 INFO              asioobject gstasioobject.cpp:1300:gst_asio_object_create_buffers:<asioobject0> occupy-all-channels mode, will allocate buffers for all channels
0:00:00.202682000 22400 000001285BA737E0 INFO              asioobject gstasioobject.cpp:1375:gst_asio_object_create_buffers:<asioobject0> Creating buffer with size 512
0:00:00.206552000 22400 000001285BA737E0 INFO              asioobject gstasioobject.cpp:1389:gst_asio_object_create_buffers:<asioobject0> Selected buffer size 512
0:00:00.209975000 22400 000001285BA737E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:449:gst_asio_ring_buffer_configure:<asiosink0-asioringbuffer> configured buffer size: 512
0:00:00.216152000 22400 000001285BA737E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:128:gst_asio_ring_buffer_open_device:<asiosink0-asioringbuffer> Open
Pipeline is PREROLLING ...
0:00:00.221960000 22400 000001285BA7F080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
0:00:00.227519000 22400 000001285BA7F080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, samplerate=(int)48000, rate=(int)48000, format=(string)S32LE, channels=(int)1, layout=(string)interleaved
0:00:00.235857000 22400 000001285BA7F080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
0:00:00.241816000 22400 000001285BA7F080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, rate=(int)48000, samplerate=(int)48000, format=(string)S32LE, channels=(int)1, layout=(string)interleaved
0:00:00.249121000 22400 000001285BA7F080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
0:00:00.254447000 22400 000001285BA7F080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
0:00:00.261287000 22400 000001285BA7F080 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
0:00:00.266988000 22400 000001285BA7F080 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
0:00:00.272014000 22400 000001285BA7F040 DEBUG             asioobject gstasioobject.cpp:909:gst_asio_object_create_caps_from_channel_info:<asioobject0> Create caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
0:00:00.278914000 22400 000001285BA7F040 DEBUG               asiosink gstasiosink.cpp:220:gst_asio_sink_get_caps:<asiosink0> returning caps audio/x-raw, layout=(string)interleaved, format=(string)S32LE, rate=(int)48000, channels=(int)1
Redistribute latency...
Pipeline is PREROLLED ...
Setting pipeline to PLAYING ...
0:00:00.288436000 22400 000001285BA7F040 DEBUG         asioringbuffer gstasioringbuffer.cpp:348:gst_asio_ring_buffer_start:<asiosink0-asioringbuffer> Start
Redistribute latency...
New clock: GstAudioSinkClock
0:00:00.582054000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 0, System Time: 3:28:03.316000000
0:00:00.589339000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.593795000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:00.634853000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 512, System Time: 3:28:03.368000000
0:00:00.641060000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.645758000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:00.677559000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 1024, System Time: 3:28:03.411000000
0:00:00.684678000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.689737000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:00.714883000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 1536, System Time: 3:28:03.449000000
0:00:00.721037000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.726059000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:00.746865000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 2048, System Time: 3:28:03.480000000
0:00:00.752781000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.759750000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:00.784215000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 2560, System Time: 3:28:03.518000000
0:00:00.792103000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.797244000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:00.837541000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 3072, System Time: 3:28:03.572000000
0:00:00.843846000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.849025000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:00.869553000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 3584, System Time: 3:28:03.603000000
0:00:00.876094000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.881054000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:00.906887000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 4096, System Time: 3:28:03.640000000
0:00:00.912621000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.919770000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:00.944285000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 4608, System Time: 3:28:03.678000000
0:00:00.950548000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:00.956162000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:00.986884000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 5120, System Time: 3:28:03.720000000
0:00:00.994506000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:00.999550000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.040201000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 5632, System Time: 3:28:03.774000000
0:00:01.045981000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.051389000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.072212000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 6144, System Time: 3:28:03.805000000
0:00:01.077631000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.082787000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.114883000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 6656, System Time: 3:28:03.848000000
0:00:01.121580000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.126944000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.152223000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 7168, System Time: 3:28:03.887000000
0:00:01.159543000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.166809000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.178876000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 7680, System Time: 3:28:03.912000000
0:00:01.186699000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.191941000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.225577000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 8192, System Time: 3:28:03.959000000
0:00:01.232621000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.238696000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.257569000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 8704, System Time: 3:28:03.991000000
0:00:01.263306000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.268115000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.284221000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 9216, System Time: 3:28:04.018000000
0:00:01.291765000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.296858000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.326925000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 9728, System Time: 3:28:04.060000000
0:00:01.333180000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.341321000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.364242000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 10240, System Time: 3:28:04.097000000
0:00:01.371670000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.376787000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.401585000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 10752, System Time: 3:28:04.135000000
0:00:01.408194000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.413046000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.438897000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 11264, System Time: 3:28:04.173000000
0:00:01.444885000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.452169000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.476248000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 11776, System Time: 3:28:04.210000000
0:00:01.482932000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.488652000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.502894000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 12288, System Time: 3:28:04.238000000
0:00:01.509929000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.514802000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.550893000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 12800, System Time: 3:28:04.284000000
0:00:01.557922000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.562705000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
0:00:01.582906000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 13312, System Time: 3:28:04.317000000
0:00:01.589324000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.594208000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 0, length 2048
0:00:01.625605000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 13824, System Time: 3:28:04.359000000
0:00:01.632619000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 1
0:00:01.638682000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:173:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> segment 1, length 2048
handling interrupt.
Interrupt: Stopping pipeline ...
Execution ended after 0:00:01.372371000
Setting pipeline to NULL ...
0:00:01.662898000 22400 000001285BA813C0 TRACE             asioobject gstasioobject.cpp:1636:gst_asio_object_buffer_switch_time_info:<asioobject0> Sample Position: 14336, System Time: 3:28:04.396000000
0:00:01.663603000 22400 000001285BA737E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:382:gst_asio_ring_buffer_stop:<asiosink0-asioringbuffer> Stop
0:00:01.670681000 22400 000001285BA813C0 TRACE         asioringbuffer gstasioringbuffer.cpp:165:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> Buffer Switch callback, index 0
0:00:01.681762000 22400 000001285BA813C0 WARN          asioringbuffer gstasioringbuffer.cpp:169:gst_asio_buffer_switch_cb:<asiosink0-asioringbuffer> No segment available
0:00:01.686361000 22400 000001285BA737E0 DEBUG             asioobject gstasioobject.cpp:1817:gst_asio_object_uninstall_callback:<asioobject0> Removing callback id 0
0:00:01.690714000 22400 000001285BA737E0 DEBUG             asioobject gstasioobject.cpp:1846:gst_asio_object_uninstall_callback:<asioobject0> Found sink callback for id 0
0:00:01.697920000 22400 000001285BA737E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:335:gst_asio_ring_buffer_release:<asiosink0-asioringbuffer> Release
0:00:01.702787000 22400 000001285BA737E0 DEBUG         asioringbuffer gstasioringbuffer.cpp:138:gst_asio_ring_buffer_close_device:<asiosink0-asioringbuffer> Close
0:00:01.716243000 22400 000001285BA7F000 INFO              asioobject gstasioobject.cpp:811:gst_asio_object_thread_func:<asioobject0> Exit loop
Freeing pipeline ...


More information about the gstreamer-devel mailing list