TS DEMUXER and WOWZA HLS with AES ENCRYPTION PROBLEM
Nicolas Castillejos
djos06 at gmail.com
Tue Jul 4 09:16:20 UTC 2017
Hello,
I'm contacting you because I think I've found a bug in the gstreamer TS
DEMUXER called tsdemux.
The thing that it makes me think it is a bug is that VLC or hls.js
succeed to read the stream where GStreamer failed.
The HLS Live stream is coming from Wowza Streaming Engine.
When encryption is disabled on Wowza, Gstreamer has no problem to read
the Live stream.
it only fails when it is encrypted.
I've noticed what problem could be make Gstreamer failed, look what I
have tested :
When I download a normal HLS chunk from Wowza, I write it to the disk ,
then I double-click on it and can read it with VLC.
When I download an encrypted chunk from Wowza, and I decrypt it with the
HLS key, then write it to the disk, I double-click on it and VLC failed
to read it, the displayed error is :
ts error: libdvbpsi error (misc PSI): Bad CRC_32 table 0x0 !!!
In GStreamer log, i can see the same kind of error :
0:00:19.623514731 6948 1558FFA0 WARN mpegts
gstmpegtssection.c:161:__common_section_checks: PID:0x0000
table_id:0x00, Bad CRC on section
The fact that crc table seems to be bad or not set certainly makes TS
DEMUXER failed.
VLC or hls.js seems to manage this kind of case, i don't know how but
they succeed to read it even if the crc is bad.
I've put the gstreamer logs in attachement.
Do you know this bug, is there a way to bypass this crc check ?
Does somebody will correct it ?
Thank you.
Cordially,
Nicolas Castillejos
-------------- next part --------------
0:00:00.002329029 6948 15016080 INFO GST_INIT gstmessage.c:127:_priv_gst_message_initialize: init messages
0:00:00.002810101 6948 15016080 INFO GST_INIT gstcontext.c:84:_priv_gst_context_initialize: init contexts
0:00:00.013360008 6948 15016080 INFO GST_PLUGIN_LOADING gstplugin.c:317:_priv_gst_plugin_initialize: registering 0 static plugins
0:00:00.013481559 6948 15016080 INFO GST_PLUGIN_LOADING gstplugin.c:225:gst_plugin_register_static: registered static plugin "staticelements"
0:00:00.013517479 6948 15016080 INFO GST_PLUGIN_LOADING gstplugin.c:227:gst_plugin_register_static: added static plugin "staticelements", result: 1
0:00:00.032200388 6948 15016080 INFO GST_REGISTRY gstregistry.c:1721:ensure_current_registry: reading registry cache: C:\Users\CASTILNI\AppData\Local\Microsoft\Windows\Temporary Internet Files\gstreamer-1.0\registry.i686.bin
0:00:00.045491442 6948 15016080 INFO GST_REGISTRY gstregistrybinary.c:621:priv_gst_registry_binary_read_cache: loaded C:\Users\CASTILNI\AppData\Local\Microsoft\Windows\Temporary Internet Files\gstreamer-1.0\registry.i686.bin in 0.010000 seconds
0:00:00.045636726 6948 15016080 INFO GST_REGISTRY gstregistry.c:1577:scan_and_update_registry: Validating plugins from registry cache: C:\Users\CASTILNI\AppData\Local\Microsoft\Windows\Temporary Internet Files\gstreamer-1.0\registry.i686.bin
0:00:00.085346325 6948 15016080 INFO GST_REGISTRY gstregistry.c:1679:scan_and_update_registry: Registry cache has not changed
0:00:00.085391225 6948 15016080 INFO GST_REGISTRY gstregistry.c:1756:ensure_current_registry: registry reading and updating done, result = 1
0:00:00.085420731 6948 15016080 INFO GST_INIT gst.c:727:init_post: GLib runtime version: 2.50.3
0:00:00.085448312 6948 15016080 INFO GST_INIT gst.c:729:init_post: GLib headers version: 2.50.3
0:00:00.085474611 6948 15016080 INFO GST_INIT gst.c:730:init_post: initialized GStreamer successfully
0:00:00.397279121 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstapp.dll" loaded
0:00:00.397334605 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "appsink" named "GstVideoComponent"
0:00:00.397503622 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSink at 150BC590> adding pad 'sink'
0:00:00.487688247 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "appsink" named "GstVideoComponent"
0:00:00.487782217 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSink at 150BED50> adding pad 'sink'
0:00:00.509952255 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "appsrc" named "source"
0:00:00.510132497 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSrc at 150BB870> adding pad 'src'
0:00:00.554105997 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "bin" named "Video Bin"
0:00:00.562582484 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstmpegtsdemux.dll" loaded
0:00:00.562635402 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "tsdemux" named "tsdemux"
0:00:00.562788383 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<MpegTSBase at 155B7D78> adding pad 'sink'
0:00:00.564679957 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstvideoparsersbad.dll" loaded
0:00:00.564727102 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "h264parse" named "h264parse"
0:00:00.564820110 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseParse at 155C5650> adding pad 'sink'
0:00:00.564865330 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseParse at 155C5650> adding pad 'src'
0:00:00.564901571 6948 15590060 INFO baseparse gstbaseparse.c:3942:gst_base_parse_set_pts_interpolation:<GstH264Parse at 155C5650> PTS interpolation: no
0:00:00.579374459 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_avs
0:00:00.579502424 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_daud
0:00:00.579568491 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_ea
0:00:00.579621730 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_ffm
0:00:00.579676893 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_4xm
0:00:00.579732697 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_gxf
0:00:00.579785936 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_idcin
0:00:00.579841419 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_ipmovie
0:00:00.579914542 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_mm
0:00:00.579965536 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_mmf
0:00:00.580047639 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_nsv
0:00:00.580095105 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_nut
0:00:00.580184905 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_film_cpk
0:00:00.580243916 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_smk
0:00:00.580298117 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_sol
0:00:00.580438590 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_psxstr
0:00:00.580512034 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_vmd
0:00:00.580570724 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_wc3movie
0:00:00.580619794 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_wsaud
0:00:00.580666939 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_wsvqa
0:00:00.580724347 6948 15590060 INFO GST_TYPEFIND gsttypefind.c:72:gst_type_find_register: registering typefind function for avtype_yuv4mpegpipe
0:00:00.581090282 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstlibav.dll" loaded
0:00:00.581130692 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "avdec_h264" named "H264 Decoder"
0:00:00.581296822 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstVideoDecoder at 155F5DB0> adding pad 'sink'
0:00:00.581339157 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstVideoDecoder at 155F5DB0> adding pad 'src'
0:00:00.583165626 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstvideoconvert.dll" loaded
0:00:00.583207319 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "videoconvert" named "videoconvert"
0:00:00.583434385 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 15622838> adding pad 'sink'
0:00:00.583477682 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 15622838> adding pad 'src'
0:00:00.584910955 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstvideorate.dll" loaded
0:00:00.584967722 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "videorate" named "videorate"
0:00:00.585057201 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 1562B628> adding pad 'sink'
0:00:00.585099215 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 1562B628> adding pad 'src'
0:00:00.587407077 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstcoreelements.dll" loaded
0:00:00.587450373 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "capsfilter" named "capsfilter"
0:00:00.587733564 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 15622B88> adding pad 'sink'
0:00:00.587775257 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 15622B88> adding pad 'src'
0:00:00.590084402 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.605884728 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element h264parse:(any) to element H264 Decoder:(any)
0:00:00.605959775 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link h264parse:src and H264 Decoder:sink
0:00:00.606012372 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<H264 Decoder:src> pad has no peer
0:00:00.606066894 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: h264parse and H264 Decoder in same bin, no need for ghost pads
0:00:00.606238156 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link h264parse:src and H264 Decoder:sink
0:00:00.606280169 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<H264 Decoder:src> pad has no peer
0:00:00.606322824 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked h264parse:src and H264 Decoder:sink, successful
0:00:00.606354254 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.606383439 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<h264parse:src> Received event on flushing pad. Discarding
0:00:00.606469070 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element H264 Decoder:(any) to element videoconvert:(any)
0:00:00.606507556 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link H264 Decoder:src and videoconvert:sink
0:00:00.606549890 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<videoconvert:src> pad has no peer
0:00:00.607233974 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: H264 Decoder and videoconvert in same bin, no need for ghost pads
0:00:00.607270857 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link H264 Decoder:src and videoconvert:sink
0:00:00.607305494 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<videoconvert:src> pad has no peer
0:00:00.607965204 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked H264 Decoder:src and videoconvert:sink, successful
0:00:00.607997275 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.608025819 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<H264 Decoder:src> Received event on flushing pad. Discarding
0:00:00.608087075 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element videoconvert:(any) to element videorate:(any)
0:00:00.608122033 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link videoconvert:src and videorate:sink
0:00:00.608797779 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<videorate:src> pad has no peer
0:00:00.608846207 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: videoconvert and videorate in same bin, no need for ghost pads
0:00:00.608878599 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link videoconvert:src and videorate:sink
0:00:00.609544082 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<videorate:src> pad has no peer
0:00:00.609588982 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked videoconvert:src and videorate:sink, successful
0:00:00.609619129 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.609647031 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<videoconvert:src> Received event on flushing pad. Discarding
0:00:00.609705080 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element videorate:(any) to element capsfilter:(any)
0:00:00.609739718 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link videorate:src and capsfilter:sink
0:00:00.612447832 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<capsfilter:src> pad has no peer
0:00:00.612495939 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: videorate and capsfilter in same bin, no need for ghost pads
0:00:00.612530576 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link videorate:src and capsfilter:sink
0:00:00.615384936 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<capsfilter:src> pad has no peer
0:00:00.615441061 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked videorate:src and capsfilter:sink, successful
0:00:00.615474095 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.615503280 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<videorate:src> Received event on flushing pad. Discarding
0:00:00.615579610 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element capsfilter:(any) to element GstVideoComponent:(any)
0:00:00.615615851 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link capsfilter:src and GstVideoComponent:sink
0:00:00.618182850 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: capsfilter and GstVideoComponent in same bin, no need for ghost pads
0:00:00.618224864 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link capsfilter:src and GstVideoComponent:sink
0:00:00.620909887 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked capsfilter:src and GstVideoComponent:sink, successful
0:00:00.620952542 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.620983651 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<capsfilter:src> Received event on flushing pad. Discarding
0:00:00.621113540 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad h264parse:sink
0:00:00.629331211 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link sink:proxypad0 and h264parse:sink
0:00:00.629383166 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked sink:proxypad0 and h264parse:sink, successful
0:00:00.629414917 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.629985789 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<Video Bin> adding pad 'sink'
0:00:00.637390769 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "pipeline" named "main pipeline"
0:00:00.646017350 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "queue" named "input_buffer"
0:00:00.646158464 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstQueue at 156320D8> adding pad 'sink'
0:00:00.646206572 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstQueue at 156320D8> adding pad 'src'
0:00:00.648953492 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element source:(any) to element tsdemux:(any)
0:00:00.648999675 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link source:src and tsdemux:sink
0:00:00.649039764 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: source and tsdemux in same bin, no need for ghost pads
0:00:00.649080174 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link source:src and tsdemux:sink
0:00:00.649115453 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked source:src and tsdemux:sink, successful
0:00:00.649146562 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.649177030 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<source:src> Received event on flushing pad. Discarding
0:00:00.649236362 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element tsdemux:(any) to element input_buffer:(any)
0:00:00.649277414 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<input_buffer:src> pad has no peer
0:00:00.649318465 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:915:gst_element_get_static_pad: no such pad 'video_%01x_%05x' in element "tsdemux"
0:00:00.649355348 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1201:gst_element_get_compatible_pad:<tsdemux> Could not find a compatible pad to link to input_buffer:sink
0:00:00.649417566 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "bin" named "Audio Bin"
0:00:00.649876830 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "queue" named "queue"
0:00:00.649934558 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstQueue at 15632330> adding pad 'sink'
0:00:00.649976892 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstQueue at 15632330> adding pad 'src'
0:00:00.651471743 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstaudioparsers.dll" loaded
0:00:00.651523058 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "aacparse" named "aacparse"
0:00:00.651604198 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseParse at 15646728> adding pad 'sink'
0:00:00.651644608 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseParse at 15646728> adding pad 'src'
0:00:00.653412387 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstfaad.dll" loaded
0:00:00.653454401 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "faad" named "faad"
0:00:00.653546767 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstAudioDecoder at 15647340> adding pad 'sink'
0:00:00.653589742 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstAudioDecoder at 15647340> adding pad 'src'
0:00:00.654873563 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstautodetect.dll" loaded
0:00:00.654915577 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "autoaudiosink" named "autoaudiosink"
0:00:00.654996717 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<autoaudiosink> adding pad 'sink'
0:00:00.655031996 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "fakesink" named "fake-audio-sink"
0:00:00.655109288 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSink at 15647858> adding pad 'sink'
0:00:00.655156754 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad fake-audio-sink:sink
0:00:00.655190750 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link sink:proxypad1 and fake-audio-sink:sink
0:00:00.655223463 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked sink:proxypad1 and fake-audio-sink:sink, successful
0:00:00.655254572 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.658214447 6948 15590060 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstvolume.dll" loaded
0:00:00.658257744 6948 15590060 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "volume" named "volume"
0:00:00.658353958 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 156492F0> adding pad 'sink'
0:00:00.658404631 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform at 156492F0> adding pad 'src'
0:00:00.662127807 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element queue:(any) to element aacparse:(any)
0:00:00.662179121 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link queue:src and aacparse:sink
0:00:00.662218248 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<queue:sink> pad has no peer
0:00:00.662254810 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<aacparse:src> pad has no peer
0:00:00.662285919 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: queue and aacparse in same bin, no need for ghost pads
0:00:00.662320235 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link queue:src and aacparse:sink
0:00:00.662353910 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<queue:sink> pad has no peer
0:00:00.662385661 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<aacparse:src> pad has no peer
0:00:00.662415808 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked queue:src and aacparse:sink, successful
0:00:00.662445635 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.662474178 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<queue:src> Received event on flushing pad. Discarding
0:00:00.662504967 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element aacparse:(any) to element faad:(any)
0:00:00.662536076 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link aacparse:src and faad:sink
0:00:00.662571034 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<faad:src> pad has no peer
0:00:00.662617538 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: aacparse and faad in same bin, no need for ghost pads
0:00:00.662650251 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link aacparse:src and faad:sink
0:00:00.662684246 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<faad:src> pad has no peer
0:00:00.662721770 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked aacparse:src and faad:sink, successful
0:00:00.662752238 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.662780461 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<aacparse:src> Received event on flushing pad. Discarding
0:00:00.662810929 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element faad:(any) to element volume:(any)
0:00:00.662841397 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link faad:src and volume:sink
0:00:00.662875392 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<volume:src> pad has no peer
0:00:00.662912275 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: faad and volume in same bin, no need for ghost pads
0:00:00.662944667 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link faad:src and volume:sink
0:00:00.662977700 6948 15590060 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<volume:src> pad has no peer
0:00:00.663011696 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked faad:src and volume:sink, successful
0:00:00.663050823 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.663079688 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<faad:src> Received event on flushing pad. Discarding
0:00:00.663110476 6948 15590060 INFO GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element volume:(any) to element autoaudiosink:(any)
0:00:00.663141265 6948 15590060 INFO GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link volume:src and autoaudiosink:sink
0:00:00.663189372 6948 15590060 INFO GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: volume and autoaudiosink in same bin, no need for ghost pads
0:00:00.663222406 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link volume:src and autoaudiosink:sink
0:00:00.663265061 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked volume:src and autoaudiosink:sink, successful
0:00:00.663295529 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.663323751 6948 15590060 INFO GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<volume:src> Received event on flushing pad. Discarding
0:00:00.663390139 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad queue:sink
0:00:00.663770507 6948 15590060 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link sink:proxypad2 and queue:sink
0:00:00.663807710 6948 15590060 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked sink:proxypad2 and queue:sink, successful
0:00:00.663836895 6948 15590060 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.664150874 6948 15590060 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<Audio Bin> adding pad 'sink'
0:00:07.352478178 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Audio Bin> current NULL pending VOID_PENDING, desired next READY
0:00:07.352547452 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<autoaudiosink> current NULL pending VOID_PENDING, desired next READY
0:00:07.352584655 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<fake-audio-sink> completed state change to NULL
0:00:07.352619613 6948 155AE980 INFO GST_ELEMENT_PADS gstpad.c:2072:gst_pad_unlink: unlinking sink:proxypad1(155B21C8) and fake-audio-sink:sink(155AFD40)
0:00:07.352656495 6948 155AE980 INFO GST_ELEMENT_PADS gstpad.c:2126:gst_pad_unlink: unlinked sink:proxypad1 and fake-audio-sink:sink
0:00:07.352687925 6948 155AE980 INFO GST_PARENTAGE gstbin.c:1792:gst_bin_remove_func:<autoaudiosink> removed child "fake-audio-sink"
0:00:07.352729939 6948 155AE980 INFO GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<fake-audio-sink> 15647858 dispose
0:00:07.352760086 6948 155AE980 INFO GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<fake-audio-sink> removing pad 'sink'
0:00:07.352795364 6948 155AE980 INFO GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<fake-audio-sink> 15647858 parent class dispose
0:00:07.352826474 6948 155AE980 INFO GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<fake-audio-sink> 15647858 finalize
0:00:07.352855338 6948 155AE980 INFO GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<fake-audio-sink> 15647858 finalize parent
0:00:07.355493216 6948 155AE980 INFO GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "C:\Workspace_Shaft_Maven_SVN\Shaft_Maven\annex\Shaft_CS_Mosaic\dll_1_12\lib\gstreamer-1.0\libgstdirectsoundsink.dll" loaded
0:00:07.355540040 6948 155AE980 INFO GST_ELEMENT_FACTORY gstelementfactory.c:359:gst_element_factory_create: creating element "directsoundsink" named "autoaudiosink-actual-sink-directsound"
0:00:07.355702963 6948 155AE980 INFO GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSink at 15651280> adding pad 'sink'
0:00:07.355755560 6948 155AE980 INFO GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad autoaudiosink-actual-sink-directsound:sink
0:00:07.364158283 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<autoaudiosink-actual-sink-directsound> completed state change to READY
0:00:07.364217936 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<autoaudiosink-actual-sink-directsound> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.365256410 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<autoaudiosink-actual-sink-directsound> completed state change to NULL
0:00:07.365302593 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<autoaudiosink-actual-sink-directsound> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:07.365374112 6948 155AE980 INFO GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad autoaudiosink-actual-sink-directsound:sink
0:00:07.365409391 6948 155AE980 INFO GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link sink:proxypad1 and autoaudiosink-actual-sink-directsound:sink
0:00:07.365441141 6948 155AE980 INFO GST_PADS gstpad.c:2524:gst_pad_link_full: linked sink:proxypad1 and autoaudiosink-actual-sink-directsound:sink, successful
0:00:07.365470647 6948 155AE980 INFO GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:07.365510416 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<autoaudiosink-actual-sink-directsound> current NULL pending VOID_PENDING, desired next READY
0:00:07.370132875 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<autoaudiosink-actual-sink-directsound> completed state change to READY
0:00:07.370178096 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<autoaudiosink-actual-sink-directsound> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.386701633 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<autoaudiosink> child 'autoaudiosink-actual-sink-directsound' changed state to 2(READY) successfully
0:00:07.386765135 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<autoaudiosink> completed state change to READY
0:00:07.386797206 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<autoaudiosink> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.387113431 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'autoaudiosink' changed state to 2(READY) successfully
0:00:07.387159934 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<volume> current NULL pending VOID_PENDING, desired next READY
0:00:07.387192006 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<volume> completed state change to READY
0:00:07.387219587 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<volume> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.387454030 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'volume' changed state to 2(READY) successfully
0:00:07.387494119 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<faad> current NULL pending VOID_PENDING, desired next READY
0:00:07.387530680 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<faad> completed state change to READY
0:00:07.387558903 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<faad> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.387782441 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'faad' changed state to 2(READY) successfully
0:00:07.387822210 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<aacparse> current NULL pending VOID_PENDING, desired next READY
0:00:07.387852678 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<aacparse> completed state change to READY
0:00:07.387880580 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<aacparse> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.388099307 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'aacparse' changed state to 2(READY) successfully
0:00:07.388138114 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<queue> current NULL pending VOID_PENDING, desired next READY
0:00:07.388167940 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<queue> completed state change to READY
0:00:07.388195842 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<queue> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.388431568 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'queue' changed state to 2(READY) successfully
0:00:07.388471657 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<Audio Bin> completed state change to READY
0:00:07.388508860 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<Audio Bin> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.388733360 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'Audio Bin' changed state to 2(READY) successfully
0:00:07.388771525 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Video Bin> current NULL pending VOID_PENDING, desired next READY
0:00:07.388813218 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<GstVideoComponent> current NULL pending VOID_PENDING, desired next READY
0:00:07.388844969 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<GstVideoComponent> completed state change to READY
0:00:07.388873192 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<GstVideoComponent> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.389314174 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'GstVideoComponent' changed state to 2(READY) successfully
0:00:07.389357150 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter> current NULL pending VOID_PENDING, desired next READY
0:00:07.389388580 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter> completed state change to READY
0:00:07.389417765 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.389639058 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'capsfilter' changed state to 2(READY) successfully
0:00:07.389679147 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<videorate> current NULL pending VOID_PENDING, desired next READY
0:00:07.389714747 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<videorate> completed state change to READY
0:00:07.389743932 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<videorate> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.389999541 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'videorate' changed state to 2(READY) successfully
0:00:07.390040593 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<videoconvert> current NULL pending VOID_PENDING, desired next READY
0:00:07.390070740 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<videoconvert> completed state change to READY
0:00:07.390098642 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<videoconvert> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.392732030 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'videoconvert' changed state to 2(READY) successfully
0:00:07.392779175 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<H264 Decoder> current NULL pending VOID_PENDING, desired next READY
0:00:07.392810926 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<H264 Decoder> completed state change to READY
0:00:07.392841073 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<H264 Decoder> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.393062366 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'H264 Decoder' changed state to 2(READY) successfully
0:00:07.393100852 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<h264parse> current NULL pending VOID_PENDING, desired next READY
0:00:07.393130678 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<h264parse> completed state change to READY
0:00:07.393158580 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<h264parse> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.393363838 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'h264parse' changed state to 2(READY) successfully
0:00:07.393402323 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<Video Bin> completed state change to READY
0:00:07.393430867 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<Video Bin> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.393636124 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'Video Bin' changed state to 2(READY) successfully
0:00:07.393674931 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<input_buffer> current NULL pending VOID_PENDING, desired next READY
0:00:07.393704757 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<input_buffer> completed state change to READY
0:00:07.393734263 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<input_buffer> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.393960687 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'input_buffer' changed state to 2(READY) successfully
0:00:07.393999815 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<tsdemux> current NULL pending VOID_PENDING, desired next READY
0:00:07.394034452 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<tsdemux> completed state change to READY
0:00:07.394062354 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<tsdemux> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.394590250 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'tsdemux' changed state to 2(READY) successfully
0:00:07.394630660 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<source> current NULL pending VOID_PENDING, desired next READY
0:00:07.394660487 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<source> completed state change to READY
0:00:07.394688710 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<source> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:07.394928604 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'source' changed state to 2(READY) successfully
0:00:07.394997878 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<main pipeline> completed state change to READY
0:00:07.395029950 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<main pipeline> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:19.592801176 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Audio Bin> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.592872695 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<autoaudiosink> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.592912785 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<autoaudiosink-actual-sink-directsound> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.592965061 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<autoaudiosink> child 'autoaudiosink-actual-sink-directsound' is changing state asynchronously to PAUSED
0:00:19.593004830 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<Audio Bin> child 'autoaudiosink' is changing state asynchronously to PAUSED
0:00:19.593038184 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<volume> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.593072500 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<volume> completed state change to PAUSED
0:00:19.593102006 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<volume> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.593404119 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'volume' changed state to 3(PAUSED) successfully
0:00:19.593446454 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<faad> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.593485260 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<faad> completed state change to PAUSED
0:00:19.593515407 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<faad> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.593756585 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'faad' changed state to 3(PAUSED) successfully
0:00:19.593798919 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<aacparse> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.593900585 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<aacparse> completed state change to PAUSED
0:00:19.593936506 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<aacparse> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.594160685 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'aacparse' changed state to 3(PAUSED) successfully
0:00:19.594200454 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<queue> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.594242147 6948 155AE980 INFO task gsttask.c:457:gst_task_set_lock: setting stream lock 155AF6FC on task 1563E040
0:00:19.594275180 6948 155AE980 INFO GST_PADS gstpad.c:6001:gst_pad_start_task:<queue:src> created task 1563E040
0:00:19.594593970 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<queue> completed state change to PAUSED
0:00:19.594631815 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<queue> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.594868502 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Audio Bin> child 'queue' changed state to 3(PAUSED) successfully
0:00:19.594916609 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Audio Bin' is changing state asynchronously to PAUSED
0:00:19.594949964 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Video Bin> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.594990374 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<GstVideoComponent> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.595028218 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<Video Bin> child 'GstVideoComponent' is changing state asynchronously to PAUSED
0:00:19.595061252 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.595095568 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter> completed state change to PAUSED
0:00:19.595125395 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.595401851 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'capsfilter' changed state to 3(PAUSED) successfully
0:00:19.595442581 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<videorate> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.595477860 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<videorate> completed state change to PAUSED
0:00:19.595507366 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<videorate> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.595708454 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'videorate' changed state to 3(PAUSED) successfully
0:00:19.595747902 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<videoconvert> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.595782218 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<videoconvert> completed state change to PAUSED
0:00:19.595812045 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<videoconvert> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.596013453 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'videoconvert' changed state to 3(PAUSED) successfully
0:00:19.596055146 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<H264 Decoder> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.596113196 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<H264 Decoder> completed state change to PAUSED
0:00:19.596144626 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<H264 Decoder> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.596344751 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'H264 Decoder' changed state to 3(PAUSED) successfully
0:00:19.596383879 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<h264parse> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.596442569 6948 155AE980 INFO GST_PADS gstpad.c:4115:gst_pad_peer_query:<Video Bin:sink> pad has no peer
0:00:19.596550650 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<h264parse> completed state change to PAUSED
0:00:19.596583363 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<h264parse> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.596785093 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<Video Bin> child 'h264parse' changed state to 3(PAUSED) successfully
0:00:19.596826786 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Video Bin' is changing state asynchronously to PAUSED
0:00:19.596859819 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<input_buffer> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.596899908 6948 155AE980 INFO task gsttask.c:457:gst_task_set_lock: setting stream lock 155AF45C on task 1563E0E8
0:00:19.596932301 6948 155AE980 INFO GST_PADS gstpad.c:6001:gst_pad_start_task:<input_buffer:src> created task 1563E0E8
0:00:19.597617668 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<input_buffer> completed state change to PAUSED
0:00:19.597663530 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<input_buffer> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.597896048 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'input_buffer' changed state to 3(PAUSED) successfully
0:00:19.597943193 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<tsdemux> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.597996111 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<tsdemux> completed state change to PAUSED
0:00:19.598027541 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<tsdemux> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.598234402 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'tsdemux' changed state to 3(PAUSED) successfully
0:00:19.598273529 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<source> current READY pending VOID_PENDING, desired next PAUSED
0:00:19.598311373 6948 155AE980 INFO basesrc gstbasesrc.c:1331:gst_base_src_do_seek:<source> seeking: 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
0:00:19.598363650 6948 155AE980 INFO task gsttask.c:457:gst_task_set_lock: setting stream lock 155A6314 on task 1563E190
0:00:19.598404701 6948 155AE980 INFO GST_PADS gstpad.c:6001:gst_pad_start_task:<source:src> created task 1563E190
0:00:19.598714191 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<source> completed state change to PAUSED
0:00:19.598751394 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<source> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:19.598967235 6948 155AE980 INFO GST_STATES gstbin.c:2982:gst_bin_change_state_func:<main pipeline> child 'source' changed state to 3(PAUSED) successfully without preroll
0:00:19.599009248 6948 155AE980 INFO GST_STATES gstelement.c:2442:gst_element_continue_state:<main pipeline> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:19.599041641 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<main pipeline> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:19.599246898 6948 155AE980 INFO GST_STATES gstelement.c:2449:gst_element_continue_state:<main pipeline> continue state change PAUSED to PLAYING, final PLAYING
0:00:19.599870688 6948 155AE980 INFO GST_EVENT gstevent.c:1383:gst_event_new_latency: creating latency event 0:00:00.000000000
0:00:19.599934189 6948 155AE980 INFO bin gstbin.c:2768:gst_bin_do_latency_func:<main pipeline> configured latency of 0:00:00.000000000
0:00:19.599975241 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Audio Bin> current READY pending PAUSED, desired next PLAYING
0:00:19.600007633 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Audio Bin' is changing state asynchronously to PLAYING
0:00:19.600038422 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Video Bin> current READY pending PAUSED, desired next PLAYING
0:00:19.600068569 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Video Bin' is changing state asynchronously to PLAYING
0:00:19.600099999 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<input_buffer> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:19.600131429 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<input_buffer> completed state change to PLAYING
0:00:19.600160293 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<input_buffer> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:19.600362343 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'input_buffer' changed state to 4(PLAYING) successfully
0:00:19.600402112 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<tsdemux> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:19.600433863 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<tsdemux> completed state change to PLAYING
0:00:19.600463048 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<tsdemux> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:19.600661570 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'tsdemux' changed state to 4(PLAYING) successfully
0:00:19.600701659 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<source> completed state change to PLAYING
0:00:19.600731486 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<source> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:19.600935781 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'source' changed state to 4(PLAYING) successfully
0:00:19.601672142 6948 1558FFA0 INFO GST_ELEMENT_PADS gstelement.c:915:gst_element_get_static_pad: no such pad 'sink' in element "source"
0:00:19.601730191 6948 1558FFA0 FIXME default gstutils.c:3902:gst_pad_create_stream_id_internal:<source:src> Creating random stream-id, consider implementing a deterministic way of creating a stream-id
0:00:19.607563028 6948 155AE980 INFO GST_STATES gstbin.c:2080:gst_bin_get_state_func:<main pipeline> getting state
0:00:19.607613700 6948 155AE980 INFO GST_STATES gstelement.c:2185:gst_element_get_state_func:<main pipeline> waiting for element to commit state
0:00:19.611267602 6948 1558FFA0 INFO GST_EVENT gstevent.c:890: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
0:00:19.611350988 6948 1558FFA0 INFO basesrc gstbasesrc.c:2836:gst_base_src_loop:<source> marking pending DISCONT
0:00:19.623445777 6948 1558FFA0 INFO mpegtspacketizer mpegtspacketizer.c:769:mpegts_try_discover_packet_size: have packetsize detected: 188 bytes
0:00:19.623514731 6948 1558FFA0 WARN mpegts gstmpegtssection.c:161:__common_section_checks: PID:0x0000 table_id:0x00, Bad CRC on section
0:00:20.604789167 6948 155AE980 INFO GST_STATES gstelement.c:2199:gst_element_get_state_func:<main pipeline> timed out
0:00:20.607561424 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Audio Bin> current READY pending PAUSED, desired next PAUSED
0:00:20.607617870 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Audio Bin' is changing state asynchronously to PAUSED
0:00:20.607653790 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Video Bin> current READY pending PAUSED, desired next PAUSED
0:00:20.607685220 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Video Bin' is changing state asynchronously to PAUSED
0:00:20.607717612 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<input_buffer> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:20.607749042 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<input_buffer> completed state change to PAUSED
0:00:20.607778227 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<input_buffer> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:20.608106960 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'input_buffer' changed state to 3(PAUSED) successfully
0:00:20.608153142 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<tsdemux> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:20.608186497 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<tsdemux> completed state change to PAUSED
0:00:20.608216323 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<tsdemux> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:20.608363852 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'tsdemux' changed state to 3(PAUSED) successfully
0:00:20.608403621 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<source> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:22.251901757 6948 1558FFA0 INFO basesrc gstbasesrc.c:2732:gst_base_src_loop:<source> pausing after gst_base_src_get_range() = flushing
0:00:22.251988992 6948 1558FFA0 INFO task gsttask.c:319:gst_task_func:<source:src> Task going to paused
0:00:22.252032609 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<source> completed state change to PAUSED
0:00:22.252088413 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<source> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:22.252321894 6948 155AE980 INFO GST_STATES gstbin.c:2982:gst_bin_change_state_func:<main pipeline> child 'source' changed state to 3(PAUSED) successfully without preroll
0:00:22.252370963 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<main pipeline> completed state change to PAUSED
0:00:22.252401110 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<main pipeline> notifying about state-changed PAUSED to PAUSED (VOID_PENDING pending)
0:00:22.254635849 6948 155AE980 INFO GST_EVENT gstevent.c:1383:gst_event_new_latency: creating latency event 0:00:00.000000000
0:00:22.254703520 6948 155AE980 INFO bin gstbin.c:2768:gst_bin_do_latency_func:<main pipeline> configured latency of 0:00:00.000000000
0:00:22.254747779 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Audio Bin> current READY pending PAUSED, desired next PLAYING
0:00:22.254780812 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Audio Bin' is changing state asynchronously to PLAYING
0:00:22.254813525 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<Video Bin> current READY pending PAUSED, desired next PLAYING
0:00:22.254843993 6948 155AE980 INFO GST_STATES gstbin.c:2945:gst_bin_change_state_func:<main pipeline> child 'Video Bin' is changing state asynchronously to PLAYING
0:00:22.254875102 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<input_buffer> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:22.254906212 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<input_buffer> completed state change to PLAYING
0:00:22.254935076 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<input_buffer> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:22.255084529 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'input_buffer' changed state to 4(PLAYING) successfully
0:00:22.255125581 6948 155AE980 INFO GST_STATES gstbin.c:2491:gst_bin_element_set_state:<tsdemux> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:22.255157652 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<tsdemux> completed state change to PLAYING
0:00:22.255186837 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<tsdemux> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:22.255315764 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'tsdemux' changed state to 4(PLAYING) successfully
0:00:22.255359061 6948 155AE980 INFO GST_STATES gstelement.c:2467:gst_element_continue_state:<source> completed state change to PLAYING
0:00:22.255389208 6948 155AE980 INFO GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<source> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:22.255564960 6948 155AE980 INFO GST_STATES gstbin.c:2939:gst_bin_change_state_func:<main pipeline> child 'source' changed state to 4(PLAYING) successfully
0:00:22.256164054 6948 1558FFA0 INFO task gsttask.c:321:gst_task_func:<source:src> Task resume from paused
More information about the gstreamer-devel
mailing list