media pipeline: rtpdemux0 send8 audiotestsrc fakesink2 rtpbin0 DEBUG (0x81ccf90 - 0:00:00.2180950001470):gst_base_sink_change_state: READY to PAUSED, need preroll to FALSE DEBUG (0x81ccf90 - 0:00:00.2181800001197):gst_base_sink_activate: Trying pull mode first DEBUG (0x81ccf90 - 0:00:00.2182270001204):gst_base_sink_activate: Falling back to push mode DEBUG (0x81ccf90 - 0:00:00.2182760001206):gst_base_sink_activate: Success activating push mode DEBUG (0x81ccf90 - 0:00:00.2188360001319):gst_base_src_activate_push: Activating in push mode DEBUG (0x81ccf90 - 0:00:00.2188910001204):gst_base_src_start: starting source DEBUG (0x81ccf90 - 0:00:00.2189340001229):gst_base_src_start: size 0 -1 DEBUG (0x81ccf90 - 0:00:00.2189810001107):gst_base_src_is_seekable: is seekable: 0 state_changed: 0x811cee8 playing ** Message: added incesink 0x822f710 to pipeline 0x8216a68 DEBUG (0x8214f28 - 0:00:00.231821000450):gst_base_src_default_newsegment: Sending newsegment from 0 to -1 DEBUG (0x8214f28 - 0:00:00.232031000773):gst_base_sink_event: event 0x8215aa8 DEBUG (0x8214f28 - 0:00:00.232087000552):gst_base_sink_handle_object: push 0x8215aa8 on preroll_queue DEBUG (0x8214f28 - 0:00:00.232147000591):gst_base_sink_handle_object: received NEWSEGMENT 0:00:00.000000000 -- 5124095:34:33.709551615, time 0:00:00.000000000, accum 0:00:00.000000000 DEBUG (0x8214f28 - 0:00:00.232205000637):gst_base_sink_handle_object: now 0 preroll, 0 buffers, 1 events on queue DEBUG (0x8214f28 - 0:00:00.232251000662):gst_base_sink_handle_object: prerolled length 0 DEBUG (0x8214f28 - 0:00:00.232312000853):gst_base_src_get_range: reading offset 0, length 320, size -1, segment.stop -1, maxsize -1 DEBUG (0x8214f28 - 0:00:00.232420000773):gst_base_sink_event: event 0x8215cd0 DEBUG (0x8214f28 - 0:00:00.232942000788):gst_base_src_do_sync: got times start: 0:00:00.000000000, end: 0:00:00.128000000 LOG (0x8214f28 - 0:00:00.232999000797):gst_base_src_do_sync: waiting for clock, base time 316680:38:03.972326000, stream_start 0:00:00.000000000 LOG (0x8214f28 - 0:00:00.233067000802):gst_base_src_do_sync: clock entry done: 1 DEBUG (0x8214f28 - 0:00:00.233112000893):gst_base_src_get_range: buffer too late!, returning anyway DEBUG (0x8214f28 - 0:00:00.233483000853):gst_base_src_get_range: reading offset 2048, length 320, size -1, segment.stop -1, maxsize -1 DEBUG (0x8214f28 - 0:00:00.233881000788):gst_base_src_do_sync: got times start: 0:00:00.128000000, end: 0:00:00.256000000 LOG (0x8214f28 - 0:00:00.233934000797):gst_base_src_do_sync: waiting for clock, base time 316680:38:03.972326000, stream_start 0:00:00.128000000 ** (lt-farsight_test_rtp:22870): DEBUG: linking src 0x81c7100 to codec bin 0x822f930 media pipeline: rtpdemux1 send8 alsasrc fakesink3 rtpbin1 DEBUG (0x81caba8 - 0:00:00.2578960001470):gst_base_sink_change_state: READY to PAUSED, need preroll to FALSE DEBUG (0x81caba8 - 0:00:00.2579970001197):gst_base_sink_activate: Trying pull mode first DEBUG (0x81caba8 - 0:00:00.2580460001204):gst_base_sink_activate: Falling back to push mode DEBUG (0x81caba8 - 0:00:00.2581450001206):gst_base_sink_activate: Success activating push mode DEBUG (0x81caba8 - 0:00:00.2587110001319):gst_base_src_activate_push: Activating in push mode DEBUG (0x81caba8 - 0:00:00.2587630001204):gst_base_src_start: starting source DEBUG (0x81caba8 - 0:00:00.2588040001229):gst_base_src_start: size 0 -1 DEBUG (0x81caba8 - 0:00:00.2588490001107):gst_base_src_is_seekable: is seekable: 0 state_changed: 0x8124918 playing DEBUG (0x8213360 - 0:00:00.263688000450):gst_base_src_default_newsegment: Sending newsegment from 0 to -1 DEBUG (0x8213360 - 0:00:00.263834000773):gst_base_sink_event: event 0x81ca150 DEBUG (0x8213360 - 0:00:00.263887000552):gst_base_sink_handle_object: push 0x81ca150 on preroll_queue DEBUG (0x8213360 - 0:00:00.263946000591):gst_base_sink_handle_object: received NEWSEGMENT 0:00:00.000000000 -- 5124095:34:33.709551615, time 0:00:00.000000000, accum 0:00:00.000000000 DEBUG (0x8213360 - 0:00:00.264004000637):gst_base_sink_handle_object: now 0 preroll, 0 buffers, 1 events on queue DEBUG (0x8213360 - 0:00:00.264051000662):gst_base_sink_handle_object: prerolled length 0 DEBUG (0x8213360 - 0:00:00.264113000853):gst_base_src_get_range: reading offset 0, length 4096, size -1, segment.stop -1, maxsize -1 DEBUG (0x8213360 - 0:00:00.296351000783):gst_base_src_do_sync: get_times returned invalid start DEBUG (0x8213360 - 0:00:00.296410000896):gst_base_src_get_range: buffer ok DEBUG (0x8213360 - 0:00:00.296780000853):gst_base_src_get_range: reading offset 340, length 4096, size -1, segment.stop -1, maxsize -1 DEBUG (0x8213360 - 0:00:00.318169000783):gst_base_src_do_sync: get_times returned invalid start DEBUG (0x8213360 - 0:00:00.318232000896):gst_base_src_get_range: buffer ok DEBUG (0x8213360 - 0:00:00.318328000853):gst_base_src_get_range: reading offset 680, length 4096, size -1, segment.stop -1, maxsize -1 DEBUG (0x8213360 - 0:00:00.338908000783):gst_base_src_do_sync: get_times returned invalid start DEBUG (0x8213360 - 0:00:00.338958000896):gst_base_src_get_range: buffer ok DEBUG (0x8213360 - 0:00:00.339040000853):gst_base_src_get_range: reading offset 1020, length 4096, size -1, segment.stop -1, maxsize -1 LOG (0x8214f28 - 0:00:00.349610000802):gst_base_src_do_sync: clock entry done: 0 DEBUG (0x8214f28 - 0:00:00.349658000896):gst_base_src_get_range: buffer ok DEBUG (0x8214f28 - 0:00:00.350183000552):gst_base_sink_handle_object: push 0x8257c78 on preroll_queue DEBUG (0x8214f28 - 0:00:00.350238000621):gst_base_sink_handle_object: got times start: 5124095:34:33.709551615, end: 5124095:34:33.709551615 DEBUG (0x8214f28 - 0:00:00.350286000637):gst_base_sink_handle_object: now 1 preroll, 1 buffers, 1 events on queue DEBUG (0x8214f28 - 0:00:00.350330000645):gst_base_sink_handle_object: do preroll 0x8257c78 DEBUG (0x8214f28 - 0:00:00.350372000653):gst_base_sink_handle_object: preroll buffer 5124095:34:33.709551615 DEBUG (0x8214f28 - 0:00:00.350445000662):gst_base_sink_handle_object: prerolled length 1 DEBUG (0x8214f28 - 0:00:00.350633000712):gst_base_sink_handle_object: no preroll needed DEBUG (0x8214f28 - 0:00:00.350731000404):gst_base_sink_preroll_queue_empty: emptying queue DEBUG (0x8214f28 - 0:00:00.350776000431):gst_base_sink_preroll_queue_empty: popped event 0x81ca150 DEBUG (0x8214f28 - 0:00:00.3510230001053):gst_base_sink_handle_event: event unref 0x822f710 0x81ca150 DEBUG (0x8214f28 - 0:00:00.351085000428):gst_base_sink_preroll_queue_empty: popped buffer 0x8257c78 DEBUG (0x8214f28 - 0:00:00.351129000922):gst_base_sink_do_sync: got times start: 5124095:34:33.709551615, end: 5124095:34:33.709551615 DEBUG (0x8214f28 - 0:00:00.351175000926):gst_base_sink_do_sync: start not valid DEBUG (0x8214f28 - 0:00:00.3512480001090):gst_base_sink_handle_buffer: buffer unref after render 0x822f710 DEBUG (0x8214f28 - 0:00:00.351297000438):gst_base_sink_preroll_queue_empty: queue empty DEBUG (0x8214f28 - 0:00:00.351422000552):gst_base_sink_handle_object: push 0x8257c78 on preroll_queue DEBUG (0x8214f28 - 0:00:00.351472000621):gst_base_sink_handle_object: got times start: 5124095:34:33.709551615, end: 5124095:34:33.709551615 DEBUG (0x8214f28 - 0:00:00.351518000637):gst_base_sink_handle_object: now 1 preroll, 1 buffers, 0 events on queue DEBUG (0x8214f28 - 0:00:00.351570000712):gst_base_sink_handle_object: no preroll needed DEBUG (0x8214f28 - 0:00:00.351609000404):gst_base_sink_preroll_queue_empty: emptying queue DEBUG (0x8214f28 - 0:00:00.351649000428):gst_base_sink_preroll_queue_empty: popped buffer 0x8257c78 DEBUG (0x8214f28 - 0:00:00.351690000922):gst_base_sink_do_sync: got times start: 5124095:34:33.709551615, end: 5124095:34:33.709551615 DEBUG (0x8214f28 - 0:00:00.351736000926):gst_base_sink_do_sync: start not valid DEBUG (0x8214f28 - 0:00:00.3518070001090):gst_base_sink_handle_buffer: buffer unref after render 0x822f710 DEBUG (0x8214f28 - 0:00:00.351855000438):gst_base_sink_preroll_queue_empty: queue empty DEBUG (0x8214f28 - 0:00:00.351926000853):gst_base_src_get_range: reading offset 4096, length 320, size -1, segment.stop -1, maxsize -1 DEBUG (0x8214f28 - 0:00:00.352313000788):gst_base_src_do_sync: got times start: 0:00:00.256000000, end: 0:00:00.384000000 LOG (0x8214f28 - 0:00:00.352363000797):gst_base_src_do_sync: waiting for clock, base time 316680:38:03.972326000, stream_start 0:00:00.256000000 DEBUG (0x8213360 - 0:00:00.360173000783):gst_base_src_do_sync: get_times returned invalid start DEBUG (0x8213360 - 0:00:00.360260000896):gst_base_src_get_range: buffer ok DEBUG (0x8213360 - 0:00:00.360342000853):gst_base_src_get_range: reading offset 1360, length 4096, size -1, segment.stop -1, maxsize -1