0:00:13.457225106 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 271 with ts: 0:00:09.177435361, duration 99:99:99.999999999
0:00:13.457658915 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 271 bytes consumed, 4096 samples decoded
0:00:13.457719680 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=404725, ts=0:00:09.177435361
0:00:13.502131277 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 314 with ts: 0:00:09.223875270, duration 99:99:99.999999999
0:00:13.502550139 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 314 bytes consumed, 4096 samples decoded
0:00:13.502610206 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=406773, ts=0:00:09.223875270
0:00:13.564863635 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 265 with ts: 0:00:09.270315179, duration 99:99:99.999999999
0:00:13.565255117 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 265 bytes consumed, 4096 samples decoded
0:00:13.565304568 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=408821, ts=0:00:09.270315179
0:00:13.575812089 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audio-sink-actual-sink-alsa> completed state change to PAUSED
0:00:13.575886055 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audio-sink-actual-sink-alsa> posting state-changed PLAYING to PAUSED
0:00:13.575966586 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<audio-sink> child 'audio-sink-actual-sink-alsa' changed state to 3(PAUSED) successfully
0:00:13.575995223 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audio-sink> completed state change to PAUSED
0:00:13.576011148 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audio-sink> posting state-changed PLAYING to PAUSED
0:00:13.576037968 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<audiosinkbin> child 'audio-sink' changed state to 3(PAUSED) successfully
0:00:13.576064300 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audiofilter> completed state change to PAUSED
0:00:13.576079177 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audiofilter> posting state-changed PLAYING to PAUSED
0:00:13.576104880 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<audiosinkbin> child 'audiofilter' changed state to 3(PAUSED) successfully
0:00:13.576123878 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audiosinkbin> completed state change to PAUSED
0:00:13.576138126 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audiosinkbin> posting state-changed PLAYING to PAUSED
0:00:13.576163969 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'audiosinkbin' changed state to 3(PAUSED) successfully
0:00:13.576191278 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<volume> completed state change to PAUSED
0:00:13.576206295 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<volume> posting state-changed PLAYING to PAUSED
0:00:13.576231020 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'volume' changed state to 3(PAUSED) successfully
0:00:13.576255606 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<aresample> completed state change to PAUSED
0:00:13.576270483 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<aresample> posting state-changed PLAYING to PAUSED
0:00:13.576294649 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'aresample' changed state to 3(PAUSED) successfully
0:00:13.576316721 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<aconv> completed state change to PAUSED
0:00:13.576331528 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<aconv> posting state-changed PLAYING to PAUSED
0:00:13.576459484 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'aconv' changed state to 3(PAUSED) successfully
0:00:13.576480158 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<abin> completed state change to PAUSED
0:00:13.576494058 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<abin> posting state-changed PLAYING to PAUSED
0:00:13.576516548 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'abin' changed state to 3(PAUSED) successfully
0:00:13.576539806 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<preroll_audio_src0> completed state change to PAUSED
0:00:13.576554264 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<preroll_audio_src0> posting state-changed PLAYING to PAUSED
0:00:13.576577383 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'preroll_audio_src0' changed state to 3(PAUSED) successfully
0:00:13.576598965 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<selector_audio_src0> completed state change to PAUSED
0:00:13.576613563 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<selector_audio_src0> posting state-changed PLAYING to PAUSED
0:00:13.576636332 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'selector_audio_src0' changed state to 3(PAUSED) successfully
0:00:13.576682011 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<faad0> completed state change to PAUSED
0:00:13.576696469 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<faad0> posting state-changed PLAYING to PAUSED
0:00:13.576720566 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<decodebin0> child 'faad0' changed state to 3(PAUSED) successfully
0:00:13.576746688 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpmp4adepay0> completed state change to PAUSED
0:00:13.576761076 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpmp4adepay0> posting state-changed PLAYING to PAUSED
0:00:13.576784684 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<decodebin0> child 'rtpmp4adepay0' changed state to 3(PAUSED) successfully
0:00:13.576804660 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<typefind> completed state change to PAUSED
0:00:13.576834693 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<typefind> posting state-changed PLAYING to PAUSED
0:00:13.576859767 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<decodebin0> child 'typefind' changed state to 3(PAUSED) successfully
0:00:13.576878486 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<decodebin0> completed state change to PAUSED
0:00:13.692098578 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<decodebin0> posting state-changed PLAYING to PAUSED
0:00:13.692161788 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'decodebin0' changed state to 3(PAUSED) successfully
0:00:13.692231633 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpptdemux0> completed state change to PAUSED
0:00:13.692248885 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpptdemux0> posting state-changed PLAYING to PAUSED
0:00:13.692278429 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<rtpbin1> child 'rtpptdemux0' changed state to 3(PAUSED) successfully
0:00:13.692302316 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpjitterbuffer0> completed state change to PAUSED
0:00:13.692317054 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpjitterbuffer0> posting state-changed PLAYING to PAUSED
0:00:13.692342338 22329  0x80a2490 INFO              GST_STATES gstbin.c:2472:gst_bin_change_state_func:<rtpbin1> child 'rtpjitterbuffer0' changed state to 3(PAUSED) successfully without preroll
0:00:13.692365387 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpssrcdemux1> completed state change to PAUSED
0:00:13.692380054 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpssrcdemux1> posting state-changed PLAYING to PAUSED
0:00:13.692405268 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<rtpbin1> child 'rtpssrcdemux1' changed state to 3(PAUSED) successfully
0:00:13.692427689 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpsession1> completed state change to PAUSED
0:00:13.692441797 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpsession1> posting state-changed PLAYING to PAUSED
0:00:13.692466872 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<rtpbin1> child 'rtpsession1' changed state to 3(PAUSED) successfully
0:00:13.692486289 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpbin1> completed state change to PAUSED
0:00:13.692500397 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpbin1> posting state-changed PLAYING to PAUSED
0:00:13.692523935 22329  0x80a2490 INFO              GST_STATES gstbin.c:2472:gst_bin_change_state_func:<source> child 'rtpbin1' changed state to 3(PAUSED) successfully without preroll
0:00:13.596221362 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 270 with ts: 0:00:09.316755088, duration 99:99:99.999999999
0:00:13.692943845 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 270 bytes consumed, 4096 samples decoded
0:00:13.694918720 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=410869, ts=0:00:09.316755088
0:00:13.761497037 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<source> completed state change to PAUSED
0:00:13.761558850 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<source> posting state-changed PLAYING to PAUSED
0:00:13.761642385 22329  0x80a2490 INFO              GST_STATES gstbin.c:2472:gst_bin_change_state_func:<play> child 'source' changed state to 3(PAUSED) successfully without preroll
0:00:13.761680171 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<play> completed state change to PAUSED
0:00:13.761696096 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<play> posting state-changed PLAYING to PAUSED
0:00:13.762936198 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:13.763490560 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query






0:00:18.299554165 22329  0x80a2490 INFO              GST_STATES gstbin.c:1695:gst_bin_get_state_func:<play> getting state
0:00:18.300092602 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing latency query
0:00:18.300262815 22329  0x80a2490 INFO               GST_EVENT gstevent.c:1067:gst_event_new_latency: creating latency event 0:00:02.213151927
0:00:18.300381831 22329  0x80a2490 INFO                GST_PADS gstpad.c:3426:gst_pad_event_default_dispatch:<selector_audio_src0:src> Sending event 0x8706678 (latency) to all internally linked pads
0:00:18.300453911 22329  0x80a2490 LOG                     faad gstfaad.c:613:gst_faad_src_event:<faad0> Handling latency event
0:00:18.300495330 22329  0x80a2490 INFO                GST_PADS gstpad.c:3426:gst_pad_event_default_dispatch:<rtpmp4adepay0:src> Sending event 0x8706678 (latency) to all internally linked pads
0:00:18.300551625 22329  0x80a2490 INFO                GST_PADS gstpad.c:3426:gst_pad_event_default_dispatch:<rtpptdemux0:src_96> Sending event 0x8706678 (latency) to all internally linked pads
0:00:18.300606593 22329  0x80a2490 INFO                GST_PADS gstpad.c:3426:gst_pad_event_default_dispatch:<rtpssrcdemux1:src_683558317> Sending event 0x8706678 (latency) to all internally linked pads
0:00:18.300656393 22329  0x80a2490 INFO                GST_PADS gstpad.c:3426:gst_pad_event_default_dispatch:<rtpsession1:recv_rtp_src> Sending event 0x8706678 (latency) to all internally linked pads
0:00:18.300757948 22329  0x80a2490 INFO                     bin gstbin.c:2304:gst_bin_do_latency_func:<play> configured latency of 0:00:02.213151927
0:00:18.300952467 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audio-sink-actual-sink-alsa> completed state change to PLAYING
0:00:18.300996888 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audio-sink-actual-sink-alsa> posting state-changed PAUSED to PLAYING
0:00:18.301069807 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<audio-sink> child 'audio-sink-actual-sink-alsa' changed state to 4(PLAYING) successfully
0:00:18.301168289 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audio-sink> completed state change to PLAYING
0:00:18.305188163 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audio-sink> posting state-changed PAUSED to PLAYING
0:00:18.305347410 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<audiosinkbin> child 'audio-sink' changed state to 4(PLAYING) successfully
0:00:18.305481373 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audiofilter> completed state change to PLAYING
0:00:18.305594732 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audiofilter> posting state-changed PAUSED to PLAYING
0:00:18.305738054 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<audiosinkbin> child 'audiofilter' changed state to 4(PLAYING) successfully
0:00:18.305878793 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<audiosinkbin> completed state change to PLAYING
0:00:18.305993199 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<audiosinkbin> posting state-changed PAUSED to PLAYING
0:00:18.306060111 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'audiosinkbin' changed state to 4(PLAYING) successfully
0:00:18.306113263 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<volume> completed state change to PLAYING
0:00:18.306147487 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<volume> posting state-changed PAUSED to PLAYING
0:00:18.306205459 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'volume' changed state to 4(PLAYING) successfully
0:00:18.306253582 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<aresample> completed state change to PLAYING
0:00:18.306286899 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<aresample> posting state-changed PAUSED to PLAYING
0:00:18.306342425 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'aresample' changed state to 4(PLAYING) successfully
0:00:18.306406474 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<aconv> completed state change to PLAYING
0:00:18.306441047 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<aconv> posting state-changed PAUSED to PLAYING
0:00:18.306496784 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<abin> child 'aconv' changed state to 4(PLAYING) successfully
0:00:18.306540437 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<abin> completed state change to PLAYING
0:00:18.306572775 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<abin> posting state-changed PAUSED to PLAYING
0:00:18.306625648 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'abin' changed state to 4(PLAYING) successfully
0:00:18.306673492 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<preroll_audio_src0> completed state change to PLAYING
0:00:18.306706669 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<preroll_audio_src0> posting state-changed PAUSED to PLAYING
0:00:18.306761218 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'preroll_audio_src0' changed state to 4(PLAYING) successfully
0:00:18.306809481 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<selector_audio_src0> completed state change to PLAYING
0:00:18.306842587 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<selector_audio_src0> posting state-changed PAUSED to PLAYING
0:00:18.306896368 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'selector_audio_src0' changed state to 4(PLAYING) successfully
0:00:18.306978227 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<faad0> completed state change to PLAYING
0:00:18.319272669 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<faad0> posting state-changed PAUSED to PLAYING
0:00:18.319384142 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<decodebin0> child 'faad0' changed state to 4(PLAYING) successfully
0:00:18.319459714 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpmp4adepay0> completed state change to PLAYING
0:00:18.319498409 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpmp4adepay0> posting state-changed PAUSED to PLAYING
0:00:18.319557917 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<decodebin0> child 'rtpmp4adepay0' changed state to 4(PLAYING) successfully
0:00:18.319614561 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<typefind> completed state change to PLAYING
0:00:18.319649833 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<typefind> posting state-changed PAUSED to PLAYING
0:00:18.319723660 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<decodebin0> child 'typefind' changed state to 4(PLAYING) successfully
0:00:18.319771504 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<decodebin0> completed state change to PLAYING
0:00:18.319805239 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<decodebin0> posting state-changed PAUSED to PLAYING
0:00:18.319946536 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'decodebin0' changed state to 4(PLAYING) successfully
0:00:18.320100126 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpptdemux0> completed state change to PLAYING
0:00:18.320143779 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpptdemux0> posting state-changed PAUSED to PLAYING
0:00:18.320229758 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<rtpbin1> child 'rtpptdemux0' changed state to 4(PLAYING) successfully
0:00:18.320371544 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 276 with ts: 0:00:09.363194998, duration 99:99:99.999999999
0:00:18.321274294 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpjitterbuffer0> completed state change to PLAYING
0:00:18.321321300 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 276 bytes consumed, 4096 samples decoded
0:00:18.321411959 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpjitterbuffer0> posting state-changed PAUSED to PLAYING
0:00:18.321543338 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=412917, ts=0:00:09.363194998
0:00:18.321731152 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 263 with ts: 0:00:09.409634907, duration 99:99:99.999999999
0:00:18.321726961 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<rtpbin1> child 'rtpjitterbuffer0' changed state to 4(PLAYING) successfully
0:00:18.321854499 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpssrcdemux1> completed state change to PLAYING
0:00:18.321895638 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpssrcdemux1> posting state-changed PAUSED to PLAYING
0:00:18.321962899 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<rtpbin1> child 'rtpssrcdemux1' changed state to 4(PLAYING) successfully
0:00:18.322067317 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpsession1> completed state change to PLAYING
0:00:18.322105592 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpsession1> posting state-changed PAUSED to PLAYING
0:00:18.322169012 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<rtpbin1> child 'rtpsession1' changed state to 4(PLAYING) successfully
0:00:18.322215878 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<rtpbin1> completed state change to PLAYING
0:00:18.322250172 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<rtpbin1> posting state-changed PAUSED to PLAYING
0:00:18.322308214 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<source> child 'rtpbin1' changed state to 4(PLAYING) successfully
0:00:18.322614764 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 263 bytes consumed, 4096 samples decoded
0:00:18.322710103 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=414965, ts=0:00:09.409634907
0:00:18.348306714 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<source> completed state change to PLAYING
0:00:18.348589797 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<source> posting state-changed PAUSED to PLAYING
0:00:18.348778379 22329  0x80a2490 INFO              GST_STATES gstbin.c:2428:gst_bin_change_state_func:<play> child 'source' changed state to 4(PLAYING) successfully
0:00:18.348927708 22329  0x80a2490 INFO              GST_STATES gstelement.c:2221:gst_element_continue_state:<play> completed state change to PLAYING
0:00:18.349043372 22329  0x80a2490 INFO              GST_STATES gstelement.c:2234:gst_element_continue_state:<play> posting state-changed PAUSED to PLAYING
0:00:18.552964219 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:18.754074213 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:18.953595367 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:19.153107441 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:19.353980660 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:19.553989194 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:19.753970140 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:19.954122136 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:20.153971633 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:20.352987666 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:20.553962999 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:20.753038121 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:20.953963793 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:21.153102405 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:21.353063095 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:21.553125480 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:21.757015246 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:21.957069599 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:22.157141483 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:22.357139401 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:22.557098205 22329  0x80a2490 LOG                     faad gstfaad.c:764:gst_faad_src_query:<faad0> processing duration query
0:00:22.604940112 22329  0x8727a40 WARN      gstrtpjitterbuffer gstrtpjitterbuffer.c:1726:gst_rtp_jitter_buffer_loop:<rtpjitterbuffer0> Packet #87 lost
0:00:22.605448516 22329  0x8727a40 INFO                typefind gsttypefindelement.c:169:gst_type_find_element_have_type:<typefind> found caps application/x-rtp, media=(string)audio, payload=(int)96, clock-rate=(int)22050, encoding-name=(string)MP4A-LATM, encoding-params=(string)2, object=(string)2, cpresent=(string)0, profile-level-id=(string)15, config=(string)400027103FC0, sbr-enabled=(string)1, a-SdpplinVersion=(string)1610641560, a-StreamCount=(string)"integer\;1", a-maxprate=(string)16.000000, a-length=(string)"npt\=30.138000", a-mimetype=(string)"string\;\"audio/MP4A-LATM\"", a-3GPP-Adaptation-Support=(string)1, a-Helix-Adaptation-Support=(string)1, a-AvgBitRate=(string)"integer\;48000", a-MaxBitRate=(string)"integer\;48000", a-HasOutOfOrderTS=(string)"integer\;1", a-Preroll=(string)"integer\;1000", a-OpaqueData=(string)"buffer\;\"A4CAgCUAAAAEgICAF0AVAAMAAAC7gAAAu4AFgICABROIVuWgBoCAgAEC\"", a-StreamName=(string)"string\;\"Audio\ Track\"", a-ASMRuleBook=(string)"string\;\"Marker\=0\,AverageBandwidth\=48000\,TimeStampDelivery\=TRUE\,InterDepend\=1\;Marker\=1\,AverageBandwidth\=0\,TimeStampDelivery\=TRUE\,InterDepend\=0\;\"", clock-base=(uint)190209, seqnum-base=(uint)88, npt-start=(guint64)4086999893, npt-stop=(guint64)30138000488, play-speed=(double)1, play-scale=(double)1, probability=100
0:00:22.606064621 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 271 with ts: 0:00:14.042061211, duration 99:99:99.999999999
0:00:22.606942157 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 271 bytes consumed, 0 samples decoded
0:00:22.607044061 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 284 with ts: 0:00:14.088501120, duration 99:99:99.999999999
0:00:22.607884719 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 284 bytes consumed, 4096 samples decoded
0:00:22.608023641 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=621303, ts=0:00:14.088501120
0:00:22.608150061 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 323 with ts: 0:00:14.134941029, duration 99:99:99.999999999
0:00:22.609089200 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 323 bytes consumed, 4096 samples decoded
0:00:22.609189987 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=623351, ts=0:00:14.134941029
0:00:22.609302857 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 272 with ts: 0:00:14.181380939, duration 99:99:99.999999999
0:00:22.610136600 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 272 bytes consumed, 4096 samples decoded
0:00:22.610234313 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=625399, ts=0:00:14.181380939
0:00:22.610344529 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 259 with ts: 0:00:14.227820848, duration 99:99:99.999999999
0:00:22.611199714 22329  0x8727a40 LOG                     faad gstfaad.c:1151:gst_faad_chain:<faad0> 259 bytes consumed, 4096 samples decoded
0:00:22.611295751 22329  0x8727a40 LOG                     faad gstfaad.c:1197:gst_faad_chain:<faad0> pushing buffer, off=627447, ts=0:00:14.227820848
0:00:22.611403942 22329  0x8727a40 LOG                     faad gstfaad.c:1036:gst_faad_chain:<faad0> buffer of size 264 with ts: 0:00:14.274260757, duration 99:99:99.999999999

