Problem with webmmux duration when stream larger than 10 mins.

[vellee]

Hi:
   I'm writing record webrtc stream whit gstreamer.But I got one issues is that when my stream duration is less than 9mins
the recorded webm's duration is correct, but  when I record stream duration large than 10mins ,the recorded file's duratin is
not corrent (duration is -35791394:-8).

My pipeline like this:
   appsrc->rtpjitterbuffer->rtpvp9depay->queue->wemmux->filesink.

I don't know whe the duration is not correct when stream duration large than 10min.

Anyone can give me some suggestions?
Thans

[vellee]

This is my pipeline.

[vellee]

This is my pipeline.
This is my pipeline.

[Rudolfs Bundulis]

Webm uses signed 16bit values to denote simple block durations which COULD be the issue if for some reason the stream is not properly split into clusters. Can you use any of the available tools like mkvinfo to print out the EBLM element structure and put it there so that we could see all the timescales and lengths?

_______________________________________________
gstreamer-devel mailing list
[hidden email]
https://lists.freedesktop.org/mailman/listinfo/gstreamer-devel

[vellee]

At the end of the webrtc stream , I send an eos event to my pipeline.
Here is the messages I got.


09] Send eos ===================
0:00:00.745033387 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 3987467
0:00:00.745070830 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 3987467
0:00:00.745091166 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=3987467, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.745157528 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 4641201
0:00:00.745184915 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 4641201
0:00:00.745203178 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=4641201, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.799869849 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 4641205
0:00:00.799914088 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 4641205
0:00:00.799934559 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=4641205, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.800006843 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5295637
0:00:00.800034269 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5295637
0:00:00.800051649 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5295637, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.853418817 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5295641
0:00:00.853470062 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5295641
0:00:00.853496568 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5295641, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.853584667 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5950406
0:00:00.853609905 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5950406
0:00:00.853624664 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5950406, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.903168919 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5950410
0:00:00.903193113 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5950410
0:00:00.903202946 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5950410, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.903238262 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 6606114
0:00:00.903251869 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 6606114
0:00:00.903259870 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=6606114, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.956868321 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 6606118
0:00:00.956904040 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 6606118
0:00:00.956919636 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=6606118, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.956970515 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7260288
0:00:00.956991070 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7260288
0:00:00.957003300 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7260288, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.015539136 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7260292
0:00:01.015572240 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7260292
0:00:01.015593139 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7260292, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.015666347 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7915307
0:00:01.015698632 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7915307
0:00:01.015719992 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7915307, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.022345009 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7915311
0:00:01.022369995 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7915311
0:00:01.022389805 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7915311, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.022448305 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7990013
0:00:01.022485346 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7990013
0:00:01.022506981 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7990013, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.083393995 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7990017
0:00:01.083428805 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7990017
0:00:01.083450287 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7990017, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.083524683 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 8644433
0:00:01.083557070 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 8644433
0:00:01.083578305 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=8644433, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.143795555 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 8644437
0:00:01.143830999 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 8644437
0:00:01.143847778 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=8644437, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.143898994 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9300477
0:00:01.143920927 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9300477
0:00:01.143933452 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9300477, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.207097492 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9300481
0:00:01.207152136 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9300481
0:00:01.207185348 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9300481, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.207292951 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9955463
0:00:01.207329278 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9955463
0:00:01.207355102 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9955463, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.270909441 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9955467
0:00:01.270945431 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9955467
0:00:01.270968458 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9955467, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.271043901 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 10611625
0:00:01.271078107 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 10611625
0:00:01.271100273 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=10611625, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.332912046 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 10611629
0:00:01.332946303 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 10611629
0:00:01.332968105 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=10611629, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.333042788 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11267138
0:00:01.333074168 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11267138
0:00:01.333095402 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11267138, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.381635850 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11267142
0:00:01.381677928 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11267142
0:00:01.381695715 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11267142, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.381756514 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11878122
0:00:01.381779594 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11878122
0:00:01.381794209 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11878122, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.381988803 21738      0x26fed90 INFO                    task gsttask.c:328:gst_task_func:<video_jitter_buffer:src> Task going to paused
0:00:01.384140262 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11878126
0:00:01.384169084 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11878126
0:00:01.384183445 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11878126, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.384233521 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11899178
0:00:01.384254349 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11899178
0:00:01.384266910 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11899178, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.384334858 21738      0x26fed40 INFO                    task gsttask.c:328:gst_task_func:<queue1:src> Task going to paused
0:00:01.397132312 21738      0x26fede0 INFO                    task gsttask.c:328:gst_task_func:<audio_jitter_buffer:src> Task going to paused
0:00:01.398254642 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11899182
0:00:01.398289135 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11899182
0:00:01.398314941 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11899182, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398355032 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946764
0:00:01.398397710 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11946764
0:00:01.398410535 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11946764, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398447714 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 72
0:00:01.398462496 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 72
0:00:01.398474276 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=72, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398505140 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398519371 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 100
0:00:01.398531410 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 100
0:00:01.398542898 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=100, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398572231 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398585904 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 108
0:00:01.398605042 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398618054 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 156
0:00:01.398629458 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 156
0:00:01.398641138 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=156, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398678036 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398690506 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 164
0:00:01.398707497 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398719329 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398730003 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 211
0:00:01.398741143 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 211
0:00:01.398751765 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=211, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398778676 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398791326 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 32
0:00:01.398802152 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 32
0:00:01.398812784 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=32, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398838320 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398871235 21738      0x26fee30 INFO                    task gsttask.c:328:gst_task_func:<queue0:src> Task going to paused
I1120 22:48:07.411525 21738 stream_recorder_element.cc:28] Got message=========================================1
0:00:01.399207853 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399234651 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to PAUSED
0:00:01.399244348 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399260395 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 3(PAUSED) successfully
0:00:01.399271813 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399281521 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
0:00:01.399289120 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399299735 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:01.399309823 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399319719 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to PAUSED
0:00:01.399327680 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399338104 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 3(PAUSED) successfully
0:00:01.399347617 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399356920 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter1> completed state change to PAUSED
0:00:01.399364324 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399374042 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter1' changed state to 3(PAUSED) successfully
0:00:01.399384538 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter2> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399394010 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter2> completed state change to PAUSED
0:00:01.399401537 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter2> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399412054 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter2' changed state to 3(PAUSED) successfully
0:00:01.399422033 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399432269 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue0> completed state change to PAUSED
0:00:01.399439809 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399450457 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue0' changed state to 3(PAUSED) successfully
0:00:01.399460301 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399469569 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue1> completed state change to PAUSED
0:00:01.399477360 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399487797 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue1' changed state to 3(PAUSED) successfully
0:00:01.399497888 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399507566 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to PAUSED
0:00:01.399515485 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399525652 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 3(PAUSED) successfully
0:00:01.399535225 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399544968 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to PAUSED
0:00:01.399552469 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399562262 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 3(PAUSED) successfully
0:00:01.399572205 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<audio_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399581874 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to PAUSED
0:00:01.399589285 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399599037 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 3(PAUSED) successfully without preroll
0:00:01.399609090 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399617902 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to PAUSED
0:00:01.399625224 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399635230 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 3(PAUSED) successfully without preroll
0:00:01.399644665 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399655983 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc0> completed state change to PAUSED
0:00:01.399663552 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399673716 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc0' changed state to 3(PAUSED) successfully without preroll
0:00:01.399683464 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399693645 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc1> completed state change to PAUSED
0:00:01.399701105 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399711037 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc1' changed state to 3(PAUSED) successfully without preroll
0:00:01.399722736 21738      0x24d5400 INFO              GST_STATES gstelement.c:2347:gst_element_continue_state:<stream_recorder_element_pipeline> committing state from PLAYING to PAUSED, pending NULL, next READY
0:00:01.399732101 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed PLAYING to PAUSED (NULL pending)
0:00:01.399741689 21738      0x24d5400 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<stream_recorder_element_pipeline> continue state change PAUSED to READY, final NULL
0:00:01.399758624 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399776724 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to READY
0:00:01.399785397 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399795887 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 2(READY) successfully
0:00:01.399805332 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter0> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399821733 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter0> completed state change to READY
0:00:01.399829770 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399840054 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter0' changed state to 2(READY) successfully
0:00:01.399853359 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399888859 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to READY
0:00:01.399902269 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399928798 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 2(READY) successfully
0:00:01.399943575 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter1> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399960685 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter1> completed state change to READY
0:00:01.399968574 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399978288 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter1' changed state to 2(READY) successfully
0:00:01.399997216 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter2> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400023301 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter2> completed state change to READY
0:00:01.400031046 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter2> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400051534 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter2' changed state to 2(READY) successfully
0:00:01.400060137 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue0> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400076619 21738      0x26fee30 INFO                    task gsttask.c:330:gst_task_func:<queue0:src> Task resume from paused
0:00:01.400107628 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue0> completed state change to READY
0:00:01.400117325 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400127471 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue0' changed state to 2(READY) successfully
0:00:01.400136435 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue1> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400174850 21738      0x26fed40 INFO                    task gsttask.c:330:gst_task_func:<queue1:src> Task resume from paused
0:00:01.400207915 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue1> completed state change to READY
0:00:01.400217572 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400239248 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue1' changed state to 2(READY) successfully
0:00:01.400248317 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400263068 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to READY
0:00:01.400270305 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400279551 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 2(READY) successfully
0:00:01.400288151 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400302425 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to READY
0:00:01.400309718 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400318655 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 2(READY) successfully
0:00:01.400335701 21738      0x26fede0 INFO                    task gsttask.c:330:gst_task_func:<audio_jitter_buffer:src> Task resume from paused
0:00:01.400430459 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to READY
0:00:01.400454731 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400465853 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 2(READY) successfully
0:00:01.400506351 21738      0x26fed90 INFO                    task gsttask.c:330:gst_task_func:<video_jitter_buffer:src> Task resume from paused
0:00:01.400568485 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to READY
0:00:01.400591025 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400600916 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 2(READY) successfully
0:00:01.400622080 21738      0x26fef20 INFO                    task gsttask.c:330:gst_task_func:<appsrc0:src> Task resume from paused
0:00:01.400644430 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc0> completed state change to READY
0:00:01.400653193 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400662836 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc0' changed state to 2(READY) successfully
0:00:01.400703727 21738      0x26feed0 INFO                    task gsttask.c:330:gst_task_func:<appsrc1:src> Task resume from paused
0:00:01.400735320 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc1> completed state change to READY
0:00:01.400744386 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400774839 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc1' changed state to 2(READY) successfully
0:00:01.400797687 21738      0x24d5400 INFO              GST_STATES gstelement.c:2347:gst_element_continue_state:<stream_recorder_element_pipeline> committing state from PAUSED to READY, pending NULL, next NULL
0:00:01.400806153 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed PAUSED to READY (NULL pending)
0:00:01.400814683 21738      0x24d5400 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<stream_recorder_element_pipeline> continue state change READY to NULL, final NULL
0:00:01.400829158 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current READY pending VOID_PENDING, desired next NULL
0:00:01.402615303 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to NULL
0:00:01.402631823 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402645925 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 1(NULL) successfully
0:00:01.402657530 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next NULL
0:00:01.402668671 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter0> completed state change to NULL
0:00:01.402675986 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402685458 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter0' changed state to 1(NULL) successfully
0:00:01.402695029 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current READY pending VOID_PENDING, desired next NULL
0:00:01.402705014 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to NULL
0:00:01.402712016 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402720968 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 1(NULL) successfully
0:00:01.402729541 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter1> current READY pending VOID_PENDING, desired next NULL
0:00:01.402738613 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter1> completed state change to NULL
0:00:01.402745467 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402754500 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter1' changed state to 1(NULL) successfully
0:00:01.402762707 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter2> current READY pending VOID_PENDING, desired next NULL
0:00:01.402771999 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter2> completed state change to NULL
0:00:01.402778910 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter2> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402787526 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter2' changed state to 1(NULL) successfully
0:00:01.402795714 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue0> current READY pending VOID_PENDING, desired next NULL
0:00:01.402805097 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue0> completed state change to NULL
0:00:01.402812191 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402821180 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue0' changed state to 1(NULL) successfully
0:00:01.402829599 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue1> current READY pending VOID_PENDING, desired next NULL
0:00:01.402838504 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue1> completed state change to NULL
0:00:01.402845189 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402854114 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue1' changed state to 1(NULL) successfully
0:00:01.402862726 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current READY pending VOID_PENDING, desired next NULL
0:00:01.402872082 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to NULL
0:00:01.402879031 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402888117 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 1(NULL) successfully
0:00:01.402896988 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current READY pending VOID_PENDING, desired next NULL
0:00:01.402906357 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to NULL
0:00:01.402913361 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402922092 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 1(NULL) successfully
0:00:01.402930776 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<audio_jitter_buffer> current READY pending VOID_PENDING, desired next NULL
0:00:01.402939856 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to NULL
0:00:01.402953861 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402965848 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 1(NULL) successfully
0:00:01.402975447 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_jitter_buffer> current READY pending VOID_PENDING, desired next NULL
0:00:01.402984702 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to NULL
0:00:01.402991495 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.403001140 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 1(NULL) successfully
0:00:01.403009675 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc0> current READY pending VOID_PENDING, desired next NULL
0:00:01.403018831 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc0> completed state change to NULL
0:00:01.403025486 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.403034174 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc0' changed state to 1(NULL) successfully
0:00:01.403042283 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc1> current READY pending VOID_PENDING, desired next NULL
0:00:01.403051395 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc1> completed state change to NULL
0:00:01.403058101 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.403066881 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc1' changed state to 1(NULL) successfully
0:00:01.403106840 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<stream_recorder_element_pipeline> completed state change to NULL
0:00:01.403115613 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder

[vellee]

0:00:00.682763983 21738      0x24d5400 INFO              GST_STATES gstbin.c:1915:gst_bin_get_state_func:<stream_recorder_element_pipeline> getting state
0:00:00.682779647 21738      0x24d5400 INFO              GST_STATES gstelement.c:2090:gst_element_get_state_func:<stream_recorder_element_pipeline> waiting for element to commit state
0:00:00.682789065 21738      0x24d5400 INFO              GST_STATES gstelement.c:2104:gst_element_get_state_func:<stream_recorder_element_pipeline> timed out
0:00:00.683325243 21738      0x24d5400 INFO              GST_STATES gstelement.c:2090:gst_element_get_state_func:<filesink> waiting for element to commit state
0:00:00.683339721 21738      0x24d5400 INFO              GST_STATES gstelement.c:2104:gst_element_get_state_func:<filesink> timed out
0:00:00.683488191 21738      0x24d5400 INFO                 default gstdebugutils.c:811:gst_debug_bin_to_dot_file: wrote bin graph to : '/home/yong/Develop/orbit/dot/destroy.dot'
0:00:00.683516055 21738 0x7f05cc003770 INFO                 basesrc gstbasesrc.c:2739:gst_base_src_loop:<appsrc3> pausing after gst_base_src_get_range() = eos
0:00:00.683548704 21738 0x7f05cc003770 INFO                    task gsttask.c:328:gst_task_func:<appsrc3:src> Task going to paused
0:00:00.683577945 21738 0x7f05cc003540 INFO                    task gsttask.c:328:gst_task_func:<queue3:src> Task going to paused
0:00:00.683570175 21738 0x7f05cc003630 INFO                    task gsttask.c:328:gst_task_func:<video_jitter_buffer:src> Task going to paused
0:00:00.683550256 21738      0x275b000 INFO                 basesrc gstbasesrc.c:2739:gst_base_src_loop:<appsrc2> pausing after gst_base_src_get_range() = eos
0:00:00.683634465 21738      0x275b000 INFO                    task gsttask.c:328:gst_task_func:<appsrc2:src> Task going to paused
0:00:00.683644711 21738 0x7f05cc003590 INFO                    task gsttask.c:328:gst_task_func:<audio_jitter_buffer:src> Task going to paused
I1120 22:48:06.695996 21738 stream_recorder_element.cc:109] Send eos ===================
0:00:00.683660694 21738      0x26cd4a0 INFO             matroskamux matroska-mux.c:2735:gst_matroska_mux_start:<webmmux> downstream is seekable
0:00:00.683682958 21738      0x26cd4a0 FIXME               basesink gstbasesink.c:3125:gst_base_sink_default_event:<filesink> stream-start event without group-id. Consider implementing group-id handling in the upstream elements
I1120 22:48:06.696053 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683706204 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/webm
I1120 22:48:06.696084 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683731091 21738      0x26cd4a0 INFO           basetransform gstbasetransform.c:1367:gst_base_transform_setcaps:<capsfilter3> reuse caps
0:00:00.683751212 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/webm
I1120 22:48:06.696126 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683769585 21738      0x26cd4a0 INFO             matroskamux matroska-mux.c:2767:gst_matroska_mux_start:<ebmlwrite1> DocType: webm, Version: 2
I1120 22:48:06.696148 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683797829 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 0
I1120 22:48:06.696171 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683807630 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=0, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.696185 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683840549 21738      0x26cd4a0 INFO              GST_STATES gstbin.c:3247:bin_handle_async_done:<stream_recorder_element_pipeline> setting state from PAUSED to PAUSED, pending PLAYING
I1120 22:48:06.696213 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683852838 21738      0x26cd4a0 INFO              GST_STATES gstbin.c:3267:bin_handle_async_done:<stream_recorder_element_pipeline> continue state change, pending PLAYING
I1120 22:48:06.696233 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683883014 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:3061:gst_bin_continue_func:<stream_recorder_element_pipeline> continue state change PAUSED to PLAYING, final PLAYING
I1120 22:48:06.696254 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.696275 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.696293 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683934533 21738 0x7f05c40031e0 INFO               GST_EVENT gstevent.c:1253:gst_event_new_latency: creating latency event 0:00:00.000000000
I1120 22:48:06.696310 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683969427 21738 0x7f05c40031e0 INFO                     bin gstbin.c:2593:gst_bin_do_latency_func:<stream_recorder_element_pipeline> configured latency of 0:00:00.000000000
I1120 22:48:06.696334 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.683991794 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current PAUSED pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.696357 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684007595 21738 0x7f05c40031e0 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to PLAYING
I1120 22:48:06.696388 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684025173 21738 0x7f05c40031e0 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
I1120 22:48:06.696406 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684058720 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 4(PLAYING) successfully
0:00:00.684079035 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter3> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.696442 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684096847 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<capsfilter3> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.696473 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684121148 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter3' changed state to 4(PLAYING) successfully
I1120 22:48:06.696501 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684147559 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.696517 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684165387 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<webmmux> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.696545 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.696558 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684195790 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 4(PLAYING) successfully
I1120 22:48:06.696574 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684220861 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter4> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.684135597 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/webm, streamheader=(buffer)< 1a45dfa301000000000000104282857765626d0042878102428581021853806701ffffffffffffff114d9b74010000000000008c4dbb010000000000001253ab841549a96653ac88ffffffffffffffff4dbb010000000000001253ab841654ae6b53ac88ffffffffffffffff4dbb010000000000001253ab841043a77053ac88ffffffffffffffff4dbb010000000000001253ab841c53bb6b53ac88ffffffffffffffff4dbb010000000000001253ab841254c36753ac88ffffffffffffffff1549a96601000000000000622ad7b1830f424044898800000000000000004d80a64753747265616d6572206d6174726f736b616d75782076657273696f6e20312e382e312e31005741994753747265616d6572204d6174726f736b61206d757865720044618806f54e2c5ef01c001654ae6b010000000000005fae0100000000000056d7810183810273c588f47c69fb7f0ecd20536e86417564696f00e1010000000000000db58840e77000000000009f81028687415f4f5055530063a2934f707573486561640102000080bb000000000056bb8404c4b400 >
I1120 22:48:06.696594 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684239591 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<capsfilter4> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.696635 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684274072 21738      0x26cd4a0 INFO           basetransform gstbasetransform.c:1367:gst_base_transform_setcaps:<capsfilter3> reuse caps
0:00:00.684281824 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter4' changed state to 4(PLAYING) successfully
I1120 22:48:06.696655 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684319393 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter5> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.696693 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684337155 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<capsfilter5> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.696712 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684359258 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter5' changed state to 4(PLAYING) successfully
I1120 22:48:06.696738 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684382772 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue2> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.684303433 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/webm, streamheader=(buffer)< 1a45dfa301000000000000104282857765626d0042878102428581021853806701ffffffffffffff114d9b74010000000000008c4dbb010000000000001253ab841549a96653ac88ffffffffffffffff4dbb010000000000001253ab841654ae6b53ac88ffffffffffffffff4dbb010000000000001253ab841043a77053ac88ffffffffffffffff4dbb010000000000001253ab841c53bb6b53ac88ffffffffffffffff4dbb010000000000001253ab841254c36753ac88ffffffffffffffff1549a96601000000000000622ad7b1830f424044898800000000000000004d80a64753747265616d6572206d6174726f736b616d75782076657273696f6e20312e382e312e31005741994753747265616d6572204d6174726f736b61206d757865720044618806f54e2c5ef01c001654ae6b010000000000005fae0100000000000056d7810183810273c588f47c69fb7f0ecd20536e86417564696f00e1010000000000000db58840e77000000000009f81028687415f4f5055530063a2934f707573486561640102000080bb000000000056bb8404c4b400 >
I1120 22:48:06.696755 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684402259 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<queue2> skipping transition from PLAYING to  PLAYING
0:00:00.684432159 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 72
I1120 22:48:06.696796 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684442792 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue2' changed state to 4(PLAYING) successfully
0:00:00.684455530 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 72
I1120 22:48:06.696830 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684488731 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=72, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.696867 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684477949 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue3> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.684526670 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
I1120 22:48:06.696880 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684530399 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<queue3> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.696921 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684542743 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 100
I1120 22:48:06.696934 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684571542 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue3' changed state to 4(PLAYING) successfully
0:00:00.684583805 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 100
I1120 22:48:06.696964 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684606017 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.684616272 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=100, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.696991 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684636475 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<opusdepay> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.697027 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684665636 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
0:00:00.684673666 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 4(PLAYING) successfully
I1120 22:48:06.697046 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684692382 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 108
I1120 22:48:06.697083 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684707553 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.697098 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684746016 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
0:00:00.684748460 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<video_rtp_depay> skipping transition from PLAYING to  PLAYING
0:00:00.684766768 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 136
I1120 22:48:06.697134 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684779841 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 4(PLAYING) successfully
0:00:00.684792837 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 136
I1120 22:48:06.697167 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684814551 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<audio_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.697203 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684825243 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=136, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.697216 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684853802 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<audio_jitter_buffer> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.697244 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.684883549 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
0:00:00.684891331 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 4(PLAYING) successfully
I1120 22:48:06.697265 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684909342 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 164
I1120 22:48:06.697300 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684924660 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.697314 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684951283 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 164
I1120 22:48:06.697340 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684962953 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<video_jitter_buffer> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.697353 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.684989756 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=164, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.697382 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685003917 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 4(PLAYING) successfully
0:00:00.685039480 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
0:00:00.685054911 21738      0x26cd4a0 WARN             matroskamux matroska-mux.c:3333:gst_matroska_mux_finish:0x2754000 unable to get final track duration
I1120 22:48:06.697396 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685059540 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc2> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.697448 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685069486 21738      0x26cd4a0 WARN             matroskamux matroska-mux.c:3333:gst_matroska_mux_finish:0x275c200 unable to get final track duration
I1120 22:48:06.697459 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685097439 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<appsrc2> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.697489 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685109279 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
0:00:00.685128461 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc2' changed state to 4(PLAYING) successfully
I1120 22:48:06.697501 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685145431 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 211
I1120 22:48:06.697536 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685159407 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc3> current PLAYING pending VOID_PENDING, desired next PLAYING
I1120 22:48:06.697549 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685186701 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 211
I1120 22:48:06.697576 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685216896 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=211, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.685198337 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2433:gst_bin_element_set_state:<appsrc3> skipping transition from PLAYING to  PLAYING
I1120 22:48:06.697589 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685248704 21738 0x7f05c40031e0 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc3' changed state to 4(PLAYING) successfully
I1120 22:48:06.697628 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685270445 21738 0x7f05c40031e0 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<stream_recorder_element_pipeline> completed state change to PLAYING
0:00:00.685250424 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
I1120 22:48:06.697640 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685283749 21738 0x7f05c40031e0 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
I1120 22:48:06.697676 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685296807 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 32
I1120 22:48:06.697690 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685334851 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 32
I1120 22:48:06.697713 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685350961 21738      0x26cd4a0 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=32, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.697726 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685382771 21738      0x26cd4a0 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 409
I1120 22:48:06.697747 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685402291 21738      0x26cd4a0 INFO                    task gsttask.c:328:gst_task_func:<queue2:src> Task going to paused
I1120 22:48:06.697767 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685417609 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 3930104
I1120 22:48:06.697790 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685434681 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 3930104
I1120 22:48:06.697809 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685452420 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=3930104, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.697829 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685477929 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 3987463
I1120 22:48:06.697841 21738 stream_recorder_element.cc:28] Got message=========================================64
0:00:00.685490809 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 3987463
I1120 22:48:06.697867 21738 stream_recorder_element.cc:28] Got message=========================================8192
0:00:00.685505296 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=3987463, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
I1120 22:48:06.697880 21738 stream_recorder_element.cc:28] Got message=========================================8192
I1120 22:48:06.697901 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.697911 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.697926 21738 stream_recorder_element.cc:28] Got message=========================================2048
I1120 22:48:06.697935 21738 stream_recorder_element.cc:28] Got message=========================================2048
I1120 22:48:06.697949 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.697959 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.697973 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.697983 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.697998 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698012 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698026 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698036 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698050 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698060 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698074 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698084 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698097 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698107 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698122 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698132 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698144 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698154 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698168 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698179 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698191 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698201 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698215 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698225 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698238 21738 stream_recorder_element.cc:28] Got message=========================================268435456
I1120 22:48:06.698248 21738 stream_recorder_element.cc:28] Got message=========================================268435456
I1120 22:48:06.698262 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698273 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698287 21738 stream_recorder_element.cc:28] Got message=========================================2097152
I1120 22:48:06.698297 21738 stream_recorder_element.cc:28] Got message=========================================2097152
I1120 22:48:06.698310 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698320 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698338 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698348 21738 stream_recorder_element.cc:28] Got message=========================================64
I1120 22:48:06.698364 21738 stream_recorder_element.cc:28] Got message=========================================1
0:00:00.686025098 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686040607 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to PAUSED
0:00:00.686049718 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686065643 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 3(PAUSED) successfully
0:00:00.686076707 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter3> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686086295 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter3> completed state change to PAUSED
0:00:00.686094007 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter3> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686104384 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter3' changed state to 3(PAUSED) successfully
0:00:00.686114392 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686124117 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to PAUSED
0:00:00.686131956 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686142046 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 3(PAUSED) successfully
0:00:00.686151676 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter4> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686160846 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter4> completed state change to PAUSED
0:00:00.686168810 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter4> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686178646 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter4' changed state to 3(PAUSED) successfully
0:00:00.686188047 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter5> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686197370 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter5> completed state change to PAUSED
0:00:00.686205203 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter5> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686215021 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter5' changed state to 3(PAUSED) successfully
0:00:00.686224397 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue2> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686233736 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue2> completed state change to PAUSED
0:00:00.686241395 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue2> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686251632 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue2' changed state to 3(PAUSED) successfully
0:00:00.686261350 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue3> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686270502 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue3> completed state change to PAUSED
0:00:00.686277951 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue3> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686287788 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue3' changed state to 3(PAUSED) successfully
0:00:00.686297084 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686306384 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to PAUSED
0:00:00.686314109 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686323966 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 3(PAUSED) successfully
0:00:00.686333409 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686342882 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to PAUSED
0:00:00.686350622 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686360631 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 3(PAUSED) successfully
0:00:00.686370250 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<audio_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686380478 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to PAUSED
0:00:00.686388305 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686398992 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 3(PAUSED) successfully without preroll
0:00:00.686408752 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686418058 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to PAUSED
0:00:00.686426185 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686436155 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 3(PAUSED) successfully without preroll
0:00:00.686445849 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc2> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686456469 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc2> completed state change to PAUSED
0:00:00.686464174 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc2> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686474007 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc2' changed state to 3(PAUSED) successfully without preroll
0:00:00.686483326 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc3> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.686493462 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc3> completed state change to PAUSED
0:00:00.686501170 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc3> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.686511021 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc3' changed state to 3(PAUSED) successfully without preroll
0:00:00.686522148 21738      0x24d5400 INFO              GST_STATES gstelement.c:2347:gst_element_continue_state:<stream_recorder_element_pipeline> committing state from PLAYING to PAUSED, pending NULL, next READY
0:00:00.686532320 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed PLAYING to PAUSED (NULL pending)
0:00:00.686542144 21738      0x24d5400 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<stream_recorder_element_pipeline> continue state change PAUSED to READY, final NULL
0:00:00.686558151 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686575325 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to READY
0:00:00.686583885 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686594325 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 2(READY) successfully
0:00:00.686604097 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter3> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686619298 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter3> completed state change to READY
0:00:00.686627599 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter3> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686638262 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter3' changed state to 2(READY) successfully
0:00:00.686648055 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686672145 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to READY
0:00:00.686680968 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686691678 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 2(READY) successfully
0:00:00.686701396 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter4> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686715872 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter4> completed state change to READY
0:00:00.686723994 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter4> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686734297 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter4' changed state to 2(READY) successfully
0:00:00.686743926 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter5> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686755798 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter5> completed state change to READY
0:00:00.686763636 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter5> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686773573 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter5' changed state to 2(READY) successfully
0:00:00.686783081 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue2> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686803371 21738      0x26cd4a0 INFO                    task gsttask.c:330:gst_task_func:<queue2:src> Task resume from paused
0:00:00.686838260 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue2> completed state change to READY
0:00:00.686847863 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue2> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686858306 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue2' changed state to 2(READY) successfully
0:00:00.686868087 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue3> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686884952 21738 0x7f05cc003540 INFO                    task gsttask.c:330:gst_task_func:<queue3:src> Task resume from paused
0:00:00.686918961 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue3> completed state change to READY
0:00:00.686935522 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue3> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686948698 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue3' changed state to 2(READY) successfully
0:00:00.686961135 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.686979312 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to READY
0:00:00.686987888 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.686998474 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 2(READY) successfully
0:00:00.687008970 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current PAUSED pending VOID_PENDING, desired next READY
0:00:00.687022583 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to READY
0:00:00.687030888 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.687041267 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 2(READY) successfully
0:00:00.687059352 21738 0x7f05cc003590 INFO                    task gsttask.c:330:gst_task_func:<audio_jitter_buffer:src> Task resume from paused
0:00:00.687110655 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to READY
0:00:00.687124462 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.687136247 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 2(READY) successfully
0:00:00.687155904 21738 0x7f05cc003630 INFO                    task gsttask.c:330:gst_task_func:<video_jitter_buffer:src> Task resume from paused
0:00:00.687193005 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to READY
0:00:00.687208795 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.687221102 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 2(READY) successfully
0:00:00.687246619 21738      0x275b000 INFO                    task gsttask.c:330:gst_task_func:<appsrc2:src> Task resume from paused
0:00:00.687284193 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc2> completed state change to READY
0:00:00.687300624 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc2> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.687976927 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc2' changed state to 2(READY) successfully
0:00:00.688009100 21738 0x7f05cc003770 INFO                    task gsttask.c:330:gst_task_func:<appsrc3:src> Task resume from paused
0:00:00.688045147 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc3> completed state change to READY
0:00:00.688063289 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc3> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.688084230 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc3' changed state to 2(READY) successfully
0:00:00.688106523 21738      0x24d5400 INFO              GST_STATES gstelement.c:2347:gst_element_continue_state:<stream_recorder_element_pipeline> committing state from PAUSED to READY, pending NULL, next NULL
0:00:00.688123983 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed PAUSED to READY (NULL pending)
0:00:00.688141869 21738      0x24d5400 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<stream_recorder_element_pipeline> continue state change READY to NULL, final NULL
0:00:00.688170711 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current READY pending VOID_PENDING, desired next NULL
0:00:00.688236234 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to NULL
0:00:00.688255291 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688275289 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 1(NULL) successfully
0:00:00.688289473 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter3> current READY pending VOID_PENDING, desired next NULL
0:00:00.688301446 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter3> completed state change to NULL
0:00:00.688309500 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter3> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688320065 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter3' changed state to 1(NULL) successfully
0:00:00.688330624 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current READY pending VOID_PENDING, desired next NULL
0:00:00.688341317 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to NULL
0:00:00.688349086 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688359125 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 1(NULL) successfully
0:00:00.688368607 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter4> current READY pending VOID_PENDING, desired next NULL
0:00:00.688380768 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter4> completed state change to NULL
0:00:00.688388699 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter4> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688398399 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter4' changed state to 1(NULL) successfully
0:00:00.688407844 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter5> current READY pending VOID_PENDING, desired next NULL
0:00:00.688417928 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter5> completed state change to NULL
0:00:00.688425688 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter5> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688435663 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter5' changed state to 1(NULL) successfully
0:00:00.688445270 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue2> current READY pending VOID_PENDING, desired next NULL
0:00:00.688456674 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue2> completed state change to NULL
0:00:00.688464430 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue2> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688474864 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue2' changed state to 1(NULL) successfully
0:00:00.688484344 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue3> current READY pending VOID_PENDING, desired next NULL
0:00:00.688494389 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue3> completed state change to NULL
0:00:00.688502164 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue3> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688512284 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue3' changed state to 1(NULL) successfully
0:00:00.688521980 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current READY pending VOID_PENDING, desired next NULL
0:00:00.688532277 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to NULL
0:00:00.688540222 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688550227 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 1(NULL) successfully
0:00:00.688559714 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current READY pending VOID_PENDING, desired next NULL
0:00:00.688569941 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to NULL
0:00:00.688577725 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.688587679 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 1(NULL) successfully
0:00:00.701289693 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<audio_jitter_buffer> current READY pending VOID_PENDING, desired next NULL
0:00:00.701320971 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to NULL
0:00:00.701340715 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.701359836 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 1(NULL) successfully
0:00:00.701375792 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_jitter_buffer> current READY pending VOID_PENDING, desired next NULL
0:00:00.701391935 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to NULL
0:00:00.701403939 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.701419472 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 1(NULL) successfully
0:00:00.701434282 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc2> current READY pending VOID_PENDING, desired next NULL
0:00:00.701450141 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc2> completed state change to NULL
0:00:00.701462719 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc2> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.701478025 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc2' changed state to 1(NULL) successfully
0:00:00.701491939 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc3> current READY pending VOID_PENDING, desired next NULL
0:00:00.701507613 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc3> completed state change to NULL
0:00:00.701519521 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc3> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.701534944 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc3' changed state to 1(NULL) successfully
0:00:00.701592336 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<stream_recorder_element_pipeline> completed state change to NULL
0:00:00.701606551 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed READY to NULL (VOID_PENDING pending)
I1120 22:48:06.714041 21738 stream_recorder_element.cc:104] StreamRecorderElement destroy
0:00:00.701760097 21738      0x24d5400 INFO              GST_STATES gstbin.c:1915:gst_bin_get_state_func:<stream_recorder_element_pipeline> getting state
0:00:00.702950793 21738      0x24d5400 INFO                 default gstdebugutils.c:811:gst_debug_bin_to_dot_file: wrote bin graph to : '/home/yong/Develop/orbit/dot/destroy.dot'
0:00:00.702993979 21738      0x26feed0 INFO                 basesrc gstbasesrc.c:2739:gst_base_src_loop:<appsrc1> pausing after gst_base_src_get_range() = eos
0:00:00.703028509 21738      0x26feed0 INFO                    task gsttask.c:328:gst_task_func:<appsrc1:src> Task going to paused
0:00:00.703055831 21738      0x26fef20 INFO                 basesrc gstbasesrc.c:2739:gst_base_src_loop:<appsrc0> pausing after gst_base_src_get_range() = eos
0:00:00.710823648 21738      0x26fef20 INFO                    task gsttask.c:328:gst_task_func:<appsrc0:src> Task going to paused
I1120 22:48:06.723214 21738 stream_recorder_element.cc:109] Send eos ===================
0:00:00.745033387 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 3987467
0:00:00.745070830 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 3987467
0:00:00.745091166 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=3987467, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.745157528 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 4641201
0:00:00.745184915 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 4641201
0:00:00.745203178 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=4641201, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.799869849 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 4641205
0:00:00.799914088 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 4641205
0:00:00.799934559 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=4641205, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.800006843 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5295637
0:00:00.800034269 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5295637
0:00:00.800051649 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5295637, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.853418817 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5295641
0:00:00.853470062 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5295641
0:00:00.853496568 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5295641, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.853584667 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5950406
0:00:00.853609905 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5950406
0:00:00.853624664 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5950406, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.903168919 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 5950410
0:00:00.903193113 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 5950410
0:00:00.903202946 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=5950410, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.903238262 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 6606114
0:00:00.903251869 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 6606114
0:00:00.903259870 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=6606114, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.956868321 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 6606118
0:00:00.956904040 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 6606118
0:00:00.956919636 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=6606118, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:00.956970515 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7260288
0:00:00.956991070 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7260288
0:00:00.957003300 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7260288, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.015539136 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7260292
0:00:01.015572240 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7260292
0:00:01.015593139 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7260292, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.015666347 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7915307
0:00:01.015698632 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7915307
0:00:01.015719992 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7915307, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.022345009 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7915311
0:00:01.022369995 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7915311
0:00:01.022389805 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7915311, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.022448305 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7990013
0:00:01.022485346 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7990013
0:00:01.022506981 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7990013, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.083393995 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 7990017
0:00:01.083428805 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 7990017
0:00:01.083450287 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=7990017, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.083524683 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 8644433
0:00:01.083557070 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 8644433
0:00:01.083578305 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=8644433, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.143795555 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 8644437
0:00:01.143830999 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 8644437
0:00:01.143847778 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=8644437, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.143898994 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9300477
0:00:01.143920927 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9300477
0:00:01.143933452 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9300477, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.207097492 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9300481
0:00:01.207152136 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9300481
0:00:01.207185348 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9300481, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.207292951 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9955463
0:00:01.207329278 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9955463
0:00:01.207355102 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9955463, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.270909441 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 9955467
0:00:01.270945431 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 9955467
0:00:01.270968458 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=9955467, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.271043901 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 10611625
0:00:01.271078107 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 10611625
0:00:01.271100273 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=10611625, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.332912046 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 10611629
0:00:01.332946303 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 10611629
0:00:01.332968105 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=10611629, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.333042788 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11267138
0:00:01.333074168 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11267138
0:00:01.333095402 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11267138, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.381635850 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11267142
0:00:01.381677928 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11267142
0:00:01.381695715 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11267142, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.381756514 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11878122
0:00:01.381779594 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11878122
0:00:01.381794209 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11878122, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.381988803 21738      0x26fed90 INFO                    task gsttask.c:328:gst_task_func:<video_jitter_buffer:src> Task going to paused
0:00:01.384140262 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11878126
0:00:01.384169084 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11878126
0:00:01.384183445 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11878126, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.384233521 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11899178
0:00:01.384254349 21738      0x26fed40 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11899178
0:00:01.384266910 21738      0x26fed40 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11899178, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.384334858 21738      0x26fed40 INFO                    task gsttask.c:328:gst_task_func:<queue1:src> Task going to paused
0:00:01.397132312 21738      0x26fede0 INFO                    task gsttask.c:328:gst_task_func:<audio_jitter_buffer:src> Task going to paused
0:00:01.398254642 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11899182
0:00:01.398289135 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11899182
0:00:01.398314941 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11899182, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398355032 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946764
0:00:01.398397710 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 11946764
0:00:01.398410535 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=11946764, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398447714 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 72
0:00:01.398462496 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 72
0:00:01.398474276 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=72, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398505140 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398519371 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 100
0:00:01.398531410 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 100
0:00:01.398542898 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=100, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398572231 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398585904 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 108
0:00:01.398605042 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398618054 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 156
0:00:01.398629458 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 156
0:00:01.398641138 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=156, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398678036 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398690506 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 164
0:00:01.398707497 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398719329 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398730003 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 211
0:00:01.398741143 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 211
0:00:01.398751765 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=211, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398778676 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398791326 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 32
0:00:01.398802152 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:216:gst_ebml_writer_send_segment_event: seeking to 32
0:00:01.398812784 21738      0x26fee30 INFO               GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=32, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.398838320 21738      0x26fee30 INFO               ebmlwrite ebml-write.c:523:gst_ebml_write_seek: scheduling seek to 11946957
0:00:01.398871235 21738      0x26fee30 INFO                    task gsttask.c:328:gst_task_func:<queue0:src> Task going to paused
I1120 22:48:07.411525 21738 stream_recorder_element.cc:28] Got message=========================================1
0:00:01.399207853 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399234651 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to PAUSED
0:00:01.399244348 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399260395 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 3(PAUSED) successfully
0:00:01.399271813 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399281521 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
0:00:01.399289120 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399299735 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:01.399309823 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399319719 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to PAUSED
0:00:01.399327680 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399338104 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 3(PAUSED) successfully
0:00:01.399347617 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399356920 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter1> completed state change to PAUSED
0:00:01.399364324 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399374042 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter1' changed state to 3(PAUSED) successfully
0:00:01.399384538 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter2> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399394010 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter2> completed state change to PAUSED
0:00:01.399401537 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter2> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399412054 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter2' changed state to 3(PAUSED) successfully
0:00:01.399422033 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399432269 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue0> completed state change to PAUSED
0:00:01.399439809 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399450457 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue0' changed state to 3(PAUSED) successfully
0:00:01.399460301 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399469569 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue1> completed state change to PAUSED
0:00:01.399477360 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399487797 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue1' changed state to 3(PAUSED) successfully
0:00:01.399497888 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399507566 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to PAUSED
0:00:01.399515485 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399525652 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 3(PAUSED) successfully
0:00:01.399535225 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399544968 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to PAUSED
0:00:01.399552469 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399562262 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 3(PAUSED) successfully
0:00:01.399572205 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<audio_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399581874 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to PAUSED
0:00:01.399589285 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399599037 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 3(PAUSED) successfully without preroll
0:00:01.399609090 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_jitter_buffer> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399617902 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to PAUSED
0:00:01.399625224 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399635230 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 3(PAUSED) successfully without preroll
0:00:01.399644665 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399655983 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc0> completed state change to PAUSED
0:00:01.399663552 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399673716 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc0' changed state to 3(PAUSED) successfully without preroll
0:00:01.399683464 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:01.399693645 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc1> completed state change to PAUSED
0:00:01.399701105 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:01.399711037 21738      0x24d5400 INFO              GST_STATES gstbin.c:2807:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc1' changed state to 3(PAUSED) successfully without preroll
0:00:01.399722736 21738      0x24d5400 INFO              GST_STATES gstelement.c:2347:gst_element_continue_state:<stream_recorder_element_pipeline> committing state from PLAYING to PAUSED, pending NULL, next READY
0:00:01.399732101 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed PLAYING to PAUSED (NULL pending)
0:00:01.399741689 21738      0x24d5400 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<stream_recorder_element_pipeline> continue state change PAUSED to READY, final NULL
0:00:01.399758624 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399776724 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to READY
0:00:01.399785397 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399795887 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 2(READY) successfully
0:00:01.399805332 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter0> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399821733 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter0> completed state change to READY
0:00:01.399829770 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399840054 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter0' changed state to 2(READY) successfully
0:00:01.399853359 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399888859 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to READY
0:00:01.399902269 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399928798 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 2(READY) successfully
0:00:01.399943575 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter1> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.399960685 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter1> completed state change to READY
0:00:01.399968574 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.399978288 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter1' changed state to 2(READY) successfully
0:00:01.399997216 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter2> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400023301 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter2> completed state change to READY
0:00:01.400031046 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter2> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400051534 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter2' changed state to 2(READY) successfully
0:00:01.400060137 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue0> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400076619 21738      0x26fee30 INFO                    task gsttask.c:330:gst_task_func:<queue0:src> Task resume from paused
0:00:01.400107628 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue0> completed state change to READY
0:00:01.400117325 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400127471 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue0' changed state to 2(READY) successfully
0:00:01.400136435 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue1> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400174850 21738      0x26fed40 INFO                    task gsttask.c:330:gst_task_func:<queue1:src> Task resume from paused
0:00:01.400207915 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue1> completed state change to READY
0:00:01.400217572 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400239248 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue1' changed state to 2(READY) successfully
0:00:01.400248317 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400263068 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to READY
0:00:01.400270305 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400279551 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 2(READY) successfully
0:00:01.400288151 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current PAUSED pending VOID_PENDING, desired next READY
0:00:01.400302425 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to READY
0:00:01.400309718 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400318655 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 2(READY) successfully
0:00:01.400335701 21738      0x26fede0 INFO                    task gsttask.c:330:gst_task_func:<audio_jitter_buffer:src> Task resume from paused
0:00:01.400430459 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to READY
0:00:01.400454731 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400465853 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 2(READY) successfully
0:00:01.400506351 21738      0x26fed90 INFO                    task gsttask.c:330:gst_task_func:<video_jitter_buffer:src> Task resume from paused
0:00:01.400568485 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to READY
0:00:01.400591025 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400600916 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 2(READY) successfully
0:00:01.400622080 21738      0x26fef20 INFO                    task gsttask.c:330:gst_task_func:<appsrc0:src> Task resume from paused
0:00:01.400644430 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc0> completed state change to READY
0:00:01.400653193 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400662836 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc0' changed state to 2(READY) successfully
0:00:01.400703727 21738      0x26feed0 INFO                    task gsttask.c:330:gst_task_func:<appsrc1:src> Task resume from paused
0:00:01.400735320 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc1> completed state change to READY
0:00:01.400744386 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:01.400774839 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc1' changed state to 2(READY) successfully
0:00:01.400797687 21738      0x24d5400 INFO              GST_STATES gstelement.c:2347:gst_element_continue_state:<stream_recorder_element_pipeline> committing state from PAUSED to READY, pending NULL, next NULL
0:00:01.400806153 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<stream_recorder_element_pipeline> notifying about state-changed PAUSED to READY (NULL pending)
0:00:01.400814683 21738      0x24d5400 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<stream_recorder_element_pipeline> continue state change READY to NULL, final NULL
0:00:01.400829158 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<filesink> current READY pending VOID_PENDING, desired next NULL
0:00:01.402615303 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<filesink> completed state change to NULL
0:00:01.402631823 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<filesink> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402645925 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'filesink' changed state to 1(NULL) successfully
0:00:01.402657530 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next NULL
0:00:01.402668671 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter0> completed state change to NULL
0:00:01.402675986 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402685458 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter0' changed state to 1(NULL) successfully
0:00:01.402695029 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<webmmux> current READY pending VOID_PENDING, desired next NULL
0:00:01.402705014 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<webmmux> completed state change to NULL
0:00:01.402712016 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<webmmux> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402720968 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'webmmux' changed state to 1(NULL) successfully
0:00:01.402729541 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter1> current READY pending VOID_PENDING, desired next NULL
0:00:01.402738613 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter1> completed state change to NULL
0:00:01.402745467 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402754500 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter1' changed state to 1(NULL) successfully
0:00:01.402762707 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<capsfilter2> current READY pending VOID_PENDING, desired next NULL
0:00:01.402771999 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<capsfilter2> completed state change to NULL
0:00:01.402778910 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<capsfilter2> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402787526 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'capsfilter2' changed state to 1(NULL) successfully
0:00:01.402795714 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue0> current READY pending VOID_PENDING, desired next NULL
0:00:01.402805097 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue0> completed state change to NULL
0:00:01.402812191 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402821180 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue0' changed state to 1(NULL) successfully
0:00:01.402829599 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<queue1> current READY pending VOID_PENDING, desired next NULL
0:00:01.402838504 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<queue1> completed state change to NULL
0:00:01.402845189 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<queue1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402854114 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'queue1' changed state to 1(NULL) successfully
0:00:01.402862726 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<opusdepay> current READY pending VOID_PENDING, desired next NULL
0:00:01.402872082 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<opusdepay> completed state change to NULL
0:00:01.402879031 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<opusdepay> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402888117 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'opusdepay' changed state to 1(NULL) successfully
0:00:01.402896988 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_rtp_depay> current READY pending VOID_PENDING, desired next NULL
0:00:01.402906357 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_rtp_depay> completed state change to NULL
0:00:01.402913361 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_rtp_depay> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402922092 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_rtp_depay' changed state to 1(NULL) successfully
0:00:01.402930776 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<audio_jitter_buffer> current READY pending VOID_PENDING, desired next NULL
0:00:01.402939856 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<audio_jitter_buffer> completed state change to NULL
0:00:01.402953861 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<audio_jitter_buffer> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.402965848 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'audio_jitter_buffer' changed state to 1(NULL) successfully
0:00:01.402975447 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<video_jitter_buffer> current READY pending VOID_PENDING, desired next NULL
0:00:01.402984702 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<video_jitter_buffer> completed state change to NULL
0:00:01.402991495 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<video_jitter_buffer> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.403001140 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'video_jitter_buffer' changed state to 1(NULL) successfully
0:00:01.403009675 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc0> current READY pending VOID_PENDING, desired next NULL
0:00:01.403018831 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc0> completed state change to NULL
0:00:01.403025486 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.403034174 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc0' changed state to 1(NULL) successfully
0:00:01.403042283 21738      0x24d5400 INFO              GST_STATES gstbin.c:2316:gst_bin_element_set_state:<appsrc1> current READY pending VOID_PENDING, desired next NULL
0:00:01.403051395 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<appsrc1> completed state change to NULL
0:00:01.403058101 21738      0x24d5400 INFO              GST_STATES gstelement.c:2277:_priv_gst_element_state_changed:<appsrc1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.403066881 21738      0x24d5400 INFO              GST_STATES gstbin.c:2764:gst_bin_change_state_func:<stream_recorder_element_pipeline> child 'appsrc1' changed state to 1(NULL) successfully
0:00:01.403106840 21738      0x24d5400 INFO              GST_STATES gstelement.c:2372:gst_element_continue_state:<stream_recorder_element_pipeline> completed state change to NULL
0:00:01.403115613 21738      0x24d540