corebird-gifv-log.txt

0:00:57.457553567 10590      0x24c8630 LOG      GST_ELEMENT_FACTORY gstelementfactory.c:439:gst_element_factory_make: gstelementfactory: make "playbin" "video"
0:00:57.457603093 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playbin> 0x2552540 ref 1->2
0:00:57.457617663 10590      0x24c8630 LOG      GST_ELEMENT_FACTORY gstelementfactory.c:445:gst_element_factory_make:<playbin> found factory 0x2552540
0:00:57.457627757 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstpluginfeature.c:106:gst_plugin_feature_load: loading plugin for feature 0x2552540; 'playbin'
0:00:57.457637427 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstpluginfeature.c:110:gst_plugin_feature_load: loading plugin playback
0:00:57.457645591 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstplugin.c:1252:gst_plugin_load_by_name: looking up plugin playback in default registry
0:00:57.457660985 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<plugin51> 0x254d400 ref 1->2
0:00:57.457670938 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<plugin51> 0x254d400 ref 2->3
0:00:57.457689070 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<plugin51> 0x254d400 unref 3->2
0:00:57.457698380 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstplugin.c:1255:gst_plugin_load_by_name: loading plugin playback from file /usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstplayback.so
0:00:57.457707704 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<plugin51> 0x254d400 ref 2->3
0:00:57.457715955 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstplugin.c:707:gst_plugin_load_file: attempt to load plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstplayback.so"
0:00:57.468296371 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:808:gst_plugin_load_file: Plugin 0x254d400 for file "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstplayback.so" prepared, calling entry function...
0:00:57.468342818 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:815:gst_plugin_load_file: Plugin 0x254d400 for file "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstplayback.so" prepared, registering...
0:00:57.468940861 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:504:gst_plugin_register_func: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstplayback.so" looks good
0:00:57.468991182 10590      0x24c8630 DEBUG                default pbutils.c:100:gst_pb_utils_init: binding text domain gst-plugins-base-1.0 to locale dir /usr/share/locale
0:00:57.469026925 10590      0x24c8630 DEBUG                default gstplayback.c:44:plugin_init: binding text domain gst-plugins-base-1.0 to locale dir /usr/share/locale
0:00:57.469112457 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playbin> 0x2552540 ref 2->3
0:00:57.469133911 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:225:gst_element_register:<registry0> update existing feature 0x2552540 (playbin)
0:00:57.469150319 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playbin> 0x2552540 unref 3->2
0:00:57.469188042 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x2552620 ref 1->2
0:00:57.469205671 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:225:gst_element_register:<registry0> update existing feature 0x2552620 (playsink)
0:00:57.469221751 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playsink> 0x2552620 unref 2->1
0:00:57.469244774 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<subtitleoverlay> 0x2553820 ref 1->2
0:00:57.469261748 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:225:gst_element_register:<registry0> update existing feature 0x2553820 (subtitleoverlay)
0:00:57.469277678 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<subtitleoverlay> 0x2553820 unref 2->1
0:00:57.469407360 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<streamsynchronizer> 0x2553900 ref 1->2
0:00:57.469425601 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:225:gst_element_register:<registry0> update existing feature 0x2553900 (streamsynchronizer)
0:00:57.469441946 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<streamsynchronizer> 0x2553900 unref 2->1
0:00:57.469463121 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<decodebin> 0x25539e0 ref 1->2
0:00:57.469478755 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:225:gst_element_register:<registry0> update existing feature 0x25539e0 (decodebin)
0:00:57.469493757 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<decodebin> 0x25539e0 unref 2->1
0:00:57.469512993 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin> 0x2553ac0 ref 1->2
0:00:57.469527581 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:225:gst_element_register:<registry0> update existing feature 0x2553ac0 (uridecodebin)
0:00:57.469541753 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin> 0x2553ac0 unref 2->1
0:00:57.469554465 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:531:gst_plugin_register_func: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstplayback.so" initialised
0:00:57.469569242 10590      0x24c8630 INFO      GST_PLUGIN_LOADING gstplugin.c:833:gst_plugin_load_file: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstplayback.so" loaded
0:00:57.469583158 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<plugin51> 0x254d400 unref 3->2
0:00:57.469596106 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstpluginfeature.c:115:gst_plugin_feature_load: loaded plugin playback
0:00:57.469618967 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<plugin51> 0x254d400 unref 2->1
0:00:57.469628938 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playbin> 0x2552540 ref 2->3
0:00:57.469643967 10590      0x24c8630 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:362:gst_element_factory_create: creating element "playbin" named "video"
0:00:57.469672727 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x3442720
0:00:57.469693688 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x24c9b40 -> 0x3442720
0:00:57.469713413 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:275:gst_element_base_class_init: type GstPlayBin : factory 0x2552540
0:00:57.470004436 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x39fbc40> 0x39fbc40 new
0:00:57.470034873 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x3b094c0> 0x3b094c0 new
0:00:57.470062643 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<GstBus@0x3b094c0> 0x3b094c0 ref_sink 1->2
0:00:57.470080295 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:227:gst_bus_init:<GstBus@0x3b094c0> created
0:00:57.470104206 10590      0x24c8630 DEBUG                    bin gstbin.c:498:gst_bin_init:<GstBin@0x39fbc40> using bus <bus0> to listen to children
0:00:57.470119098 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x3b095a0> 0x3b095a0 new
0:00:57.470133278 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<GstBus@0x3b095a0> 0x3b095a0 ref_sink 1->2
0:00:57.470148623 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:227:gst_bus_init:<GstBus@0x3b095a0> created
0:00:57.470166091 10590      0x24c8630 DEBUG               GST_POLL gstpoll.c:557:gst_poll_new: 0x31748a0: new controllable : 1
0:00:57.470200409 10590      0x24c8630 DEBUG               GST_POLL gstpoll.c:726:gst_poll_add_fd_unlocked: 0x31748a0: fd (fd:21, idx:0)
0:00:57.470212495 10590      0x24c8630 DEBUG               GST_POLL gstpoll.c:893:gst_poll_fd_ctl_read_unlocked: 0x31748a0: fd (fd:21, idx:0), active : 1
0:00:57.470230656 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:281:gst_bus_new:<bus1> created new bus
0:00:57.470244869 10590      0x24c8630 DEBUG          GST_PARENTAGE gstelement.c:2965:gst_element_set_bus_func:<GstPipeline@0x39fbc40> setting bus to 0x3b095a0
0:00:57.470260879 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with 0x3b095a0 bus1 (1)
0:00:57.470279004 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 1->2
0:00:57.470293450 10590      0x24c8630 DEBUG               pipeline gstpipeline.c:217:gst_pipeline_init:<GstPipeline@0x39fbc40> set bus <bus1> on pipeline
0:00:57.470308257 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 2->1
0:00:57.470331067 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c112240
0:00:57.470344820 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x24c1060 -> 0x7f246c112240
0:00:57.470362161 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:275:gst_element_base_class_init: type GstPlaySink : factory 0x2552620
0:00:57.470419454 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3af5540
0:00:57.470432827 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726c0110 from string ANY
0:00:57.470446883 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af5540 ref 1->2
0:00:57.470480864 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af5540 ref 2->3
0:00:57.470496599 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2703ad0> 0x2703ad0 new
0:00:57.470518215 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af5540 ref 3->4
0:00:57.470533820 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af5540 ref 4->5
0:00:57.470548047 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af5540 unref 5->4
0:00:57.470566374 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af5540 unref 4->3
0:00:57.470581699 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af5540 unref 3->2
0:00:57.470596452 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<audio_raw_sink> 0x2703ad0 ref_sink 1->2
0:00:57.470612306 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x316e940
0:00:57.470624815 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726c01d0 from string ANY
0:00:57.470637396 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x316e940 ref 1->2
0:00:57.470651986 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x316e940 ref 2->3
0:00:57.470668691 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2703b60> 0x2703b60 new
0:00:57.470685372 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x316e940 ref 3->4
0:00:57.470700528 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x316e940 ref 4->5
0:00:57.470714870 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x316e940 unref 5->4
0:00:57.470733147 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x316e940 unref 4->3
0:00:57.470748400 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x316e940 unref 3->2
0:00:57.470762701 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<audio_sink> 0x2703b60 ref_sink 1->2
0:00:57.470777937 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3b5b4a0
0:00:57.470790143 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726c00d0 from string ANY
0:00:57.470802764 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5b4a0 ref 1->2
0:00:57.470817018 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5b4a0 ref 2->3
0:00:57.470833251 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2703bf0> 0x2703bf0 new
0:00:57.470849501 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5b4a0 ref 3->4
0:00:57.470864537 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5b4a0 ref 4->5
0:00:57.470878261 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b5b4a0 unref 5->4
0:00:57.470893498 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b5b4a0 unref 4->3
0:00:57.470908245 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b5b4a0 unref 3->2
0:00:57.470922482 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<video_raw_sink> 0x2703bf0 ref_sink 1->2
0:00:57.470938231 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3b5ce80
0:00:57.470950482 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726c0190 from string ANY
0:00:57.470963192 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5ce80 ref 1->2
0:00:57.470977515 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5ce80 ref 2->3
0:00:57.470993700 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2703c80> 0x2703c80 new
0:00:57.471010160 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5ce80 ref 3->4
0:00:57.471024602 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3b5ce80 ref 4->5
0:00:57.471038543 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b5ce80 unref 5->4
0:00:57.471053883 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b5ce80 unref 4->3
0:00:57.471068632 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b5ce80 unref 3->2
0:00:57.471092913 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<video_sink> 0x2703c80 ref_sink 1->2
0:00:57.471107491 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3af55e0
0:00:57.471119996 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726c0150 from string ANY
0:00:57.471133266 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af55e0 ref 1->2
0:00:57.471148298 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af55e0 ref 2->3
0:00:57.471167923 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2703d10> 0x2703d10 new
0:00:57.471186545 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af55e0 ref 3->4
0:00:57.471203141 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af55e0 ref 4->5
0:00:57.471218022 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af55e0 unref 5->4
0:00:57.471234352 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af55e0 unref 4->3
0:00:57.471250280 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af55e0 unref 3->2
0:00:57.471265693 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<text_sink> 0x2703d10 ref_sink 1->2
0:00:57.471287049 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x3250040
0:00:57.471300414 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x24c8580 -> 0x3250040
0:00:57.471316047 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:275:gst_element_base_class_init: type GstStreamSynchronizer : factory 0x2553900
0:00:57.471333833 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3af54a0
0:00:57.471347217 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726c0390 from string ANY
0:00:57.471360810 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af54a0 ref 1->2
0:00:57.471376913 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af54a0 ref 2->3
0:00:57.471393926 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2703da0> 0x2703da0 new
0:00:57.471411752 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af54a0 ref 3->4
0:00:57.471427188 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af54a0 ref 4->5
0:00:57.471442014 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af54a0 unref 5->4
0:00:57.471458608 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af54a0 unref 4->3
0:00:57.471474366 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af54a0 unref 3->2
0:00:57.471489771 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<src_%u> 0x2703da0 ref_sink 1->2
0:00:57.471507006 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3ad6770
0:00:57.471520034 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726c0350 from string ANY
0:00:57.471533777 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3ad6770 ref 1->2
0:00:57.471548983 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3ad6770 ref 2->3
0:00:57.471566450 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2703e30> 0x2703e30 new
0:00:57.471583453 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3ad6770 ref 3->4
0:00:57.471599961 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3ad6770 ref 4->5
0:00:57.471615193 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3ad6770 unref 5->4
0:00:57.471634223 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3ad6770 unref 4->3
0:00:57.471650456 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3ad6770 unref 3->2
0:00:57.471665631 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<sink_%u> 0x2703e30 ref_sink 1->2
0:00:57.471779831 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x25c4040> 0x25c4040 new
0:00:57.471796986 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x3b09680> 0x3b09680 new
0:00:57.471813409 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<GstBus@0x3b09680> 0x3b09680 ref_sink 1->2
0:00:57.471830384 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:227:gst_bus_init:<GstBus@0x3b09680> created
0:00:57.471849300 10590      0x24c8630 DEBUG                    bin gstbin.c:498:gst_bin_init:<GstBin@0x25c4040> using bus <bus2> to listen to children
0:00:57.471867753 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2579a10> 0x2579a10 new
0:00:57.471889629 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1301:gst_bin_add: adding element streamsynchronizer0 to bin (NULL)
0:00:57.471906865 10590      0x24c8630 DEBUG                    bin gstbin.c:1101:gst_bin_add_func:<GstPlaySink@0x25c4040> element :streamsynchronizer0
0:00:57.471921432 10590      0x24c8630 DEBUG        GST_REFCOUNTING gstobject.c:692:gst_object_set_parent:<streamsynchronizer0> set parent (ref and sink)
0:00:57.471934731 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<streamsynchronizer0> 0x2579a10 ref_sink 1->2
0:00:57.471959591 10590      0x24c8630 DEBUG          GST_PARENTAGE gstelement.c:2965:gst_element_set_bus_func:<streamsynchronizer0> setting bus to 0x3b09680
0:00:57.471981976 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with 0x3b09680 bus2 (1)
0:00:57.472011957 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus2> 0x3b09680 ref 1->2
0:00:57.472042000 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:462:gst_element_set_base_time:<streamsynchronizer0> set base_time=0:00:00.000000000, old 0:00:00.000000000
0:00:57.472079636 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:524:gst_element_set_start_time:<streamsynchronizer0> set start_time=0:00:00.000000000, old 0:00:00.000000000
0:00:57.472113532 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:405:gst_element_set_clock:<streamsynchronizer0> setting clock (nil)
0:00:57.472139492 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with (nil) (NONE) (0)
0:00:57.472171046 10590      0x24c8630 DEBUG                    bin gstbin.c:1189:gst_bin_add_func:<GstPlaySink@0x25c4040> added SUCCESS element
0:00:57.472220153 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1226:gst_bin_add_func:<GstPlaySink@0x25c4040> added element "streamsynchronizer0"
0:00:57.472286323 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1301:gst_bin_add: adding element playsink to bin (NULL)
0:00:57.472325394 10590      0x24c8630 DEBUG                    bin gstbin.c:1101:gst_bin_add_func:<GstPlayBin@0x39fbc40> element :playsink
0:00:57.472350007 10590      0x24c8630 DEBUG        GST_REFCOUNTING gstobject.c:692:gst_object_set_parent:<playsink> set parent (ref and sink)
0:00:57.472375098 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<playsink> 0x25c4040 ref_sink 1->2
0:00:57.472402070 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1135:gst_bin_add_func:<GstPlayBin@0x39fbc40> element "playsink" was sink
0:00:57.472428630 10590      0x24c8630 DEBUG          GST_PARENTAGE gstelement.c:2965:gst_element_set_bus_func:<playsink> setting bus to 0x3b094c0
0:00:57.472456260 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with 0x3b094c0 bus0 (1)
0:00:57.472493148 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 1->2
0:00:57.472520794 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:462:gst_element_set_base_time:<playsink> set base_time=0:00:00.000000000, old 0:00:00.000000000
0:00:57.472560226 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:524:gst_element_set_start_time:<playsink> set start_time=0:00:00.000000000, old 0:00:00.000000000
0:00:57.472596157 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:405:gst_element_set_clock:<playsink> setting clock (nil)
0:00:57.472639988 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:405:gst_element_set_clock:<streamsynchronizer0> setting clock (nil)
0:00:57.472661274 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with (nil) (NONE) (0)
0:00:57.472807536 10590      0x24c8630 DEBUG                    bin gstbin.c:724:gst_bin_set_clock_func:<playsink> iterator done
0:00:57.472857120 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with (nil) (NONE) (0)
0:00:57.472929437 10590      0x24c8630 DEBUG                    bin gstbin.c:1189:gst_bin_add_func:<GstPlayBin@0x39fbc40> added SUCCESS element
0:00:57.472990959 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1226:gst_bin_add_func:<GstPlayBin@0x39fbc40> added element "playsink"
0:00:57.473123952 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playbin> 0x2552540 unref 3->2
0:00:57.473179571 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:390:gst_element_factory_create: created element "playbin"
0:00:57.473233195 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playbin> 0x2552540 unref 2->1
0:00:57.473280701 10590      0x24c8630 LOG      GST_ELEMENT_FACTORY gstelementfactory.c:439:gst_element_factory_make: gstelementfactory: make "xvimagesink" "sink"
0:00:57.473343530 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<xvimagesink> 0x24f99c0 ref 1->2
0:00:57.473398249 10590      0x24c8630 LOG      GST_ELEMENT_FACTORY gstelementfactory.c:445:gst_element_factory_make:<xvimagesink> found factory 0x24f99c0
0:00:57.473440654 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstpluginfeature.c:106:gst_plugin_feature_load: loading plugin for feature 0x24f99c0; 'xvimagesink'
0:00:57.473484464 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstpluginfeature.c:110:gst_plugin_feature_load: loading plugin xvimagesink
0:00:57.473526642 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstplugin.c:1252:gst_plugin_load_by_name: looking up plugin xvimagesink in default registry
0:00:57.473601505 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<plugin21> 0x24f1b80 ref 1->2
0:00:57.473648478 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<plugin21> 0x24f1b80 ref 2->3
0:00:57.473692820 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<plugin21> 0x24f1b80 unref 3->2
0:00:57.473741806 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstplugin.c:1255:gst_plugin_load_by_name: loading plugin xvimagesink from file /usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstxvimagesink.so
0:00:57.473797026 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<plugin21> 0x24f1b80 ref 2->3
0:00:57.473846134 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstplugin.c:707:gst_plugin_load_file: attempt to load plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstxvimagesink.so"
0:00:57.477532571 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:808:gst_plugin_load_file: Plugin 0x24f1b80 for file "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstxvimagesink.so" prepared, calling entry function...
0:00:57.477597249 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:815:gst_plugin_load_file: Plugin 0x24f1b80 for file "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstxvimagesink.so" prepared, registering...
0:00:57.477626730 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:504:gst_plugin_register_func: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstxvimagesink.so" looks good
0:00:57.478359960 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<xvimagesink> 0x24f99c0 ref 2->3
0:00:57.478382472 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:225:gst_element_register:<registry0> update existing feature 0x24f99c0 (xvimagesink)
0:00:57.478396177 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<xvimagesink> 0x24f99c0 unref 3->2
0:00:57.478417929 10590      0x24c8630 LOG       GST_PLUGIN_LOADING gstplugin.c:531:gst_plugin_register_func: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstxvimagesink.so" initialised
0:00:57.478431456 10590      0x24c8630 INFO      GST_PLUGIN_LOADING gstplugin.c:833:gst_plugin_load_file: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstxvimagesink.so" loaded
0:00:57.478446659 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<plugin21> 0x24f1b80 unref 3->2
0:00:57.478460804 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstpluginfeature.c:115:gst_plugin_feature_load: loaded plugin xvimagesink
0:00:57.478473550 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<plugin21> 0x24f1b80 unref 2->1
0:00:57.478490071 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<xvimagesink> 0x24f99c0 ref 2->3
0:00:57.478504108 10590      0x24c8630 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:362:gst_element_factory_create: creating element "xvimagesink" named "sink"
0:00:57.478523929 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x32d6f60
0:00:57.478537292 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x24c8580 -> 0x32d6f60
0:00:57.478552414 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:275:gst_element_base_class_init: type GstBaseSink : factory (nil)
0:00:57.478609803 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x316aae0
0:00:57.478621404 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x32d6f60 -> 0x316aae0
0:00:57.478635195 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:275:gst_element_base_class_init: type GstVideoSink : factory (nil)
0:00:57.478662614 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f247418a160
0:00:57.478673956 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x316aae0 -> 0x7f247418a160
0:00:57.478688427 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:275:gst_element_base_class_init: type GstXvImageSink : factory 0x24f99c0
0:00:57.478740610 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3af05e0
0:00:57.478755225 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c11c8e0
0:00:57.478768348 10590      0x24c8630 DEBUG              structure gststructure.c:2186:gst_structure_parse_field: trying field name 'framerate'
0:00:57.478781218 10590      0x24c8630 DEBUG              structure gststructure.c:2237:gst_structure_parse_value: trying type name 'fraction'
0:00:57.478805431 10590      0x24c8630 DEBUG              structure gststructure.c:2186:gst_structure_parse_field: trying field name 'width'
0:00:57.478816169 10590      0x24c8630 DEBUG              structure gststructure.c:2237:gst_structure_parse_value: trying type name 'int'
0:00:57.478832936 10590      0x24c8630 DEBUG              structure gststructure.c:2186:gst_structure_parse_field: trying field name 'height'
0:00:57.478843906 10590      0x24c8630 DEBUG              structure gststructure.c:2237:gst_structure_parse_value: trying type name 'int'
0:00:57.478856556 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f247128b690 from string video/x-raw, framerate = (fraction) [ 0, MAX ], width = (int) [ 1, MAX ], height = (int) [ 1, MAX ]
0:00:57.478881303 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af05e0 ref 1->2
0:00:57.478902957 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af05e0 ref 2->3
0:00:57.478923384 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x27019c0> 0x27019c0 new
0:00:57.478946573 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af05e0 ref 3->4
0:00:57.478972938 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x3af05e0 ref 4->5
0:00:57.478987532 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af05e0 unref 5->4
0:00:57.479007025 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af05e0 unref 4->3
0:00:57.479022192 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3af05e0 unref 3->2
0:00:57.479036746 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<sink> 0x27019c0 ref_sink 1->2
0:00:57.479128620 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x3c83610> 0x3c83610 new
0:00:57.479149442 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2df7b10> 0x2df7b10 new
0:00:57.479169353 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with 0x27019c0 sink (3)
0:00:57.479186518 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<sink> 0x27019c0 ref 3->4
0:00:57.479215380 10590      0x24c8630 DEBUG               GST_PADS gstpad.c:1594:gst_pad_set_activate_function_full:<'':sink> activatefunc set to gst_base_sink_pad_activate
0:00:57.479229855 10590      0x24c8630 DEBUG               GST_PADS gstpad.c:1629:gst_pad_set_activatemode_function_full:<'':sink> activatemodefunc set to gst_base_sink_pad_activate_mode
0:00:57.479248148 10590      0x24c8630 DEBUG               GST_PADS gstpad.c:1803:gst_pad_set_query_function_full:<'':sink> queryfunc set to gst_base_sink_sink_query
0:00:57.479264257 10590      0x24c8630 DEBUG               GST_PADS gstpad.c:1770:gst_pad_set_event_function_full:<'':sink> eventfunc for set to gst_base_sink_event
0:00:57.479278572 10590      0x24c8630 DEBUG               GST_PADS gstpad.c:1664:gst_pad_set_chain_function_full:<'':sink> chainfunc set to gst_base_sink_chain
0:00:57.479295274 10590      0x24c8630 DEBUG               GST_PADS gstpad.c:1701:gst_pad_set_chain_list_function_full:<'':sink> chainlistfunc set to gst_base_sink_chain_list
0:00:57.479311318 10590      0x24c8630 INFO        GST_ELEMENT_PADS gstelement.c:643:gst_element_add_pad:<GstBaseSink@0x3c83610> adding pad 'sink'
0:00:57.479325922 10590      0x24c8630 DEBUG        GST_REFCOUNTING gstobject.c:692:gst_object_set_parent:<'':sink> set parent (ref and sink)
0:00:57.479338741 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<(NULL):sink> 0x2df7b10 ref_sink 1->2
0:00:57.479372023 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<xvimagesink> 0x24f99c0 unref 3->2
0:00:57.479384249 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:390:gst_element_factory_create: created element "xvimagesink"
0:00:57.479397587 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<xvimagesink> 0x24f99c0 unref 2->1
0:00:57.479418545 10590      0x24c8630 INFO                 playbin gstplaybin2.c:2227:gst_play_bin_set_sink:<video> Setting video sink to <sink>
0:00:57.479432960 10590      0x24c8630 LOG                 playsink gstplaysink.c:849:gst_play_sink_set_sink: Setting sink <sink> as sink type 2
0:00:57.479447569 10590      0x24c8630 LOG                 playsink gstplaysink.c:851:gst_play_sink_set_sink:<playsink> locking from thread 0x24c8630
0:00:57.479459864 10590      0x24c8630 LOG                 playsink gstplaysink.c:851:gst_play_sink_set_sink:<playsink> locked from thread 0x24c8630
0:00:57.479471695 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<sink> 0x3c83610 ref_sink 3->4
0:00:57.479485000 10590      0x24c8630 LOG                 playsink gstplaysink.c:873:gst_play_sink_set_sink:<playsink> unlocking from thread 0x24c8630
0:00:57.479497226 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<sink> 0x3c83610 ref 4->5
0:00:57.479516485 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 1->2
0:00:57.479530585 10590      0x24c8630 DEBUG                GST_BUS gstelement.c:3020:gst_element_get_bus:<video> got bus <bus1>
0:00:57.479550478 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.479574131 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:876:gst_bus_add_watch_full_unlocked:<bus1> New source 0x2736410 with id 5548
0:00:57.731705891 10590      0x24c8630 LOG                  playbin gstplaybin2.c:1551:gst_playbin_uri_is_valid:<video> checking uri 'data:;base64,PD94bWwgdmVyc2lvbj0nMS4wJyBlbmNvZGluZz0nVVRGLTgnPz48TVBEIHhzaTpzY2hlbWFMb2NhdGlvbj0idXJuOm1wZWc6ZGFzaDpzY2hlbWE6bXBkOjIwMTEgaHR0cDovL3N0YW5kYXJkcy5pc28ub3JnL2l0dGYvUHVibGljbHlBdmFpbGFibGVTdGFuZGFyZHMvTVBFRy1EQVNIX3NjaGVtYV9maWxlcy9EQVNILU1QRC54c2QiIHByb2ZpbGVzPSJ1cm46bXBlZzpkYXNoOnByb2ZpbGU6ZnVsbDoyMDExIiB0eXBlPSJzdGF0aWMiIG1lZGlhUHJlc2VudGF0aW9uRHVyYXRpb249IlBUMzAuMDNTIiBtaW5CdWZmZXJUaW1lPSJQVDEuNVMiIHhtbG5zPSJ1cm46bXBlZzpkYXNoOnNjaGVtYTptcGQ6MjAxMSIgeG1sbnM6eHNpPSJodHRwOi8vd3d3LnczLm9yZy8yMDAxL1hNTFNjaGVtYS1pbnN0YW5jZSI+CiAgICAgICAgPEJhc2VVUkw+aHR0cHM6Ly92aWRlby50d2ltZy5jb208L0Jhc2VVUkw+CiAgICAgICAgPFBlcmlvZCBzdGFydD0iUFQwUyI+CiAgICAgICAgICA8QWRhcHRhdGlvblNldCBzZWdtZW50QWxpZ25tZW50PSJ0cnVlIj4KICAgICAgICAgICAgPENvbnRlbnRDb21wb25lbnQgY29udGVudFR5cGU9InZpZGVvIiBpZD0iMSIvPiA8UmVwcmVzZW50YXRpb24gaWQ9IjEiIG1pbWVUeXBlPSJ2aWRlby9tcDQiIGNvZGVjcz0iYXZjMS40MjAwMWYiIGJhbmR3aWR0aD0iMjU2MDAwIiB3aWR0aD0iMzIwIiBoZWlnaHQ9IjE4MCI+CiAgICAgIDxTZWdtZW50TGlzdCB0aW1lc2NhbGU9IjEwMDAiIGR1cmF0aW9uPSIzMDAwIj4KICAgICAgICA8SW5pdGlhbGl6YXRpb24gc291cmNlVVJMPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMzIweDE4MC9pL3RmN1EzRlpsNkxsaF96Q3QubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMC8zMDAwLzMyMHgxODAvdV8yanUwRFdyQzR4WDZ6Ny5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvdmlkLzMwMDAvNjAwMC8zMjB4MTgwLy1NdE9RUTA5NTBQVGhSRzMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC82MDAwLzkwMDAvMzIweDE4MC9pTUxTOWVZVDBTQlJldmRHLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvOTAwMC8xMjAwMC8zMjB4MTgwLzA2RVZZWkV4ay1UMDFVb3MubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xMjAwMC8xNTAwMC8zMjB4MTgwL2kxbU9UOTZDdGtxRm01QnYubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xNTAwMC8xODAwMC8zMjB4MTgwL05FeU1RMmxMVTlCdjQ2TFMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xODAwMC8yMTAwMC8zMjB4MTgwL190XzRUcGE1VDAzR2J5UWUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yMTAwMC8yNDAwMC8zMjB4MTgwL3R1b3NGZ2pwUGhtZjhwRXEubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNDAwMC8yNzAwMC8zMjB4MTgwLzdKQkVFczZzNEo4eF9OeTkubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNzAwMC8zMDAzMC8zMjB4MTgwL3Fta3cxeWJrMzZwN1kweHoubTRzIi8+CiAgICAgIDwvU2VnbWVudExpc3Q+CiAgICA8L1JlcHJlc2VudGF0aW9uPgogICAgICAgICAgPC9BZGFwdGF0aW9uU2V0PgogICAgICAgICAgPEFkYXB0YXRpb25TZXQgc2VnbWVudEFsaWdubWVudD0idHJ1ZSI+CiAgICAgICAgICAgIDxDb250ZW50Q29tcG9uZW50IGNvbnRlbnRUeXBlPSJhdWRpbyIgaWQ9IjIiLz4gPFJlcHJlc2VudGF0aW9uIGlkPSIyIiBtaW1lVHlwZT0iYXVkaW8vbXA0IiBjb2RlY3M9Im1wNGEuNDAuMiIgYmFuZHdpZHRoPSI2NDAwMCIgYXVkaW9TYW1wbGluZ1JhdGU9IjQ0MTAwIj4KICAgICAgPFNlZ21lbnRMaXN0IHRpbWVzY2FsZT0iMTAwMCIgZHVyYXRpb249IjMwMDAiPgogICAgICAgIDxJbml0aWFsaXphdGlvbiBzb3VyY2VVUkw9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC82NDAwMC9pLzJDRlQ0YXhNc250cE9ZRTIubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMC8zMDAwLzY0MDAwL21mY1ZTMFFuQVpKREpldVgubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8zMDAwLzYwMDAvNjQwMDAvSTYxbi1mRnQ4UWhwLXhDeS5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzYwMDAvOTAwMC82NDAwMC9Zc1M5czJMUEppdk9yQmhpLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvOTAwMC8xMjAwMC82NDAwMC9fRHlFU3FoRTE5alZHdW5hLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMTIwMDAvMTUwMDAvNjQwMDAvWkpsVlpQWkVpNW9iQi1fNi5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzE1MDAwLzE4MDAwLzY0MDAwL2dpQzJjMUFJYTROM3pFV3oubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8xODAwMC8yMTAwMC82NDAwMC9aYV80NmdlbjZIOUM1MVdvLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMjEwMDAvMjQwMDAvNjQwMDAvZmNOS2RnLTk4YnlpNlJjMC5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzI0MDAwLzI3MDAwLzY0MDAwL3V1cEZDS0VVZm5MU1hGUHUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8yNzAwMC8zMDAzMC82NDAwMC9va05KMmFOTlhrZVpkdmVmLm00cyIvPgogICAgICA8L1NlZ21lbnRMaXN0PgogICAgPC9SZXByZXNlbnRhdGlvbj4KICAgICAgICAgIDwvQWRhcHRhdGlvblNldD4KICAgICAgICA8L1BlcmlvZD4KICAgICAgPC9NUEQ+'
0:00:57.731781638 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:1605:gst_play_bin_set_uri: set new uri to data:;base64,PD94bWwgdmVyc2lvbj0nMS4wJyBlbmNvZGluZz0nVVRGLTgnPz48TVBEIHhzaTpzY2hlbWFMb2NhdGlvbj0idXJuOm1wZWc6ZGFzaDpzY2hlbWE6bXBkOjIwMTEgaHR0cDovL3N0YW5kYXJkcy5pc28ub3JnL2l0dGYvUHVibGljbHlBdmFpbGFibGVTdGFuZGFyZHMvTVBFRy1EQVNIX3NjaGVtYV9maWxlcy9EQVNILU1QRC54c2QiIHByb2ZpbGVzPSJ1cm46bXBlZzpkYXNoOnByb2ZpbGU6ZnVsbDoyMDExIiB0eXBlPSJzdGF0aWMiIG1lZGlhUHJlc2VudGF0aW9uRHVyYXRpb249IlBUMzAuMDNTIiBtaW5CdWZmZXJUaW1lPSJQVDEuNVMiIHhtbG5zPSJ1cm46bXBlZzpkYXNoOnNjaGVtYTptcGQ6MjAxMSIgeG1sbnM6eHNpPSJodHRwOi8vd3d3LnczLm9yZy8yMDAxL1hNTFNjaGVtYS1pbnN0YW5jZSI+CiAgICAgICAgPEJhc2VVUkw+aHR0cHM6Ly92aWRlby50d2ltZy5jb208L0Jhc2VVUkw+CiAgICAgICAgPFBlcmlvZCBzdGFydD0iUFQwUyI+CiAgICAgICAgICA8QWRhcHRhdGlvblNldCBzZWdtZW50QWxpZ25tZW50PSJ0cnVlIj4KICAgICAgICAgICAgPENvbnRlbnRDb21wb25lbnQgY29udGVudFR5cGU9InZpZGVvIiBpZD0iMSIvPiA8UmVwcmVzZW50YXRpb24gaWQ9IjEiIG1pbWVUeXBlPSJ2aWRlby9tcDQiIGNvZGVjcz0iYXZjMS40MjAwMWYiIGJhbmR3aWR0aD0iMjU2MDAwIiB3aWR0aD0iMzIwIiBoZWlnaHQ9IjE4MCI+CiAgICAgIDxTZWdtZW50TGlzdCB0aW1lc2NhbGU9IjEwMDAiIGR1cmF0aW9uPSIzMDAwIj4KICAgICAgICA8SW5pdGlhbGl6YXRpb24gc291cmNlVVJMPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMzIweDE4MC9pL3RmN1EzRlpsNkxsaF96Q3QubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMC8zMDAwLzMyMHgxODAvdV8yanUwRFdyQzR4WDZ6Ny5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvdmlkLzMwMDAvNjAwMC8zMjB4MTgwLy1NdE9RUTA5NTBQVGhSRzMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC82MDAwLzkwMDAvMzIweDE4MC9pTUxTOWVZVDBTQlJldmRHLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvOTAwMC8xMjAwMC8zMjB4MTgwLzA2RVZZWkV4ay1UMDFVb3MubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xMjAwMC8xNTAwMC8zMjB4MTgwL2kxbU9UOTZDdGtxRm01QnYubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xNTAwMC8xODAwMC8zMjB4MTgwL05FeU1RMmxMVTlCdjQ2TFMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xODAwMC8yMTAwMC8zMjB4MTgwL190XzRUcGE1VDAzR2J5UWUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yMTAwMC8yNDAwMC8zMjB4MTgwL3R1b3NGZ2pwUGhtZjhwRXEubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNDAwMC8yNzAwMC8zMjB4MTgwLzdKQkVFczZzNEo4eF9OeTkubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNzAwMC8zMDAzMC8zMjB4MTgwL3Fta3cxeWJrMzZwN1kweHoubTRzIi8+CiAgICAgIDwvU2VnbWVudExpc3Q+CiAgICA8L1JlcHJlc2VudGF0aW9uPgogICAgICAgICAgPC9BZGFwdGF0aW9uU2V0PgogICAgICAgICAgPEFkYXB0YXRpb25TZXQgc2VnbWVudEFsaWdubWVudD0idHJ1ZSI+CiAgICAgICAgICAgIDxDb250ZW50Q29tcG9uZW50IGNvbnRlbnRUeXBlPSJhdWRpbyIgaWQ9IjIiLz4gPFJlcHJlc2VudGF0aW9uIGlkPSIyIiBtaW1lVHlwZT0iYXVkaW8vbXA0IiBjb2RlY3M9Im1wNGEuNDAuMiIgYmFuZHdpZHRoPSI2NDAwMCIgYXVkaW9TYW1wbGluZ1JhdGU9IjQ0MTAwIj4KICAgICAgPFNlZ21lbnRMaXN0IHRpbWVzY2FsZT0iMTAwMCIgZHVyYXRpb249IjMwMDAiPgogICAgICAgIDxJbml0aWFsaXphdGlvbiBzb3VyY2VVUkw9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC82NDAwMC9pLzJDRlQ0YXhNc250cE9ZRTIubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMC8zMDAwLzY0MDAwL21mY1ZTMFFuQVpKREpldVgubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8zMDAwLzYwMDAvNjQwMDAvSTYxbi1mRnQ4UWhwLXhDeS5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzYwMDAvOTAwMC82NDAwMC9Zc1M5czJMUEppdk9yQmhpLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvOTAwMC8xMjAwMC82NDAwMC9fRHlFU3FoRTE5alZHdW5hLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMTIwMDAvMTUwMDAvNjQwMDAvWkpsVlpQWkVpNW9iQi1fNi5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzE1MDAwLzE4MDAwLzY0MDAwL2dpQzJjMUFJYTROM3pFV3oubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8xODAwMC8yMTAwMC82NDAwMC9aYV80NmdlbjZIOUM1MVdvLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMjEwMDAvMjQwMDAvNjQwMDAvZmNOS2RnLTk4YnlpNlJjMC5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzI0MDAwLzI3MDAwLzY0MDAwL3V1cEZDS0VVZm5MU1hGUHUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8yNzAwMC8zMDAzMC82NDAwMC9va05KMmFOTlhrZVpkdmVmLm00cyIvPgogICAgICA8L1NlZ21lbnRMaXN0PgogICAgPC9SZXByZXNlbnRhdGlvbj4KICAgICAgICAgIDwvQWRhcHRhdGlvblNldD4KICAgICAgICA8L1BlcmlvZD4KICAgICAgPC9NUEQ+
0:00:57.732047253 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<video> set_state to PLAYING
0:00:57.732088348 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<video> setting target state to PLAYING
0:00:57.732098042 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<video> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.732108454 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<video> intermediate: setting state from NULL to READY
0:00:57.732120963 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:449:gst_bus_set_flushing:<bus1> unset bus flushing
0:00:57.732137338 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2562:gst_bin_change_state_func:<video> changing state of children from NULL to READY
0:00:57.732147107 10590      0x24c8630 DEBUG                    bin gstbin.c:2595:gst_bin_change_state_func:<video> clearing all cached messages
0:00:57.732155783 10590      0x24c8630 DEBUG                    bin gstbin.c:2418:gst_bin_src_pads_activate:<video> deactivate pads
0:00:57.732166548 10590      0x24c8630 DEBUG                    bin gstbin.c:2426:gst_bin_src_pads_activate:<video> pad deactivation successful
0:00:57.732179138 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<video> 0x39fbc40 ref 1->2
0:00:57.732193432 10590      0x24c8630 DEBUG                    bin gstbin.c:2109:gst_bin_sort_iterator_resync:<video> resync
0:00:57.732202974 10590      0x24c8630 DEBUG                    bin gstbin.c:1895:add_to_queue:<video> adding 'playsink' to queue
0:00:57.732212906 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x25c4040 ref 1->2
0:00:57.732222616 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<video> element playsink not linked on any sinkpads
0:00:57.732234578 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playsink> 0x25c4040 unref 3->2
0:00:57.732244029 10590      0x24c8630 DEBUG                    bin gstbin.c:2096:gst_bin_sort_iterator_next:<video> queue head gives playsink
0:00:57.732254056 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<video> element playsink not linked on any sinkpads
0:00:57.732262054 10590      0x24c8630 INFO              GST_STATES gstbin.c:2230:gst_bin_element_set_state:<playsink> current NULL pending VOID_PENDING, desired next READY
0:00:57.732273904 10590      0x24c8630 DEBUG                    bin gstbin.c:883:find_message:<video> no message found matching types 00100000
0:00:57.732283505 10590      0x24c8630 DEBUG                    bin gstbin.c:890:find_message:<video>   async-start
0:00:57.732291077 10590      0x24c8630 DEBUG                    bin gstbin.c:2325:gst_bin_element_set_state:<video> setting element playsink to READY, base_time 0:00:00.000000000
0:00:57.732302911 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<playsink> set_state to READY
0:00:57.732311366 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<playsink> setting target state to READY
0:00:57.732320824 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<playsink> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.732330810 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<playsink> final: setting state from NULL to READY
0:00:57.732340762 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2562:gst_bin_change_state_func:<playsink> changing state of children from NULL to READY
0:00:57.732349158 10590      0x24c8630 DEBUG                    bin gstbin.c:2595:gst_bin_change_state_func:<playsink> clearing all cached messages
0:00:57.732356448 10590      0x24c8630 DEBUG                    bin gstbin.c:2418:gst_bin_src_pads_activate:<playsink> deactivate pads
0:00:57.732366462 10590      0x24c8630 DEBUG                    bin gstbin.c:2426:gst_bin_src_pads_activate:<playsink> pad deactivation successful
0:00:57.732375281 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x25c4040 ref 2->3
0:00:57.732385825 10590      0x24c8630 DEBUG                    bin gstbin.c:2109:gst_bin_sort_iterator_resync:<playsink> resync
0:00:57.732393700 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<playsink> element streamsynchronizer0 not linked on any sinkpads
0:00:57.732403504 10590      0x24c8630 DEBUG                    bin gstbin.c:2081:gst_bin_sort_iterator_next:<playsink> queue empty, next best: streamsynchronizer0
0:00:57.732412207 10590      0x24c8630 DEBUG                    bin gstbin.c:2096:gst_bin_sort_iterator_next:<playsink> queue head gives streamsynchronizer0
0:00:57.732421196 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<playsink> element streamsynchronizer0 not linked on any sinkpads
0:00:57.732429226 10590      0x24c8630 INFO              GST_STATES gstbin.c:2230:gst_bin_element_set_state:<streamsynchronizer0> current NULL pending VOID_PENDING, desired next READY
0:00:57.732439550 10590      0x24c8630 DEBUG                    bin gstbin.c:883:find_message:<playsink> no message found matching types 00100000
0:00:57.732447276 10590      0x24c8630 DEBUG                    bin gstbin.c:890:find_message:<playsink>   async-start
0:00:57.732454396 10590      0x24c8630 DEBUG                    bin gstbin.c:2325:gst_bin_element_set_state:<playsink> setting element streamsynchronizer0 to READY, base_time 0:00:00.000000000
0:00:57.732466007 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<streamsynchronizer0> set_state to READY
0:00:57.732473953 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<streamsynchronizer0> setting target state to READY
0:00:57.732483331 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<streamsynchronizer0> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.732492430 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<streamsynchronizer0> final: setting state from NULL to READY
0:00:57.732501420 10590      0x24c8630 DEBUG     streamsynchronizer gststreamsynchronizer.c:808:gst_stream_synchronizer_change_state:<streamsynchronizer0> State change NULL->READY
0:00:57.732509313 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<streamsynchronizer0> default handler tries setting state from NULL to READY (000a)
0:00:57.732519890 10590      0x24c8630 DEBUG     streamsynchronizer gststreamsynchronizer.c:836:gst_stream_synchronizer_change_state:<streamsynchronizer0> Base class state changed returned: 1
0:00:57.732527645 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<streamsynchronizer0> element changed state SUCCESS
0:00:57.732535222 10590      0x24c8630 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<streamsynchronizer0> completed state change to READY
0:00:57.732543260 10590      0x24c8630 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<streamsynchronizer0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:57.732553727 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c110800
0:00:57.732564455 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source streamsynchronizer0: creating new message 0x27092b0 state-changed
0:00:57.732576287 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<streamsynchronizer0> 0x2579a10 ref 2->3
0:00:57.732585695 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus2> 0x3b09680 ref 2->3
0:00:57.732594337 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus2> [msg 0x27092b0] posting on bus state-changed message: 0x27092b0, time 99:99:99.999999999, seq-num 0, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.732624419 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<playsink> [msg 0x27092b0] handling child streamsynchronizer0 message of type state-changed
0:00:57.732633659 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<playsink> posting message upward
0:00:57.732640939 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x27092b0 ref 1->2
0:00:57.732650108 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 2->3
0:00:57.732660018 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus0> [msg 0x27092b0] posting on bus state-changed message: 0x27092b0, time 99:99:99.999999999, seq-num 0, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.732689610 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<video> [msg 0x27092b0] handling child streamsynchronizer0 message of type state-changed
0:00:57.732700691 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<video> posting message upward
0:00:57.732707803 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x27092b0 ref 2->3
0:00:57.732717961 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.732726569 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x27092b0] posting on bus state-changed message: 0x27092b0, time 99:99:99.999999999, seq-num 0, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.732744688 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x27092b0] pushing on async queue
0:00:57.732753358 10590      0x24c8630 LOG                 GST_POLL gstpoll.c:186:raise_wakeup: 0x31748a0: raise
0:00:57.732767176 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x27092b0] pushed on async queue
0:00:57.732776906 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.732785516 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27092b0 unref 3->2
0:00:57.732794372 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus0> [msg 0x27092b0] dropped
0:00:57.732801759 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 3->2
0:00:57.732811182 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27092b0 unref 2->1
0:00:57.732819914 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus2> [msg 0x27092b0] dropped
0:00:57.732828700 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus2> 0x3b09680 unref 3->2
0:00:57.732837441 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<streamsynchronizer0> exit state change 1
0:00:57.732848233 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<streamsynchronizer0> returned SUCCESS
0:00:57.732856683 10590      0x24c8630 INFO              GST_STATES gstbin.c:2673:gst_bin_change_state_func:<playsink> child 'streamsynchronizer0' changed state to 2(READY) successfully
0:00:57.732866555 10590      0x24c8630 DEBUG                    bin gstbin.c:2085:gst_bin_sort_iterator_next:<playsink> queue empty, elements exhausted
0:00:57.732873906 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2732:gst_bin_change_state_func:<playsink> iterator done
0:00:57.732881218 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<playsink> default handler tries setting state from NULL to READY (000a)
0:00:57.732892010 10590      0x24c8630 DEBUG                    bin gstbin.c:2127:gst_bin_sort_iterator_free:<playsink> free
0:00:57.732900425 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playsink> 0x25c4040 unref 3->2
0:00:57.732910756 10590      0x24c8630 DEBUG                    bin gstbin.c:2767:gst_bin_change_state_func:<playsink> no async elements
0:00:57.732917809 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2801:gst_bin_change_state_func:<playsink> done changing bin's state from NULL to READY, now in NULL, ret SUCCESS
0:00:57.732928871 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<playsink> element changed state SUCCESS
0:00:57.732936165 10590      0x24c8630 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<playsink> completed state change to READY
0:00:57.732943724 10590      0x24c8630 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<playsink> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:57.732952625 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c105660
0:00:57.732961044 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source playsink: creating new message 0x2709330 state-changed
0:00:57.732970177 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x25c4040 ref 2->3
0:00:57.732978553 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2709330 ref 1->2
0:00:57.732987115 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 2->3
0:00:57.732995204 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus0> [msg 0x2709330] posting on bus state-changed message: 0x2709330, time 99:99:99.999999999, seq-num 1, element 'playsink', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.733011024 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<video> [msg 0x2709330] handling child playsink message of type state-changed
0:00:57.733019568 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<video> posting message upward
0:00:57.733026414 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2709330 ref 2->3
0:00:57.733038322 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.733053667 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x2709330] posting on bus state-changed message: 0x2709330, time 99:99:99.999999999, seq-num 1, element 'playsink', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.733076855 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x2709330] pushing on async queue
0:00:57.733091004 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x2709330] pushed on async queue
0:00:57.733105265 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.733121800 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709330 unref 3->2
0:00:57.733136793 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus0> [msg 0x2709330] dropped
0:00:57.733144734 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 3->2
0:00:57.733153253 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709330 unref 2->1
0:00:57.733163738 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<playsink> exit state change 1
0:00:57.733171628 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<playsink> returned SUCCESS
0:00:57.733179414 10590      0x24c8630 INFO              GST_STATES gstbin.c:2673:gst_bin_change_state_func:<video> child 'playsink' changed state to 2(READY) successfully
0:00:57.733190645 10590      0x24c8630 DEBUG                    bin gstbin.c:2085:gst_bin_sort_iterator_next:<video> queue empty, elements exhausted
0:00:57.733198277 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2732:gst_bin_change_state_func:<video> iterator done
0:00:57.733207085 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<video> default handler tries setting state from NULL to READY (000a)
0:00:57.733216201 10590      0x24c8630 DEBUG                    bin gstbin.c:2127:gst_bin_sort_iterator_free:<video> free
0:00:57.733223208 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<video> 0x39fbc40 unref 2->1
0:00:57.733233077 10590      0x24c8630 DEBUG                    bin gstbin.c:2767:gst_bin_change_state_func:<video> no async elements
0:00:57.733240094 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2801:gst_bin_change_state_func:<video> done changing bin's state from NULL to READY, now in NULL, ret SUCCESS
0:00:57.733250633 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<video> element changed state SUCCESS
0:00:57.733258014 10590      0x24c8630 INFO              GST_STATES gstelement.c:2303:gst_element_continue_state:<video> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:57.733268240 10590      0x24c8630 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<video> notifying about state-changed NULL to READY (PLAYING pending)
0:00:57.733276873 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c11c820
0:00:57.733284995 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source video: creating new message 0x27093b0 state-changed
0:00:57.733295665 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<video> 0x39fbc40 ref 1->2
0:00:57.733304352 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x27093b0 ref 1->2
0:00:57.733314257 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.733322665 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x27093b0] posting on bus state-changed message: 0x27093b0, time 99:99:99.999999999, seq-num 2, element 'video', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_PLAYING;
0:00:57.733338561 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x27093b0] pushing on async queue
0:00:57.733346743 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x27093b0] pushed on async queue
0:00:57.733355754 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.733364264 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27093b0 unref 2->1
0:00:57.733374020 10590      0x24c8630 INFO              GST_STATES gstelement.c:2310:gst_element_continue_state:<video> continue state change READY to PAUSED, final PLAYING
0:00:57.733382651 10590      0x24c8630 LOG                  playbin gstplaybin2.c:5498:gst_play_bin_change_state:<video> clearing shutdown flag
0:00:57.733401016 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:5390:setup_next_source:<video> setup sources
0:00:57.733410596 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:4999:activate_group:<video> activating group 0x39fc0c8
0:00:57.733418977 10590      0x24c8630 LOG                 playsink gstplaysink.c:889:gst_play_sink_get_sink:<playsink> locking from thread 0x24c8630
0:00:57.733428066 10590      0x24c8630 LOG                 playsink gstplaysink.c:889:gst_play_sink_get_sink:<playsink> locked from thread 0x24c8630
0:00:57.733435569 10590      0x24c8630 LOG                 playsink gstplaysink.c:927:gst_play_sink_get_sink:<playsink> unlocking from thread 0x24c8630
0:00:57.733443605 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<sink> 0x3c83610 ref 3->4
0:00:57.733454326 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x3d548e0> 0x3d548e0 new
0:00:57.733465699 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<GstBus@0x3d548e0> 0x3d548e0 ref_sink 1->2
0:00:57.733474789 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:227:gst_bus_init:<GstBus@0x3d548e0> created
0:00:57.733486616 10590      0x24c8630 DEBUG               GST_POLL gstpoll.c:557:gst_poll_new: 0x31685e0: new controllable : 1
0:00:57.733506496 10590      0x24c8630 DEBUG               GST_POLL gstpoll.c:726:gst_poll_add_fd_unlocked: 0x31685e0: fd (fd:29, idx:0)
0:00:57.733517196 10590      0x24c8630 DEBUG               GST_POLL gstpoll.c:893:gst_poll_fd_ctl_read_unlocked: 0x31685e0: fd (fd:29, idx:0), active : 1
0:00:57.733528036 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:281:gst_bus_new:<bus3> created new bus
0:00:57.733536215 10590      0x24c8630 DEBUG          GST_PARENTAGE gstelement.c:2965:gst_element_set_bus_func:<sink> setting bus to 0x3d548e0
0:00:57.733544320 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with 0x3d548e0 bus3 (1)
0:00:57.733556857 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus3> 0x3d548e0 ref 1->2
0:00:57.733565439 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<sink> set_state to READY
0:00:57.733573524 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<sink> setting target state to READY
0:00:57.733582407 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<sink> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.733591578 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<sink> final: setting state from NULL to READY
0:00:57.733881815 10590      0x24c8630 DEBUG               xcontext xvcontext.c:672:gst_xvcontext_new: X reports 3840x3240 pixels and 1016 mm x 857 mm
0:00:57.733903617 10590      0x24c8630 DEBUG               xcontext xvcontext.c:414:gst_xvcontext_calculate_pixel_aspect_ratio: calculated pixel aspect ratio: 1.000292
0:00:57.733915868 10590      0x24c8630 DEBUG               xcontext xvcontext.c:430:gst_xvcontext_calculate_pixel_aspect_ratio: Decided on index 0 (1/1)
0:00:57.733925400 10590      0x24c8630 DEBUG               xcontext xvcontext.c:438:gst_xvcontext_calculate_pixel_aspect_ratio: set context PAR to 1/1
0:00:57.734054249 10590      0x24c8630 DEBUG               xcontext xvcontext.c:126:gst_xvcontext_get_xv_support: Found 2 XV adaptor(s)
0:00:57.734100863 10590      0x24c8630 DEBUG               xcontext xvcontext.c:86:gst_lookup_xv_port_from_adaptor: XV Adaptor Intel(R) Textured Video with 64 ports
0:00:57.737066222 10590      0x24c8630 DEBUG               xcontext xvcontext.c:164:gst_xvcontext_get_xv_support: Checking 1 Xv port attributes
0:00:57.737094050 10590      0x24c8630 DEBUG               xcontext xvcontext.c:172:gst_xvcontext_get_xv_support: Got attribute XV_SYNC_TO_VBLANK
0:00:57.737140278 10590      0x24c8630 LOG                 xcontext xvcontext.c:253:gst_xvcontext_get_xv_support: Encoding 0, name XV_IMAGE, max wxh 16384x16384 rate 1/1
0:00:57.737223168 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x31748f0
0:00:57.737254848 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3b63720
0:00:57.737265925 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c118560
0:00:57.737285696 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x30db590
0:00:57.737301876 10590      0x24c8630 DEBUG        GST_PERFORMANCE gstcaps.c:163:_gst_caps_copy:video/x-raw, format=(string)YUY2, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ] doing copy 0x3b63720 -> 0x30db590
0:00:57.737312567 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c12a080
0:00:57.737321781 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x7f246c118560 -> 0x7f246c12a080
0:00:57.737333269 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b63720 unref 1->0
0:00:57.737346331 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x3b63720
0:00:57.737354611 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3b63720
0:00:57.737362724 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x31c7520
0:00:57.737371850 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x24e0e30
0:00:57.737384435 10590      0x24c8630 DEBUG        GST_PERFORMANCE gstcaps.c:163:_gst_caps_copy:video/x-raw, format=(string)YV12, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ] doing copy 0x3b63720 -> 0x24e0e30
0:00:57.737395113 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c112040
0:00:57.737403704 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x31c7520 -> 0x7f246c112040
0:00:57.737413690 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3b63720 unref 1->0
0:00:57.737421963 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x3b63720
0:00:57.737429409 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x3165720
0:00:57.737437624 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x31ca420
0:00:57.737446260 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x7f2480002850
0:00:57.737456780 10590      0x24c8630 DEBUG        GST_PERFORMANCE gstcaps.c:163:_gst_caps_copy:video/x-raw, format=(string)I420, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ] doing copy 0x3165720 -> 0x7f2480002850
0:00:57.737467610 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x3959240
0:00:57.737475733 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x31ca420 -> 0x3959240
0:00:57.737485765 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x3165720 unref 1->0
0:00:57.737494319 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x3165720
0:00:57.737501795 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x39bb190
0:00:57.737509655 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c114ba0
0:00:57.737517866 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x2fb35e0
0:00:57.737527972 10590      0x24c8630 DEBUG        GST_PERFORMANCE gstcaps.c:163:_gst_caps_copy:video/x-raw, format=(string)UYVY, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ] doing copy 0x39bb190 -> 0x2fb35e0
0:00:57.737536806 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c114880
0:00:57.737544497 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x7f246c114ba0 -> 0x7f246c114880
0:00:57.737552718 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x39bb190 unref 1->0
0:00:57.737560951 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x39bb190
0:00:57.737568424 10590      0x24c8630 DEBUG               xcontext xvcontext.c:347:gst_xvcontext_get_xv_support: Generated the following caps: video/x-raw, format=(string)YUY2, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ]; video/x-raw, format=(string)YV12, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ]; video/x-raw, format=(string)I420, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ]; video/x-raw, format=(string)UYVY, width=(int)[ 1, 16384 ], height=(int)[ 1, 16384 ], framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:57.737650209 10590      0x24c8630 DEBUG               xcontext xvcontext.c:482:gst_xvcontext_check_xshm_calls: XvShmCreateImage of 1x1
0:00:57.737804068 10590      0x24c8630 DEBUG               xcontext xvcontext.c:528:gst_xvcontext_check_xshm_calls: XServer ShmAttached to 0xf80019, id 0x4e00001
0:00:57.737848695 10590      0x24c8630 DEBUG               xcontext xvcontext.c:547:gst_xvcontext_check_xshm_calls: XServer ShmDetaching from 0xf80019 id 0x4e00001
0:00:57.737913708 10590      0x24c8630 DEBUG               xcontext xvcontext.c:715:gst_xvcontext_new: xvimagesink is using XShm extension
0:00:57.738056206 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x27119e0> 0x27119e0 new
0:00:57.738077569 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x388ebd0 ref 1->2
0:00:57.738090613 10590      0x24c8630 DEBUG            xvimagesink xvimagesink.c:1754:gst_xvimagesink_open:<sink> set calculated PAR on object's PAR
0:00:57.738098255 10590      0x24c8630 DEBUG               xcontext xvcontext.c:805:gst_xvcontext_set_synchronous: XSynchronize called with FALSE
0:00:57.738106704 10590      0x24c8630 DEBUG            xvimagesink xvimagesink.c:607:gst_xvimagesink_manage_event_thread:<sink> run xevent thread, expose 1, events 1
0:00:57.738142882 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<sink> default handler tries setting state from NULL to READY (000a)
0:00:57.738156304 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<sink> element changed state SUCCESS
0:00:57.738164360 10590      0x24c8630 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<sink> completed state change to READY
0:00:57.738174233 10590      0x24c8630 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<sink> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:57.738183651 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c113520
0:00:57.738192982 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source sink: creating new message 0x2709430 state-changed
0:00:57.738204252 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<sink> 0x3c83610 ref 4->5
0:00:57.738213390 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus3> 0x3d548e0 ref 2->3
0:00:57.738221746 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus3> [msg 0x2709430] posting on bus state-changed message: 0x2709430, time 99:99:99.999999999, seq-num 3, element 'sink', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.738242279 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2709430 ref 1->2
0:00:57.738251525 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.738259985 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x2709430] posting on bus state-changed message: 0x2709430, time 99:99:99.999999999, seq-num 3, element 'sink', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.738276728 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x2709430] pushing on async queue
0:00:57.738285080 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x2709430] pushed on async queue
0:00:57.738292937 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.738302814 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709430 unref 2->1
0:00:57.738311415 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus3> [msg 0x2709430] dropped
0:00:57.738318834 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus3> 0x3d548e0 unref 3->2
0:00:57.738329119 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<sink> exit state change 1
0:00:57.738337385 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<sink> returned SUCCESS
0:00:57.738345365 10590      0x24c8630 DEBUG          GST_PARENTAGE gstelement.c:2965:gst_element_set_bus_func:<sink> setting bus to (nil)
0:00:57.738354721 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace 0x3d548e0 bus3 (2) with (nil) (NONE) (0)
0:00:57.738364911 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus3> 0x3d548e0 unref 2->1
0:00:57.738373646 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus3> 0x3d548e0 unref 1->0
0:00:57.738384896 10590      0x24c8630 DEBUG               GST_POLL gstpoll.c:650:gst_poll_free: 0x31685e0: freeing
0:00:57.738406404 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:369:gst_object_dispose:<bus3> dispose
0:00:57.738417222 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:411:gst_object_finalize:<bus3> finalize
0:00:57.738428982 10590      0x24c8630 LOG                 playsink gstplaysink.c:889:gst_play_sink_get_sink:<playsink> locking from thread 0x24c8630
0:00:57.738438998 10590      0x24c8630 LOG                 playsink gstplaysink.c:889:gst_play_sink_get_sink:<playsink> locked from thread 0x24c8630
0:00:57.738446571 10590      0x24c8630 LOG                 playsink gstplaysink.c:927:gst_play_sink_get_sink:<playsink> unlocking from thread 0x24c8630
0:00:57.738456471 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:5069:activate_group:<video> making new uridecodebin
0:00:57.738464573 10590      0x24c8630 LOG      GST_ELEMENT_FACTORY gstelementfactory.c:439:gst_element_factory_make: gstelementfactory: make "uridecodebin" "(NULL)"
0:00:57.738476931 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin> 0x2553ac0 ref 1->2
0:00:57.738485643 10590      0x24c8630 LOG      GST_ELEMENT_FACTORY gstelementfactory.c:445:gst_element_factory_make:<uridecodebin> found factory 0x2553ac0
0:00:57.738493497 10590      0x24c8630 DEBUG     GST_PLUGIN_LOADING gstpluginfeature.c:106:gst_plugin_feature_load: loading plugin for feature 0x2553ac0; 'uridecodebin'
0:00:57.738502200 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin> 0x2553ac0 ref 2->3
0:00:57.738510079 10590      0x24c8630 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "uridecodebin"
0:00:57.738520635 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c12c960
0:00:57.738530811 10590      0x24c8630 TRACE        GST_PERFORMANCE gststructure.c:357:gst_structure_copy: doing copy 0x24c1060 -> 0x7f246c12c960
0:00:57.738539995 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:275:gst_element_base_class_init: type GstURIDecodeBin : factory 0x2553ac0
0:00:57.738604652 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x2fb34a0
0:00:57.738616283 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726bff90 from string ANY
0:00:57.738624839 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2fb34a0 ref 1->2
0:00:57.738636291 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2fb34a0 ref 2->3
0:00:57.738648473 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x2701a50> 0x2701a50 new
0:00:57.738660549 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2fb34a0 ref 3->4
0:00:57.738671471 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2fb34a0 ref 4->5
0:00:57.738679810 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2fb34a0 unref 5->4
0:00:57.738690555 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2fb34a0 unref 4->3
0:00:57.738699396 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2fb34a0 unref 3->2
0:00:57.738708296 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<src_%u> 0x2701a50 ref_sink 1->2
0:00:57.738724035 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x3e48020> 0x3e48020 new
0:00:57.738736483 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:221:gst_object_init:<GstObject@0x3d549c0> 0x3d549c0 new
0:00:57.738746150 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<GstBus@0x3d549c0> 0x3d549c0 ref_sink 1->2
0:00:57.738757012 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:227:gst_bus_init:<GstBus@0x3d549c0> created
0:00:57.738767720 10590      0x24c8630 DEBUG                    bin gstbin.c:498:gst_bin_init:<GstBin@0x3e48020> using bus <bus4> to listen to children
0:00:57.738779221 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:242:gst_caps_new_empty: created caps 0x25ae2d0
0:00:57.738788020 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x32c7f20
0:00:57.738795425 10590      0x24c8630 TRACE          caps-features gstcapsfeatures.c:171:gst_caps_features_new_empty: created caps features 0x7f246c112f60
0:00:57.738803311 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x37d2fa0
0:00:57.738811151 10590      0x24c8630 TRACE          caps-features gstcapsfeatures.c:171:gst_caps_features_new_empty: created caps features 0x7f246c12df60
0:00:57.738819124 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c12e0c0
0:00:57.738828392 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x32d6ec0
0:00:57.738836016 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c115e20
0:00:57.738845456 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c1109a0
0:00:57.738852575 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:416:gst_static_caps_get: created 0x7f24726bff20 from string video/x-raw(ANY); audio/x-raw(ANY); text/x-raw; subpicture/x-dvd; subpicture/x-dvb; subpicture/x-pgs
0:00:57.738863380 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x25ae2d0 ref 1->2
0:00:57.738874867 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin> 0x2553ac0 unref 3->2
0:00:57.738884909 10590      0x24c8630 DEBUG    GST_ELEMENT_FACTORY gstelementfactory.c:390:gst_element_factory_create: created element "uridecodebin"
0:00:57.738893092 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin> 0x2553ac0 unref 2->1
0:00:57.738904533 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1301:gst_bin_add: adding element uridecodebin0 to bin video
0:00:57.738914119 10590      0x24c8630 DEBUG                    bin gstbin.c:1101:gst_bin_add_func:<video> element :uridecodebin0
0:00:57.738921886 10590      0x24c8630 DEBUG        GST_REFCOUNTING gstobject.c:692:gst_object_set_parent:<uridecodebin0> set parent (ref and sink)
0:00:57.738929754 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:306:gst_object_ref_sink:<uridecodebin0> 0x3e48020 ref_sink 1->2
0:00:57.738938282 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1140:gst_bin_add_func:<video> element "uridecodebin0" was source
0:00:57.738946409 10590      0x24c8630 DEBUG          GST_PARENTAGE gstelement.c:2965:gst_element_set_bus_func:<uridecodebin0> setting bus to 0x3b094c0
0:00:57.738954384 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with 0x3b094c0 bus0 (2)
0:00:57.738964465 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 2->3
0:00:57.738974127 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:462:gst_element_set_base_time:<uridecodebin0> set base_time=0:00:00.000000000, old 0:00:00.000000000
0:00:57.738988861 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:524:gst_element_set_start_time:<uridecodebin0> set start_time=0:00:00.000000000, old 0:00:00.000000000
0:00:57.739000031 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:405:gst_element_set_clock:<uridecodebin0> setting clock (nil)
0:00:57.739008772 10590      0x24c8630 DEBUG                    bin gstbin.c:724:gst_bin_set_clock_func:<uridecodebin0> iterator done
0:00:57.739017981 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with (nil) (NONE) (0)
0:00:57.739029874 10590      0x24c8630 DEBUG                    bin gstbin.c:1189:gst_bin_add_func:<video> added SUCCESS element
0:00:57.739038177 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1226:gst_bin_add_func:<video> added element "uridecodebin0"
0:00:57.739051532 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin0> 0x3e48020 ref 1->2
0:00:57.739074306 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<video> 0x39fbc40 ref 2->3
0:00:57.739085908 10590      0x24c8630 LOG           GST_PROPERTIES gstobject.c:463:gst_object_dispatch_properties_changed:<video> deep notification from uridecodebin0 (ring-buffer-max-size)
0:00:57.739096249 10590      0x24c8630 LOG           GST_PROPERTIES gstobject.c:463:gst_object_dispatch_properties_changed:<video> deep notification from uridecodebin0 (buffer-size)
0:00:57.739106074 10590      0x24c8630 LOG           GST_PROPERTIES gstobject.c:463:gst_object_dispatch_properties_changed:<video> deep notification from uridecodebin0 (buffer-duration)
0:00:57.739115103 10590      0x24c8630 LOG           GST_PROPERTIES gstobject.c:463:gst_object_dispatch_properties_changed:<video> deep notification from uridecodebin0 (use-buffering)
0:00:57.739126605 10590      0x24c8630 LOG           GST_PROPERTIES gstobject.c:463:gst_object_dispatch_properties_changed:<video> deep notification from uridecodebin0 (download)
0:00:57.739137207 10590      0x24c8630 LOG           GST_PROPERTIES gstobject.c:463:gst_object_dispatch_properties_changed:<video> deep notification from uridecodebin0 (uri)
0:00:57.739146749 10590      0x24c8630 LOG           GST_PROPERTIES gstobject.c:463:gst_object_dispatch_properties_changed:<video> deep notification from uridecodebin0 (connection-speed)
0:00:57.739155871 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<video> 0x39fbc40 unref 3->2
0:00:57.739177218 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<uridecodebin0> set_state to READY
0:00:57.739187410 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<uridecodebin0> setting target state to READY
0:00:57.739195499 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<uridecodebin0> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.739206299 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<uridecodebin0> final: setting state from NULL to READY
0:00:57.739216036 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2562:gst_bin_change_state_func:<uridecodebin0> changing state of children from NULL to READY
0:00:57.739224449 10590      0x24c8630 DEBUG                    bin gstbin.c:2595:gst_bin_change_state_func:<uridecodebin0> clearing all cached messages
0:00:57.739231686 10590      0x24c8630 DEBUG                    bin gstbin.c:2418:gst_bin_src_pads_activate:<uridecodebin0> deactivate pads
0:00:57.739240593 10590      0x24c8630 DEBUG                    bin gstbin.c:2426:gst_bin_src_pads_activate:<uridecodebin0> pad deactivation successful
0:00:57.739251808 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin0> 0x3e48020 ref 2->3
0:00:57.739260751 10590      0x24c8630 DEBUG                    bin gstbin.c:2109:gst_bin_sort_iterator_resync:<uridecodebin0> resync
0:00:57.739268769 10590      0x24c8630 DEBUG                    bin gstbin.c:2085:gst_bin_sort_iterator_next:<uridecodebin0> queue empty, elements exhausted
0:00:57.739277596 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2732:gst_bin_change_state_func:<uridecodebin0> iterator done
0:00:57.739284824 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<uridecodebin0> default handler tries setting state from NULL to READY (000a)
0:00:57.739295612 10590      0x24c8630 DEBUG                    bin gstbin.c:2127:gst_bin_sort_iterator_free:<uridecodebin0> free
0:00:57.739303174 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin0> 0x3e48020 unref 3->2
0:00:57.739313277 10590      0x24c8630 DEBUG                    bin gstbin.c:2767:gst_bin_change_state_func:<uridecodebin0> no async elements
0:00:57.739320253 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2801:gst_bin_change_state_func:<uridecodebin0> done changing bin's state from NULL to READY, now in NULL, ret SUCCESS
0:00:57.739335278 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<uridecodebin0> element changed state SUCCESS
0:00:57.739347063 10590      0x24c8630 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<uridecodebin0> completed state change to READY
0:00:57.739355360 10590      0x24c8630 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<uridecodebin0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:57.739365892 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c10ef80
0:00:57.739374593 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source uridecodebin0: creating new message 0x30278a0 state-changed
0:00:57.739385583 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin0> 0x3e48020 ref 2->3
0:00:57.739394042 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x30278a0 ref 1->2
0:00:57.739402596 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 3->4
0:00:57.739410843 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus0> [msg 0x30278a0] posting on bus state-changed message: 0x30278a0, time 99:99:99.999999999, seq-num 4, element 'uridecodebin0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.739430191 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<video> [msg 0x30278a0] handling child uridecodebin0 message of type state-changed
0:00:57.739439907 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<video> posting message upward
0:00:57.739446695 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x30278a0 ref 2->3
0:00:57.739455224 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.739463867 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x30278a0] posting on bus state-changed message: 0x30278a0, time 99:99:99.999999999, seq-num 4, element 'uridecodebin0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.739479140 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x30278a0] pushing on async queue
0:00:57.739487015 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x30278a0] pushed on async queue
0:00:57.739494614 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.739504100 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x30278a0 unref 3->2
0:00:57.739512859 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus0> [msg 0x30278a0] dropped
0:00:57.739521870 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 4->3
0:00:57.739530261 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x30278a0 unref 2->1
0:00:57.739540222 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<uridecodebin0> exit state change 1
0:00:57.739548280 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<uridecodebin0> returned SUCCESS
0:00:57.739556209 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:4975:group_set_locked_state_unlocked:<video> locked_state 0 on group 0x39fc0c8
0:00:57.739567025 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:1937:gst_element_set_locked_state: elements uridecodebin0 was already in locked state 0
0:00:57.739576447 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2562:gst_bin_change_state_func:<video> changing state of children from READY to PAUSED
0:00:57.739584719 10590      0x24c8630 DEBUG                    bin gstbin.c:2582:gst_bin_change_state_func:<video> clearing EOS elements
0:00:57.739591721 10590      0x24c8630 DEBUG                    bin gstbin.c:2418:gst_bin_src_pads_activate:<video> activate pads
0:00:57.739602131 10590      0x24c8630 DEBUG                    bin gstbin.c:2426:gst_bin_src_pads_activate:<video> pad activation successful
0:00:57.739610312 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<video> 0x39fbc40 ref 2->3
0:00:57.739620117 10590      0x24c8630 DEBUG                    bin gstbin.c:2109:gst_bin_sort_iterator_resync:<video> resync
0:00:57.739627362 10590      0x24c8630 DEBUG                    bin gstbin.c:1895:add_to_queue:<video> adding 'playsink' to queue
0:00:57.739635209 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x25c4040 ref 2->3
0:00:57.739643813 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<video> element uridecodebin0 not linked on any sinkpads
0:00:57.739651718 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<video> element playsink not linked on any sinkpads
0:00:57.739659935 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playsink> 0x25c4040 unref 4->3
0:00:57.739668232 10590      0x24c8630 DEBUG                    bin gstbin.c:2096:gst_bin_sort_iterator_next:<video> queue head gives playsink
0:00:57.739675506 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<video> element playsink not linked on any sinkpads
0:00:57.739683988 10590      0x24c8630 INFO              GST_STATES gstbin.c:2230:gst_bin_element_set_state:<playsink> current READY pending VOID_PENDING, desired next PAUSED
0:00:57.739694902 10590      0x24c8630 DEBUG                    bin gstbin.c:883:find_message:<video> no message found matching types 00100000
0:00:57.739702880 10590      0x24c8630 DEBUG                    bin gstbin.c:890:find_message:<video>   async-start
0:00:57.739712266 10590      0x24c8630 DEBUG                    bin gstbin.c:2325:gst_bin_element_set_state:<video> setting element playsink to PAUSED, base_time 0:00:00.000000000
0:00:57.739721912 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<playsink> set_state to PAUSED
0:00:57.739729391 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<playsink> setting target state to PAUSED
0:00:57.739736883 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<playsink> current READY, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.739747543 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<playsink> final: setting state from READY to PAUSED
0:00:57.739757528 10590      0x24c8630 INFO                playsink gstplaysink.c:1400:do_async_start:<playsink> Sending async_start message
0:00:57.739768064 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source playsink: creating new message 0x27094b0 async-start
0:00:57.739779892 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x25c4040 ref 3->4
0:00:57.739788554 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<playsink> [msg 0x27094b0] handling child playsink message of type async-start
0:00:57.739797088 10590      0x24c8630 DEBUG                    bin gstbin.c:3599:gst_bin_handle_message_func:<playsink> ASYNC_START message 0x27094b0, playsink
0:00:57.739805134 10590      0x24c8630 DEBUG                    bin gstbin.c:883:find_message:<playsink> no message found matching types 00100000
0:00:57.739814269 10590      0x24c8630 DEBUG                    bin gstbin.c:890:find_message:<playsink>   async-start
0:00:57.739821652 10590      0x24c8630 DEBUG                    bin gstbin.c:930:bin_replace_message:<playsink> got new message 0x27094b0, async-start from playsink
0:00:57.739831237 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source playsink: creating new message 0x2709530 async-start
0:00:57.739840280 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x25c4040 ref 4->5
0:00:57.739848621 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:3072:bin_handle_async_start:<playsink> state change busy
0:00:57.739855861 10590      0x24c8630 DEBUG                    bin gstbin.c:3058:bin_handle_async_start:<playsink> posting ASYNC_START to parent
0:00:57.739862437 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2709530 ref 1->2
0:00:57.739870945 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 3->4
0:00:57.739880691 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus0> [msg 0x2709530] posting on bus async-start message: 0x2709530, time 99:99:99.999999999, seq-num 6, element 'playsink', (NULL)
0:00:57.739891329 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<video> [msg 0x2709530] handling child playsink message of type async-start
0:00:57.739899855 10590      0x24c8630 DEBUG                    bin gstbin.c:3599:gst_bin_handle_message_func:<video> ASYNC_START message 0x2709530, playsink
0:00:57.739907192 10590      0x24c8630 DEBUG                    bin gstbin.c:883:find_message:<video> no message found matching types 00100000
0:00:57.739914574 10590      0x24c8630 DEBUG                    bin gstbin.c:890:find_message:<video>   async-start
0:00:57.739922025 10590      0x24c8630 DEBUG                    bin gstbin.c:930:bin_replace_message:<video> got new message 0x2709530, async-start from playsink
0:00:57.739930221 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:3072:bin_handle_async_start:<video> state change busy
0:00:57.739937746 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus0> [msg 0x2709530] dropped
0:00:57.739946853 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 4->3
0:00:57.739954920 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709530 unref 2->1
0:00:57.739963089 10590      0x24c8630 LOG                 playsink gstplaysink.c:4166:gst_play_sink_reconfigure:<playsink> Triggering reconfiguration
0:00:57.739970210 10590      0x24c8630 LOG                 playsink gstplaysink.c:4168:gst_play_sink_reconfigure:<playsink> locking from thread 0x24c8630
0:00:57.739977565 10590      0x24c8630 LOG                 playsink gstplaysink.c:4168:gst_play_sink_reconfigure:<playsink> locked from thread 0x24c8630
0:00:57.739984933 10590      0x24c8630 LOG                 playsink gstplaysink.c:4172:gst_play_sink_reconfigure:<playsink> unlocking from thread 0x24c8630
0:00:57.739994454 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2562:gst_bin_change_state_func:<playsink> changing state of children from READY to PAUSED
0:00:57.740002683 10590      0x24c8630 DEBUG                    bin gstbin.c:2582:gst_bin_change_state_func:<playsink> clearing EOS elements
0:00:57.740009378 10590      0x24c8630 LOG                      bin gstbin.c:861:message_check: looking at message 0x27094b0: 0
0:00:57.740017203 10590      0x24c8630 DEBUG                    bin gstbin.c:964:bin_remove_messages:<playsink> not deleting message 0x27094b0 of type 0x00100000
0:00:57.740025132 10590      0x24c8630 LOG                      bin gstbin.c:861:message_check: looking at message 0x27094b0: 0
0:00:57.740032997 10590      0x24c8630 DEBUG                    bin gstbin.c:964:bin_remove_messages:<playsink> not deleting message 0x27094b0 of type 0x00100000
0:00:57.740042583 10590      0x24c8630 DEBUG                    bin gstbin.c:2418:gst_bin_src_pads_activate:<playsink> activate pads
0:00:57.740050622 10590      0x24c8630 DEBUG                    bin gstbin.c:2426:gst_bin_src_pads_activate:<playsink> pad activation successful
0:00:57.740060054 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<playsink> 0x25c4040 ref 5->6
0:00:57.740068665 10590      0x24c8630 DEBUG                    bin gstbin.c:2109:gst_bin_sort_iterator_resync:<playsink> resync
0:00:57.740076988 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<playsink> element streamsynchronizer0 not linked on any sinkpads
0:00:57.740085624 10590      0x24c8630 DEBUG                    bin gstbin.c:2081:gst_bin_sort_iterator_next:<playsink> queue empty, next best: streamsynchronizer0
0:00:57.740094154 10590      0x24c8630 DEBUG                    bin gstbin.c:2096:gst_bin_sort_iterator_next:<playsink> queue head gives streamsynchronizer0
0:00:57.740101524 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<playsink> element streamsynchronizer0 not linked on any sinkpads
0:00:57.740109347 10590      0x24c8630 INFO              GST_STATES gstbin.c:2230:gst_bin_element_set_state:<streamsynchronizer0> current READY pending VOID_PENDING, desired next PAUSED
0:00:57.740119496 10590      0x24c8630 LOG                      bin gstbin.c:861:message_check: looking at message 0x27094b0: 0
0:00:57.740127236 10590      0x24c8630 DEBUG                    bin gstbin.c:883:find_message:<playsink> no message found matching types 00100000
0:00:57.740136959 10590      0x24c8630 DEBUG                    bin gstbin.c:890:find_message:<playsink>   async-start
0:00:57.740144229 10590      0x24c8630 DEBUG                    bin gstbin.c:2325:gst_bin_element_set_state:<playsink> setting element streamsynchronizer0 to PAUSED, base_time 0:00:00.000000000
0:00:57.740155423 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<streamsynchronizer0> set_state to PAUSED
0:00:57.740163283 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<streamsynchronizer0> setting target state to PAUSED
0:00:57.740173175 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<streamsynchronizer0> current READY, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.740182278 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<streamsynchronizer0> final: setting state from READY to PAUSED
0:00:57.740191318 10590      0x24c8630 DEBUG     streamsynchronizer gststreamsynchronizer.c:812:gst_stream_synchronizer_change_state:<streamsynchronizer0> State change READY->PAUSED
0:00:57.740199226 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<streamsynchronizer0> default handler tries setting state from READY to PAUSED (0013)
0:00:57.740209466 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:2740:gst_element_pads_activate:<streamsynchronizer0> activate pads
0:00:57.740218398 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:2759:gst_element_pads_activate:<streamsynchronizer0> pad activation successful
0:00:57.740227909 10590      0x24c8630 DEBUG     streamsynchronizer gststreamsynchronizer.c:836:gst_stream_synchronizer_change_state:<streamsynchronizer0> Base class state changed returned: 1
0:00:57.740235861 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<streamsynchronizer0> element changed state SUCCESS
0:00:57.740245252 10590      0x24c8630 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<streamsynchronizer0> completed state change to PAUSED
0:00:57.740252985 10590      0x24c8630 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<streamsynchronizer0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:57.740262964 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c12a180
0:00:57.740271105 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source streamsynchronizer0: creating new message 0x27095b0 state-changed
0:00:57.740281607 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<streamsynchronizer0> 0x2579a10 ref 3->4
0:00:57.740290225 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus2> 0x3b09680 ref 2->3
0:00:57.740298861 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus2> [msg 0x27095b0] posting on bus state-changed message: 0x27095b0, time 99:99:99.999999999, seq-num 7, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_PAUSED, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.740315323 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<playsink> [msg 0x27095b0] handling child streamsynchronizer0 message of type state-changed
0:00:57.740324002 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<playsink> posting message upward
0:00:57.740330766 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x27095b0 ref 1->2
0:00:57.740340921 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 3->4
0:00:57.740349290 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus0> [msg 0x27095b0] posting on bus state-changed message: 0x27095b0, time 99:99:99.999999999, seq-num 7, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_PAUSED, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.740364494 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<video> [msg 0x27095b0] handling child streamsynchronizer0 message of type state-changed
0:00:57.740372961 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<video> posting message upward
0:00:57.740379658 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x27095b0 ref 2->3
0:00:57.740390083 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.740398702 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x27095b0] posting on bus state-changed message: 0x27095b0, time 99:99:99.999999999, seq-num 7, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_PAUSED, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.740413190 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x27095b0] pushing on async queue
0:00:57.740420998 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x27095b0] pushed on async queue
0:00:57.740430332 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.740438458 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27095b0 unref 3->2
0:00:57.740448312 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus0> [msg 0x27095b0] dropped
0:00:57.740455578 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 4->3
0:00:57.740465051 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27095b0 unref 2->1
0:00:57.740473689 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus2> [msg 0x27095b0] dropped
0:00:57.740482708 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus2> 0x3b09680 unref 3->2
0:00:57.740491155 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<streamsynchronizer0> exit state change 1
0:00:57.740501315 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<streamsynchronizer0> returned SUCCESS
0:00:57.740509322 10590      0x24c8630 INFO              GST_STATES gstbin.c:2673:gst_bin_change_state_func:<playsink> child 'streamsynchronizer0' changed state to 3(PAUSED) successfully
0:00:57.740520289 10590      0x24c8630 DEBUG                    bin gstbin.c:2085:gst_bin_sort_iterator_next:<playsink> queue empty, elements exhausted
0:00:57.740527544 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2732:gst_bin_change_state_func:<playsink> iterator done
0:00:57.740536732 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<playsink> default handler tries setting state from READY to PAUSED (0013)
0:00:57.740545226 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:2740:gst_element_pads_activate:<playsink> activate pads
0:00:57.740553716 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:2759:gst_element_pads_activate:<playsink> pad activation successful
0:00:57.740563499 10590      0x24c8630 DEBUG                    bin gstbin.c:2127:gst_bin_sort_iterator_free:<playsink> free
0:00:57.740571182 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playsink> 0x25c4040 unref 6->5
0:00:57.740580987 10590      0x24c8630 DEBUG                    bin gstbin.c:2767:gst_bin_change_state_func:<playsink> no async elements
0:00:57.740587936 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2801:gst_bin_change_state_func:<playsink> done changing bin's state from READY to PAUSED, now in READY, ret SUCCESS
0:00:57.740598346 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2618:gst_element_change_state:<playsink> element will change state ASYNC
0:00:57.740605552 10590      0x24c8630 LOG               GST_STATES gstelement.c:2658:gst_element_change_state:<playsink> exit async state change 2
0:00:57.740615582 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<playsink> returned ASYNC
0:00:57.740623346 10590      0x24c8630 INFO              GST_STATES gstbin.c:2679:gst_bin_change_state_func:<video> child 'playsink' is changing state asynchronously to PAUSED
0:00:57.740633658 10590      0x24c8630 DEBUG                    bin gstbin.c:2081:gst_bin_sort_iterator_next:<video> queue empty, next best: uridecodebin0
0:00:57.740641745 10590      0x24c8630 DEBUG                    bin gstbin.c:2096:gst_bin_sort_iterator_next:<video> queue head gives uridecodebin0
0:00:57.740650708 10590      0x24c8630 DEBUG                    bin gstbin.c:2035:update_degree:<video> element uridecodebin0 not linked on any sinkpads
0:00:57.740658806 10590      0x24c8630 INFO              GST_STATES gstbin.c:2230:gst_bin_element_set_state:<uridecodebin0> current READY pending VOID_PENDING, desired next PAUSED
0:00:57.740668760 10590      0x24c8630 LOG                      bin gstbin.c:861:message_check: looking at message 0x2709530: 0
0:00:57.740684997 10590      0x24c8630 DEBUG                    bin gstbin.c:883:find_message:<video> no message found matching types 00100000
0:00:57.740695456 10590      0x24c8630 DEBUG                    bin gstbin.c:890:find_message:<video>   async-start
0:00:57.740702717 10590      0x24c8630 DEBUG                    bin gstbin.c:2325:gst_bin_element_set_state:<video> setting element uridecodebin0 to PAUSED, base_time 0:00:00.000000000
0:00:57.740714684 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<uridecodebin0> set_state to PAUSED
0:00:57.740722474 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<uridecodebin0> setting target state to PAUSED
0:00:57.740730310 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<uridecodebin0> current READY, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.740739895 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<uridecodebin0> final: setting state from READY to PAUSED
0:00:57.740749123 10590      0x24c8630 DEBUG           uridecodebin gsturidecodebin.c:2190:setup_source:<uridecodebin0> setup source
0:00:57.740756712 10590      0x24c8630 LOG             uridecodebin gsturidecodebin.c:1294:gen_source_element:<uridecodebin0> finding source for data:;base64,PD94bWwgdmVyc2lvbj0nMS4wJyBlbmNvZGluZz0nVVRGLTgnPz48TVBEIHhzaTpzY2hlbWFMb2NhdGlvbj0idXJuOm1wZWc6ZGFzaDpzY2hlbWE6bXBkOjIwMTEgaHR0cDovL3N0YW5kYXJkcy5pc28ub3JnL2l0dGYvUHVibGljbHlBdmFpbGFibGVTdGFuZGFyZHMvTVBFRy1EQVNIX3NjaGVtYV9maWxlcy9EQVNILU1QRC54c2QiIHByb2ZpbGVzPSJ1cm46bXBlZzpkYXNoOnByb2ZpbGU6ZnVsbDoyMDExIiB0eXBlPSJzdGF0aWMiIG1lZGlhUHJlc2VudGF0aW9uRHVyYXRpb249IlBUMzAuMDNTIiBtaW5CdWZmZXJUaW1lPSJQVDEuNVMiIHhtbG5zPSJ1cm46bXBlZzpkYXNoOnNjaGVtYTptcGQ6MjAxMSIgeG1sbnM6eHNpPSJodHRwOi8vd3d3LnczLm9yZy8yMDAxL1hNTFNjaGVtYS1pbnN0YW5jZSI+CiAgICAgICAgPEJhc2VVUkw+aHR0cHM6Ly92aWRlby50d2ltZy5jb208L0Jhc2VVUkw+CiAgICAgICAgPFBlcmlvZCBzdGFydD0iUFQwUyI+CiAgICAgICAgICA8QWRhcHRhdGlvblNldCBzZWdtZW50QWxpZ25tZW50PSJ0cnVlIj4KICAgICAgICAgICAgPENvbnRlbnRDb21wb25lbnQgY29udGVudFR5cGU9InZpZGVvIiBpZD0iMSIvPiA8UmVwcmVzZW50YXRpb24gaWQ9IjEiIG1pbWVUeXBlPSJ2aWRlby9tcDQiIGNvZGVjcz0iYXZjMS40MjAwMWYiIGJhbmR3aWR0aD0iMjU2MDAwIiB3aWR0aD0iMzIwIiBoZWlnaHQ9IjE4MCI+CiAgICAgIDxTZWdtZW50TGlzdCB0aW1lc2NhbGU9IjEwMDAiIGR1cmF0aW9uPSIzMDAwIj4KICAgICAgICA8SW5pdGlhbGl6YXRpb24gc291cmNlVVJMPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMzIweDE4MC9pL3RmN1EzRlpsNkxsaF96Q3QubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMC8zMDAwLzMyMHgxODAvdV8yanUwRFdyQzR4WDZ6Ny5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvdmlkLzMwMDAvNjAwMC8zMjB4MTgwLy1NdE9RUTA5NTBQVGhSRzMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC82MDAwLzkwMDAvMzIweDE4MC9pTUxTOWVZVDBTQlJldmRHLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvOTAwMC8xMjAwMC8zMjB4MTgwLzA2RVZZWkV4ay1UMDFVb3MubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xMjAwMC8xNTAwMC8zMjB4MTgwL2kxbU9UOTZDdGtxRm01QnYubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xNTAwMC8xODAwMC8zMjB4MTgwL05FeU1RMmxMVTlCdjQ2TFMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xODAwMC8yMTAwMC8zMjB4MTgwL190XzRUcGE1VDAzR2J5UWUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yMTAwMC8yNDAwMC8zMjB4MTgwL3R1b3NGZ2pwUGhtZjhwRXEubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNDAwMC8yNzAwMC8zMjB4MTgwLzdKQkVFczZzNEo4eF9OeTkubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNzAwMC8zMDAzMC8zMjB4MTgwL3Fta3cxeWJrMzZwN1kweHoubTRzIi8+CiAgICAgIDwvU2VnbWVudExpc3Q+CiAgICA8L1JlcHJlc2VudGF0aW9uPgogICAgICAgICAgPC9BZGFwdGF0aW9uU2V0PgogICAgICAgICAgPEFkYXB0YXRpb25TZXQgc2VnbWVudEFsaWdubWVudD0idHJ1ZSI+CiAgICAgICAgICAgIDxDb250ZW50Q29tcG9uZW50IGNvbnRlbnRUeXBlPSJhdWRpbyIgaWQ9IjIiLz4gPFJlcHJlc2VudGF0aW9uIGlkPSIyIiBtaW1lVHlwZT0iYXVkaW8vbXA0IiBjb2RlY3M9Im1wNGEuNDAuMiIgYmFuZHdpZHRoPSI2NDAwMCIgYXVkaW9TYW1wbGluZ1JhdGU9IjQ0MTAwIj4KICAgICAgPFNlZ21lbnRMaXN0IHRpbWVzY2FsZT0iMTAwMCIgZHVyYXRpb249IjMwMDAiPgogICAgICAgIDxJbml0aWFsaXphdGlvbiBzb3VyY2VVUkw9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC82NDAwMC9pLzJDRlQ0YXhNc250cE9ZRTIubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMC8zMDAwLzY0MDAwL21mY1ZTMFFuQVpKREpldVgubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8zMDAwLzYwMDAvNjQwMDAvSTYxbi1mRnQ4UWhwLXhDeS5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzYwMDAvOTAwMC82NDAwMC9Zc1M5czJMUEppdk9yQmhpLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvOTAwMC8xMjAwMC82NDAwMC9fRHlFU3FoRTE5alZHdW5hLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMTIwMDAvMTUwMDAvNjQwMDAvWkpsVlpQWkVpNW9iQi1fNi5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzE1MDAwLzE4MDAwLzY0MDAwL2dpQzJjMUFJYTROM3pFV3oubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8xODAwMC8yMTAwMC82NDAwMC9aYV80NmdlbjZIOUM1MVdvLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMjEwMDAvMjQwMDAvNjQwMDAvZmNOS2RnLTk4YnlpNlJjMC5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzI0MDAwLzI3MDAwLzY0MDAwL3V1cEZDS0VVZm5MU1hGUHUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8yNzAwMC8zMDAzMC82NDAwMC9va05KMmFOTlhrZVpkdmVmLm00cyIvPgogICAgICA8L1NlZ21lbnRMaXN0PgogICAgPC9SZXByZXNlbnRhdGlvbj4KICAgICAgICAgIDwvQWRhcHRhdGlvblNldD4KICAgICAgICA8L1BlcmlvZD4KICAgICAgPC9NUEQ+
0:00:57.740794288 10590      0x24c8630 DEBUG                GST_URI gsturi.c:578:gst_element_make_from_uri: type:2, uri:data:;base64,PD94bWwgdmVyc2lvbj0nMS4wJyBlbmNvZGluZz0nVVRGLTgnPz48TVBEIHhzaTpzY2hlbWFMb2NhdGlvbj0idXJuOm1wZWc6ZGFzaDpzY2hlbWE6bXBkOjIwMTEgaHR0cDovL3N0YW5kYXJkcy5pc28ub3JnL2l0dGYvUHVibGljbHlBdmFpbGFibGVTdGFuZGFyZHMvTVBFRy1EQVNIX3NjaGVtYV9maWxlcy9EQVNILU1QRC54c2QiIHByb2ZpbGVzPSJ1cm46bXBlZzpkYXNoOnByb2ZpbGU6ZnVsbDoyMDExIiB0eXBlPSJzdGF0aWMiIG1lZGlhUHJlc2VudGF0aW9uRHVyYXRpb249IlBUMzAuMDNTIiBtaW5CdWZmZXJUaW1lPSJQVDEuNVMiIHhtbG5zPSJ1cm46bXBlZzpkYXNoOnNjaGVtYTptcGQ6MjAxMSIgeG1sbnM6eHNpPSJodHRwOi8vd3d3LnczLm9yZy8yMDAxL1hNTFNjaGVtYS1pbnN0YW5jZSI+CiAgICAgICAgPEJhc2VVUkw+aHR0cHM6Ly92aWRlby50d2ltZy5jb208L0Jhc2VVUkw+CiAgICAgICAgPFBlcmlvZCBzdGFydD0iUFQwUyI+CiAgICAgICAgICA8QWRhcHRhdGlvblNldCBzZWdtZW50QWxpZ25tZW50PSJ0cnVlIj4KICAgICAgICAgICAgPENvbnRlbnRDb21wb25lbnQgY29udGVudFR5cGU9InZpZGVvIiBpZD0iMSIvPiA8UmVwcmVzZW50YXRpb24gaWQ9IjEiIG1pbWVUeXBlPSJ2aWRlby9tcDQiIGNvZGVjcz0iYXZjMS40MjAwMWYiIGJhbmR3aWR0aD0iMjU2MDAwIiB3aWR0aD0iMzIwIiBoZWlnaHQ9IjE4MCI+CiAgICAgIDxTZWdtZW50TGlzdCB0aW1lc2NhbGU9IjEwMDAiIGR1cmF0aW9uPSIzMDAwIj4KICAgICAgICA8SW5pdGlhbGl6YXRpb24gc291cmNlVVJMPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMzIweDE4MC9pL3RmN1EzRlpsNkxsaF96Q3QubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMC8zMDAwLzMyMHgxODAvdV8yanUwRFdyQzR4WDZ6Ny5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvdmlkLzMwMDAvNjAwMC8zMjB4MTgwLy1NdE9RUTA5NTBQVGhSRzMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC82MDAwLzkwMDAvMzIweDE4MC9pTUxTOWVZVDBTQlJldmRHLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvOTAwMC8xMjAwMC8zMjB4MTgwLzA2RVZZWkV4ay1UMDFVb3MubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xMjAwMC8xNTAwMC8zMjB4MTgwL2kxbU9UOTZDdGtxRm01QnYubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xNTAwMC8xODAwMC8zMjB4MTgwL05FeU1RMmxMVTlCdjQ2TFMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xODAwMC8yMTAwMC8zMjB4MTgwL190XzRUcGE1VDAzR2J5UWUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yMTAwMC8yNDAwMC8zMjB4MTgwL3R1b3NGZ2pwUGhtZjhwRXEubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNDAwMC8yNzAwMC8zMjB4MTgwLzdKQkVFczZzNEo4eF9OeTkubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNzAwMC8zMDAzMC8zMjB4MTgwL3Fta3cxeWJrMzZwN1kweHoubTRzIi8+CiAgICAgIDwvU2VnbWVudExpc3Q+CiAgICA8L1JlcHJlc2VudGF0aW9uPgogICAgICAgICAgPC9BZGFwdGF0aW9uU2V0PgogICAgICAgICAgPEFkYXB0YXRpb25TZXQgc2VnbWVudEFsaWdubWVudD0idHJ1ZSI+CiAgICAgICAgICAgIDxDb250ZW50Q29tcG9uZW50IGNvbnRlbnRUeXBlPSJhdWRpbyIgaWQ9IjIiLz4gPFJlcHJlc2VudGF0aW9uIGlkPSIyIiBtaW1lVHlwZT0iYXVkaW8vbXA0IiBjb2RlY3M9Im1wNGEuNDAuMiIgYmFuZHdpZHRoPSI2NDAwMCIgYXVkaW9TYW1wbGluZ1JhdGU9IjQ0MTAwIj4KICAgICAgPFNlZ21lbnRMaXN0IHRpbWVzY2FsZT0iMTAwMCIgZHVyYXRpb249IjMwMDAiPgogICAgICAgIDxJbml0aWFsaXphdGlvbiBzb3VyY2VVUkw9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC82NDAwMC9pLzJDRlQ0YXhNc250cE9ZRTIubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMC8zMDAwLzY0MDAwL21mY1ZTMFFuQVpKREpldVgubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8zMDAwLzYwMDAvNjQwMDAvSTYxbi1mRnQ4UWhwLXhDeS5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzYwMDAvOTAwMC82NDAwMC9Zc1M5czJMUEppdk9yQmhpLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvOTAwMC8xMjAwMC82NDAwMC9fRHlFU3FoRTE5alZHdW5hLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMTIwMDAvMTUwMDAvNjQwMDAvWkpsVlpQWkVpNW9iQi1fNi5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzE1MDAwLzE4MDAwLzY0MDAwL2dpQzJjMUFJYTROM3pFV3oubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8xODAwMC8yMTAwMC82NDAwMC9aYV80NmdlbjZIOUM1MVdvLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMjEwMDAvMjQwMDAvNjQwMDAvZmNOS2RnLTk4YnlpNlJjMC5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzI0MDAwLzI3MDAwLzY0MDAwL3V1cEZDS0VVZm5MU1hGUHUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8yNzAwMC8zMDAzMC82NDAwMC9va05KMmFOTlhrZVpkdmVmLm00cyIvPgogICAgICA8L1NlZ21lbnRMaXN0PgogICAgPC9SZXByZXNlbnRhdGlvbj4KICAgICAgICAgIDwvQWRhcHRhdGlvblNldD4KICAgICAgICA8L1BlcmlvZD4KICAgICAgPC9NUEQ+, elementname:source
0:00:57.740869249 10590      0x24c8630 DEBUG                GST_URI gsturi.c:585:gst_element_make_from_uri: No source for URI 'data:;base64,PD94bWwgdmVyc2lvbj0nMS4wJyBlbmNvZGluZz0nVVRGLTgnPz48TVBEIHhzaTpzY2hlbWFMb2NhdGlvbj0idXJuOm1wZWc6ZGFzaDpzY2hlbWE6bXBkOjIwMTEgaHR0cDovL3N0YW5kYXJkcy5pc28ub3JnL2l0dGYvUHVibGljbHlBdmFpbGFibGVTdGFuZGFyZHMvTVBFRy1EQVNIX3NjaGVtYV9maWxlcy9EQVNILU1QRC54c2QiIHByb2ZpbGVzPSJ1cm46bXBlZzpkYXNoOnByb2ZpbGU6ZnVsbDoyMDExIiB0eXBlPSJzdGF0aWMiIG1lZGlhUHJlc2VudGF0aW9uRHVyYXRpb249IlBUMzAuMDNTIiBtaW5CdWZmZXJUaW1lPSJQVDEuNVMiIHhtbG5zPSJ1cm46bXBlZzpkYXNoOnNjaGVtYTptcGQ6MjAxMSIgeG1sbnM6eHNpPSJodHRwOi8vd3d3LnczLm9yZy8yMDAxL1hNTFNjaGVtYS1pbnN0YW5jZSI+CiAgICAgICAgPEJhc2VVUkw+aHR0cHM6Ly92aWRlby50d2ltZy5jb208L0Jhc2VVUkw+CiAgICAgICAgPFBlcmlvZCBzdGFydD0iUFQwUyI+CiAgICAgICAgICA8QWRhcHRhdGlvblNldCBzZWdtZW50QWxpZ25tZW50PSJ0cnVlIj4KICAgICAgICAgICAgPENvbnRlbnRDb21wb25lbnQgY29udGVudFR5cGU9InZpZGVvIiBpZD0iMSIvPiA8UmVwcmVzZW50YXRpb24gaWQ9IjEiIG1pbWVUeXBlPSJ2aWRlby9tcDQiIGNvZGVjcz0iYXZjMS40MjAwMWYiIGJhbmR3aWR0aD0iMjU2MDAwIiB3aWR0aD0iMzIwIiBoZWlnaHQ9IjE4MCI+CiAgICAgIDxTZWdtZW50TGlzdCB0aW1lc2NhbGU9IjEwMDAiIGR1cmF0aW9uPSIzMDAwIj4KICAgICAgICA8SW5pdGlhbGl6YXRpb24gc291cmNlVVJMPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMzIweDE4MC9pL3RmN1EzRlpsNkxsaF96Q3QubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvMC8zMDAwLzMyMHgxODAvdV8yanUwRFdyQzR4WDZ6Ny5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvdmlkLzMwMDAvNjAwMC8zMjB4MTgwLy1NdE9RUTA5NTBQVGhSRzMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC82MDAwLzkwMDAvMzIweDE4MC9pTUxTOWVZVDBTQlJldmRHLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS92aWQvOTAwMC8xMjAwMC8zMjB4MTgwLzA2RVZZWkV4ay1UMDFVb3MubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xMjAwMC8xNTAwMC8zMjB4MTgwL2kxbU9UOTZDdGtxRm01QnYubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xNTAwMC8xODAwMC8zMjB4MTgwL05FeU1RMmxMVTlCdjQ2TFMubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8xODAwMC8yMTAwMC8zMjB4MTgwL190XzRUcGE1VDAzR2J5UWUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yMTAwMC8yNDAwMC8zMjB4MTgwL3R1b3NGZ2pwUGhtZjhwRXEubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNDAwMC8yNzAwMC8zMjB4MTgwLzdKQkVFczZzNEo4eF9OeTkubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L3ZpZC8yNzAwMC8zMDAzMC8zMjB4MTgwL3Fta3cxeWJrMzZwN1kweHoubTRzIi8+CiAgICAgIDwvU2VnbWVudExpc3Q+CiAgICA8L1JlcHJlc2VudGF0aW9uPgogICAgICAgICAgPC9BZGFwdGF0aW9uU2V0PgogICAgICAgICAgPEFkYXB0YXRpb25TZXQgc2VnbWVudEFsaWdubWVudD0idHJ1ZSI+CiAgICAgICAgICAgIDxDb250ZW50Q29tcG9uZW50IGNvbnRlbnRUeXBlPSJhdWRpbyIgaWQ9IjIiLz4gPFJlcHJlc2VudGF0aW9uIGlkPSIyIiBtaW1lVHlwZT0iYXVkaW8vbXA0IiBjb2RlY3M9Im1wNGEuNDAuMiIgYmFuZHdpZHRoPSI2NDAwMCIgYXVkaW9TYW1wbGluZ1JhdGU9IjQ0MTAwIj4KICAgICAgPFNlZ21lbnRMaXN0IHRpbWVzY2FsZT0iMTAwMCIgZHVyYXRpb249IjMwMDAiPgogICAgICAgIDxJbml0aWFsaXphdGlvbiBzb3VyY2VVUkw9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC82NDAwMC9pLzJDRlQ0YXhNc250cE9ZRTIubXA0Ii8+IDxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMC8zMDAwLzY0MDAwL21mY1ZTMFFuQVpKREpldVgubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8zMDAwLzYwMDAvNjQwMDAvSTYxbi1mRnQ4UWhwLXhDeS5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzYwMDAvOTAwMC82NDAwMC9Zc1M5czJMUEppdk9yQmhpLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvOTAwMC8xMjAwMC82NDAwMC9fRHlFU3FoRTE5alZHdW5hLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMTIwMDAvMTUwMDAvNjQwMDAvWkpsVlpQWkVpNW9iQi1fNi5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzE1MDAwLzE4MDAwLzY0MDAwL2dpQzJjMUFJYTROM3pFV3oubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8xODAwMC8yMTAwMC82NDAwMC9aYV80NmdlbjZIOUM1MVdvLm00cyIvPjxTZWdtZW50VVJMIG1lZGlhPSIvZXh0X3R3X3ZpZGVvLzYxMTY1NzYzMjgzOTkwNTI4MC9wdS9hdWQvMjEwMDAvMjQwMDAvNjQwMDAvZmNOS2RnLTk4YnlpNlJjMC5tNHMiLz48U2VnbWVudFVSTCBtZWRpYT0iL2V4dF90d192aWRlby82MTE2NTc2MzI4Mzk5MDUyODAvcHUvYXVkLzI0MDAwLzI3MDAwLzY0MDAwL3V1cEZDS0VVZm5MU1hGUHUubTRzIi8+PFNlZ21lbnRVUkwgbWVkaWE9Ii9leHRfdHdfdmlkZW8vNjExNjU3NjMyODM5OTA1MjgwL3B1L2F1ZC8yNzAwMC8zMDAzMC82NDAwMC9va05KMmFOTlhrZVpkdmVmLm00cyIvPgogICAgICA8L1NlZ21lbnRMaXN0PgogICAgPC9SZXByZXNlbnRhdGlvbj4KICAgICAgICAgIDwvQWRhcHRhdGlvblNldD4KICAgICAgICA8L1BlcmlvZD4KICAgICAgPC9NUEQ+'
0:00:57.740956970 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c105b40
0:00:57.740971662 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source uridecodebin0: creating new message 0x2709630 element
0:00:57.740983553 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin0> 0x3e48020 ref 4->5
0:00:57.740992507 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2709630 ref 1->2
0:00:57.741000992 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 3->4
0:00:57.741009688 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus0> [msg 0x2709630] posting on bus element message: 0x2709630, time 99:99:99.999999999, seq-num 8, element 'uridecodebin0', missing-plugin, type=(string)urisource, detail=(string)data, name=(string)"DATA\ protocol\ source";
0:00:57.741026073 10590      0x24c8630 LOG                  default missing-plugins.c:414:gst_missing_plugin_message_get_installer_detail: Parsing missing-plugin message: missing-plugin, type=(string)urisource, detail=(string)data, name=(string)"DATA\ protocol\ source";
0:00:57.741038972 10590      0x24c8630 LOG                  default missing-plugins.c:508:gst_missing_plugin_message_get_description: Parsing missing-plugin message: missing-plugin, type=(string)urisource, detail=(string)data, name=(string)"DATA\ protocol\ source";
0:00:57.741049992 10590      0x24c8630 LOG                  default missing-plugins.c:583:gst_missing_plugin_message_get_description: returning 'DATA protocol source'
0:00:57.741060587 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<video> [msg 0x2709630] handling child uridecodebin0 message of type element
0:00:57.741070811 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<video> posting message upward
0:00:57.741077657 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x2709630 ref 2->3
0:00:57.741086466 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.741094743 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x2709630] posting on bus element message: 0x2709630, time 99:99:99.999999999, seq-num 8, element 'uridecodebin0', missing-plugin, type=(string)urisource, detail=(string)data, name=(string)"DATA\ protocol\ source";
0:00:57.741111231 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x2709630] pushing on async queue
0:00:57.741119238 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x2709630] pushed on async queue
0:00:57.741126675 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.741135057 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709630 unref 3->2
0:00:57.741145091 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus0> [msg 0x2709630] dropped
0:00:57.741152475 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 4->3
0:00:57.741162136 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709630 unref 2->1
0:00:57.741173290 10590      0x24c8630 WARN            uridecodebin gsturidecodebin.c:1416:gen_source_element:<uridecodebin0> error: No URI handler implemented for "data".
0:00:57.741183473 10590      0x24c8630 DEBUG            GST_MESSAGE gstelement.c:1804:gst_element_message_full:<uridecodebin0> start
0:00:57.741191376 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin0> 0x3e48020 ref 5->6
0:00:57.741201456 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<video> 0x39fbc40 ref 3->4
0:00:57.741211248 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<video> 0x39fbc40 unref 4->3
0:00:57.741222156 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin0> 0x3e48020 unref 6->5
0:00:57.741235494 10590      0x24c8630 INFO        GST_ERROR_SYSTEM gstelement.c:1835:gst_element_message_full:<uridecodebin0> posting message: No URI handler implemented for "data".
0:00:57.741248747 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c119040
0:00:57.741258484 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source uridecodebin0: creating new message 0x27096b0 error
0:00:57.741269505 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<uridecodebin0> 0x3e48020 ref 5->6
0:00:57.741277777 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x27096b0 ref 1->2
0:00:57.741285964 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus0> 0x3b094c0 ref 3->4
0:00:57.741295632 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus0> [msg 0x27096b0] posting on bus error message: 0x27096b0, time 99:99:99.999999999, seq-num 9, element 'uridecodebin0', GstMessageError, gerror=(GError)NULL, debug=(string)"gsturidecodebin.c\(1416\):\ gen_source_element\ \(\):\ /GstPlayBin:video/GstURIDecodeBin:uridecodebin0";
0:00:57.741316019 10590      0x24c8630 DEBUG                    bin gstbin.c:3409:gst_bin_handle_message_func:<video> [msg 0x27096b0] handling child uridecodebin0 message of type error
0:00:57.741325274 10590      0x24c8630 DEBUG                    bin gstbin.c:3416:gst_bin_handle_message_func:<video> got ERROR message, unlocking state change
0:00:57.741333443 10590      0x24c8630 DEBUG                    bin gstbin.c:3744:gst_bin_handle_message_func:<video> posting message upward
0:00:57.741341522 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:358:gst_mini_object_ref: 0x27096b0 ref 2->3
0:00:57.741350337 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<bus1> 0x3b095a0 ref 2->3
0:00:57.741359754 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:310:gst_bus_post:<bus1> [msg 0x27096b0] posting on bus error message: 0x27096b0, time 99:99:99.999999999, seq-num 9, element 'uridecodebin0', GstMessageError, gerror=(GError)NULL, debug=(string)"gsturidecodebin.c\(1416\):\ gen_source_element\ \(\):\ /GstPlayBin:video/GstURIDecodeBin:uridecodebin0";
0:00:57.741374981 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:345:gst_bus_post:<bus1> [msg 0x27096b0] pushing on async queue
0:00:57.741382859 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:348:gst_bus_post:<bus1> [msg 0x27096b0] pushed on async queue
0:00:57.741392182 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus1> 0x3b095a0 unref 3->2
0:00:57.741400418 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27096b0 unref 3->2
0:00:57.741410001 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:341:gst_bus_post:<bus0> [msg 0x27096b0] dropped
0:00:57.741417253 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 4->3
0:00:57.741427091 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27096b0 unref 2->1
0:00:57.741435314 10590      0x24c8630 INFO        GST_ERROR_SYSTEM gstelement.c:1858:gst_element_message_full:<uridecodebin0> posted error message: No URI handler implemented for "data".
0:00:57.741447154 10590      0x24c8630 INFO              GST_STATES gstelement.c:2609:gst_element_change_state:<uridecodebin0> have FAILURE change_state return
0:00:57.741455327 10590      0x24c8630 INFO              GST_STATES gstelement.c:2203:gst_element_abort_state:<uridecodebin0> aborting state from READY to PAUSED
0:00:57.741463780 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<uridecodebin0> exit state change 0
0:00:57.741471733 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<uridecodebin0> returned FAILURE
0:00:57.741480713 10590      0x24c8630 INFO              GST_STATES gstbin.c:2689:gst_bin_change_state_func:<video> child 'uridecodebin0' failed to go to state 3(PAUSED)
0:00:57.741489261 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<video> 0x39fbc40 ref 3->4
0:00:57.741497839 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<video> 0x39fbc40 unref 4->3
0:00:57.741507886 10590      0x24c8630 DEBUG                    bin gstbin.c:2127:gst_bin_sort_iterator_free:<video> free
0:00:57.741515120 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<video> 0x39fbc40 unref 3->2
0:00:57.741525097 10590      0x24c8630 DEBUG                    bin gstbin.c:2767:gst_bin_change_state_func:<video> no async elements
0:00:57.741532122 10590      0x24c8630 DEBUG             GST_STATES gstbin.c:2801:gst_bin_change_state_func:<video> done changing bin's state from READY to PAUSED, now in READY, ret FAILURE
0:00:57.741542858 10590      0x24c8630 DEBUG               pipeline gstpipeline.c:280:reset_start_time:<video> reset start_time to 0
0:00:57.741550227 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:5293:deactivate_group:<video> unlinking group 0x39fc0c8
0:00:57.741557716 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:5300:deactivate_group:<video> unlinking combiner audio/
0:00:57.741564627 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:5300:deactivate_group:<video> unlinking combiner video/
0:00:57.741571676 10590      0x24c8630 DEBUG                playbin gstplaybin2.c:5300:deactivate_group:<video> unlinking combiner text/
0:00:57.741578905 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<sink> 0x3c83610 ref 5->6
0:00:57.741587427 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<sink> 0x3c83610 unref 6->5
0:00:57.741596005 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<sink> set_state to NULL
0:00:57.741603663 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<sink> setting target state to NULL
0:00:57.741611175 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<sink> current READY, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:57.741621583 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<sink> final: setting state from READY to NULL
0:00:57.741630893 10590      0x24c8630 LOG               GST_STATES gstelement.c:2797:gst_element_change_state_func:<sink> default handler tries setting state from READY to NULL (0011)
0:00:57.741639638 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:2740:gst_element_pads_activate:<sink> deactivate pads
0:00:57.741649417 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<sink> 0x3c83610 ref 6->7
0:00:57.741659667 10590      0x24c8630 DEBUG               GST_PADS gstpad.c:1026:gst_pad_set_active:<sink:sink> pad was inactive
0:00:57.741667353 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<sink> 0x3c83610 unref 7->6
0:00:57.741677650 10590      0x24c8630 DEBUG       GST_ELEMENT_PADS gstelement.c:2759:gst_element_pads_activate:<sink> pad deactivation successful
0:00:57.788416221 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<xvimageallocator0> 0x27119e0 unref 1->0
0:00:57.788552281 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:369:gst_object_dispose:<xvimageallocator0> dispose
0:00:57.788612872 10590      0x24c8630 DEBUG       xvimageallocator xvimageallocator.c:313:gst_xvimage_allocator_finalize:<xvimageallocator0> finalize
0:00:57.788663775 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x388ebd0 unref 2->1
0:00:57.788752763 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:411:gst_object_finalize:<xvimageallocator0> finalize
0:00:57.788791768 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x388ebd0 unref 1->0
0:00:57.788822125 10590      0x24c8630 LOG                 xcontext xvcontext.c:571:gst_xvcontext_free: free 0x388ebd0
0:00:57.788843546 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x30db590 unref 1->0
0:00:57.788874142 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c12a080
0:00:57.788896010 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x30db590
0:00:57.788912773 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x24e0e30 unref 1->0
0:00:57.788934726 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c112040
0:00:57.788948028 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x24e0e30
0:00:57.788962481 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x7f2480002850 unref 1->0
0:00:57.788980993 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x3959240
0:00:57.788997569 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x7f2480002850
0:00:57.789012443 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2fb35e0 unref 1->0
0:00:57.789031118 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c114880
0:00:57.789043859 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x2fb35e0
0:00:57.789058946 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x31748f0 unref 1->0
0:00:57.789077067 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c118560
0:00:57.789090586 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x31c7520
0:00:57.789106414 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x31ca420
0:00:57.789117555 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c114ba0
0:00:57.789127221 10590      0x24c8630 TRACE               GST_CAPS gstcaps.c:201:_gst_caps_free: freeing caps 0x31748f0
0:00:57.789139171 10590      0x24c8630 DEBUG               xcontext xvcontext.c:611:gst_xvcontext_free: Closing display and freeing X Context
0:00:57.789535873 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<sink> element changed state SUCCESS
0:00:57.789630797 10590      0x24c8630 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<sink> completed state change to NULL
0:00:57.789693846 10590      0x24c8630 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<sink> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:57.789738471 10590      0x24c8630 TRACE              structure gststructure.c:152:gst_structure_new_id_empty_with_size: created structure 0x7f246c115e00
0:00:57.789821163 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:280:gst_message_new_custom: source sink: creating new message 0x2709730 state-changed
0:00:57.789901064 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:254:gst_object_ref:<sink> 0x3c83610 ref 5->6
0:00:57.789979796 10590      0x24c8630 DEBUG            GST_MESSAGE gstelement.c:1697:gst_element_post_message_default:<sink> not posting message 0x2709730: no bus
0:00:57.790020366 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709730 unref 1->0
0:00:57.790041154 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x2709730, state-changed from sink
0:00:57.790066899 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<sink> 0x3c83610 unref 6->5
0:00:57.790096168 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c115e00
0:00:57.790118245 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<sink> exit state change 1
0:00:57.790135258 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<sink> returned SUCCESS
0:00:57.790149874 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<sink> 0x3c83610 unref 5->4
0:00:57.790191100 10590      0x24c8630 DEBUG          GST_PARENTAGE gstbin.c:1613:gst_bin_remove: removing element uridecodebin0 from bin video
0:00:57.790217877 10590      0x24c8630 DEBUG                    bin gstbin.c:1334:gst_bin_remove_func:<video> element :uridecodebin0
0:00:57.790240796 10590      0x24c8630 DEBUG                    bin gstbin.c:1417:gst_bin_remove_func:<video> we removed the last source
0:00:57.790255591 10590      0x24c8630 DEBUG                    bin gstbin.c:1465:gst_bin_remove_func:<playsink> looking at message 0x2709530
0:00:57.790267883 10590      0x24c8630 DEBUG          GST_PARENTAGE gstelement.c:2965:gst_element_set_bus_func:<uridecodebin0> setting bus to (nil)
0:00:57.790279110 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace 0x3b094c0 bus0 (3) with (nil) (NONE) (0)
0:00:57.790298352 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<bus0> 0x3b094c0 unref 3->2
0:00:57.790311660 10590      0x24c8630 DEBUG              GST_CLOCK gstelement.c:405:gst_element_set_clock:<uridecodebin0> setting clock (nil)
0:00:57.790331831 10590      0x24c8630 DEBUG                    bin gstbin.c:724:gst_bin_set_clock_func:<uridecodebin0> iterator done
0:00:57.790361473 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:337:gst_object_replace: replace (nil) (NONE) (0) with (nil) (NONE) (0)
0:00:57.790382920 10590      0x24c8630 INFO           GST_PARENTAGE gstbin.c:1554:gst_bin_remove_func:<video> removed child "uridecodebin0"
0:00:57.790413004 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin0> 0x3e48020 unref 5->4
0:00:57.790429285 10590      0x24c8630 INFO              GST_STATES gstelement.c:2609:gst_element_change_state:<video> have FAILURE change_state return
0:00:57.790444401 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<video> exit state change 0
0:00:57.790462595 10590      0x24c8630 LOG               GST_STATES gstelement.c:2652:gst_element_change_state:<video> exit state change 0
0:00:57.790472141 10590      0x24c8630 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<video> returned FAILURE
0:00:57.790619052 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 8 messages
0:00:57.790675394 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x27092b0, state-changed from streamsynchronizer0, type mask is 4294967295
0:00:57.790700234 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with state-changed message: 0x27092b0, time 99:99:99.999999999, seq-num 0, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.790778961 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27092b0 unref 1->0
0:00:57.790811631 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x27092b0, state-changed from streamsynchronizer0
0:00:57.790836632 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<streamsynchronizer0> 0x2579a10 unref 3->2
0:00:57.790866397 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c110800
0:00:57.790889213 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1
0:00:57.791139662 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 7 messages
0:00:57.791201801 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x2709330, state-changed from playsink, type mask is 4294967295
0:00:57.791219690 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with state-changed message: 0x2709330, time 99:99:99.999999999, seq-num 1, element 'playsink', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.791267283 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709330 unref 1->0
0:00:57.791286523 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x2709330, state-changed from playsink
0:00:57.791302711 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<playsink> 0x25c4040 unref 4->3
0:00:57.791319886 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c105660
0:00:57.791332638 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1
0:00:57.791416601 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 6 messages
0:00:57.791441854 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x27093b0, state-changed from video, type mask is 4294967295
0:00:57.791459516 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with state-changed message: 0x27093b0, time 99:99:99.999999999, seq-num 2, element 'video', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_PLAYING;
0:00:57.791495909 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27093b0 unref 1->0
0:00:57.791511227 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x27093b0, state-changed from video
0:00:57.791526819 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<video> 0x39fbc40 unref 2->1
0:00:57.791541600 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c11c820
0:00:57.791559634 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1
0:00:57.791605725 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 5 messages
0:00:57.791624470 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x2709430, state-changed from sink, type mask is 4294967295
0:00:57.791640236 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with state-changed message: 0x2709430, time 99:99:99.999999999, seq-num 3, element 'sink', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.791672620 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709430 unref 1->0
0:00:57.791687149 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x2709430, state-changed from sink
0:00:57.791700975 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<sink> 0x3c83610 unref 4->3
0:00:57.791714484 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c113520
0:00:57.791728964 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1
0:00:57.791758111 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 4 messages
0:00:57.791776602 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x30278a0, state-changed from uridecodebin0, type mask is 4294967295
0:00:57.791794288 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with state-changed message: 0x30278a0, time 99:99:99.999999999, seq-num 4, element 'uridecodebin0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.791826506 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x30278a0 unref 1->0
0:00:57.791838660 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x30278a0, state-changed from uridecodebin0
0:00:57.791852372 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin0> 0x3e48020 unref 4->3
0:00:57.791862027 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c10ef80
0:00:57.791871580 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1
0:00:57.791901383 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 3 messages
0:00:57.791925860 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x27095b0, state-changed from streamsynchronizer0, type mask is 4294967295
0:00:57.791941517 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with state-changed message: 0x27095b0, time 99:99:99.999999999, seq-num 7, element 'streamsynchronizer0', GstMessageStateChanged, old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_PAUSED, pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:57.791970334 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27095b0 unref 1->0
0:00:57.791983517 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x27095b0, state-changed from streamsynchronizer0
0:00:57.792000590 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<streamsynchronizer0> 0x2579a10 unref 2->1
0:00:57.792012927 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c12a180
0:00:57.792022563 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1
0:00:57.792049537 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 2 messages
0:00:57.792068114 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x2709630, element from uridecodebin0, type mask is 4294967295
0:00:57.792085666 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with element message: 0x2709630, time 99:99:99.999999999, seq-num 8, element 'uridecodebin0', missing-plugin, type=(string)urisource, detail=(string)data, name=(string)"DATA\ protocol\ source";
0:00:57.792124418 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x2709630 unref 1->0
0:00:57.792139559 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x2709630, element from uridecodebin0
0:00:57.792151775 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin0> 0x3e48020 unref 3->2
0:00:57.792164871 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c105b40
0:00:57.792175435 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1
0:00:57.792204253 10590      0x24c8630 LOG                  GST_BUS gstbus.c:497:gst_bus_timed_pop_filtered:<bus1> have 1 messages
0:00:57.792221908 10590      0x24c8630 LOG                 GST_POLL gstpoll.c:201:release_wakeup: 0x31748a0: release
0:00:57.792252697 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:505:gst_bus_timed_pop_filtered:<bus1> got message 0x27096b0, error from uridecodebin0, type mask is 4294967295
0:00:57.792272239 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:773:gst_bus_source_dispatch:<bus1> source 0x2736410 calling dispatch with error message: 0x27096b0, time 99:99:99.999999999, seq-num 9, element 'uridecodebin0', GstMessageError, gerror=(GError)NULL, debug=(string)"gsturidecodebin.c\(1416\):\ gen_source_element\ \(\):\ /GstPlayBin:video/GstURIDecodeBin:uridecodebin0";
0:00:57.792315403 10590      0x24c8630 TRACE        GST_REFCOUNTING gstminiobject.c:438:gst_mini_object_unref: 0x27096b0 unref 1->0
0:00:57.792331634 10590      0x24c8630 LOG              GST_MESSAGE gstmessage.c:182:_gst_message_free: finalize message 0x27096b0, error from uridecodebin0
0:00:57.792352231 10590      0x24c8630 TRACE        GST_REFCOUNTING gstobject.c:280:gst_object_unref:<uridecodebin0> 0x3e48020 unref 2->1
0:00:57.792368049 10590      0x24c8630 TRACE              structure gststructure.c:390:gst_structure_free: free structure 0x7f246c119040
0:00:57.792381255 10590      0x24c8630 DEBUG                GST_BUS gstbus.c:778:gst_bus_source_dispatch:<bus1> source 0x2736410 handler returns 1