0:00:00.001464044 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m            GST_INIT gstquery.c:107:_gst_query_initialize:[00m init queries
0:00:00.002188000 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m            GST_INIT gstmessage.c:73:_gst_message_initialize:[00m init messages
0:00:00.002714805 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:350:_gst_plugin_initialize:[00m registering 0 static plugins
0:00:00.002844010 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:255:gst_plugin_register_static:[00m registered static plugin "staticelements"
0:00:00.002857839 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:257:gst_plugin_register_static:[00m added static plugin "staticelements", result: 1
0:00:00.023016564 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m        GST_REGISTRY gstregistry.c:1561:scan_and_update_registry:[00m Registry cache has not changed
0:00:00.023030601 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m        GST_REGISTRY gstregistry.c:1628:ensure_current_registry:[00m registry reading and updating done, result = 1
0:00:00.023040169 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m            GST_INIT gst.c:792:init_post:[00m GLib runtime version: 2.26.1
0:00:00.023050715 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m            GST_INIT gst.c:794:init_post:[00m GLib headers version: 2.26.1
0:00:00.307814640 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstplaybin.so" loaded
0:00:00.307839224 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "playbin2" named "play"
0:00:00.308636522 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstgconfelements.so" loaded
0:00:00.308652865 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "gconfaudiosink" named "audio-sink"
0:00:00.308788774 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstSwitchSink@0x159b220>[00m adding pad 'sink'
0:00:00.309570499 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
0:00:00.309589775 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "fakesink" named "testsink"
0:00:00.309743773 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x18cb260>[00m adding pad 'sink'
0:00:00.309801950 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<testsink>[00m completed state change to NULL
0:00:00.309840223 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad testsink:sink
0:00:00.309857473 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad0 and testsink:sink
0:00:00.309870464 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad0 and testsink:sink, successful
0:00:00.310593661 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "gconfvideosink" named "video-sink"
0:00:00.310670905 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstSwitchSink@0x159b580>[00m adding pad 'sink'
0:00:00.310686060 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "fakesink" named "testsink"
0:00:00.310717488 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x18d3db0>[00m adding pad 'sink'
0:00:00.310749754 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<testsink>[00m completed state change to NULL
0:00:00.310770846 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad testsink:sink
0:00:00.310783836 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad1 and testsink:sink
0:00:00.310795919 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad1 and testsink:sink, successful
0:00:00.314444173 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m        GST_PIPELINE gstparse.c:299:gst_parse_launch_full:[00m parsing pipeline description 'bin.( xvimagesink device="0" )'
0:00:00.315360618 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstxvimagesink.so" loaded
0:00:00.315383735 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "xvimagesink"
0:00:00.315606457 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x18d2000>[00m adding pad 'sink'
0:00:00.315661211 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "bin"
0:00:00.315768836 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad2 and xvimagesink0:sink
0:00:00.315784550 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad2 and xvimagesink0:sink, successful
0:00:00.315797611 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<bin0>[00m adding pad 'sink'
0:00:00.326196987 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<xvimagesink0>[00m completed state change to READY
0:00:00.326231348 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<xvimagesink0>[00m posting state-changed NULL to READY
0:00:00.326271157 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<bin0>[00m child 'xvimagesink0' changed state to 2(READY) successfully
0:00:00.326296579 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<bin0>[00m completed state change to READY
0:00:00.326310966 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<bin0>[00m posting state-changed NULL to READY
0:00:00.326366350 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<testsink>[00m completed state change to NULL
0:00:00.326388908 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking sink:proxypad1(0x159b730) and testsink:sink(0x15ac480)
0:00:00.326409721 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked sink:proxypad1 and testsink:sink
0:00:00.326428019 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:<video-sink>[00m removed child "testsink"
0:00:00.326448482 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:<testsink>[00m dispose
0:00:00.326463079 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:<testsink>[00m removing pad 'sink'
0:00:00.326492412 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:<testsink>[00m parent class dispose
0:00:00.326515180 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:<testsink>[00m finalize
0:00:00.326529707 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:<testsink>[00m finalize parent
0:00:00.326545141 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad bin0:sink
0:00:00.326561554 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad1 and bin0:sink
0:00:00.326577757 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad1 and bin0:sink, successful
0:00:00.326602690 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<bin0>[00m skipping transition from READY to  READY, since bin pending is READY : last change state return follows
0:00:00.326619451 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<video-sink>[00m child 'bin0' changed state to 2(READY) successfully
0:00:00.326636283 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<video-sink>[00m completed state change to READY
0:00:00.326649972 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<video-sink>[00m posting state-changed NULL to READY
0:00:00.326705704 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m        GST_PIPELINE gstparse.c:299:gst_parse_launch_full:[00m parsing pipeline description 'bin.( pulsesink )'
0:00:00.339414982 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstpulse.so" loaded
0:00:00.339442360 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "pulsesink"
0:00:00.339690922 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x18f7550>[00m adding pad 'sink'
0:00:00.339824526 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "bin"
0:00:00.339913293 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad3 and pulsesink0:sink
0:00:00.339928169 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad3 and pulsesink0:sink, successful
0:00:00.339941299 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<bin1>[00m adding pad 'sink'
0:00:00.339973356 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m               pulse pulsesink.c:2727:gst_pulsesink_change_state:<pulsesink0>[00m new pa main loop thread
0:00:00.340100186 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m               pulse pulsesink.c:463:gst_pulseringbuffer_open_device:<pulsesink0>[00m new context with name Lecteur vidéo Totem, pbuf=0x159bc40, pctx=0x1847760
0:00:00.342401637 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<pulsesink0>[00m completed state change to READY
0:00:00.342421891 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<pulsesink0>[00m posting state-changed NULL to READY
0:00:00.342445986 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<bin1>[00m child 'pulsesink0' changed state to 2(READY) successfully
0:00:00.342461840 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<bin1>[00m completed state change to READY
0:00:00.342472456 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<bin1>[00m posting state-changed NULL to READY
0:00:00.342513242 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<testsink>[00m completed state change to NULL
0:00:00.342527350 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking sink:proxypad0(0x159b3d0) and testsink:sink(0x15ac300)
0:00:00.342542645 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked sink:proxypad0 and testsink:sink
0:00:00.342556613 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:<audio-sink>[00m removed child "testsink"
0:00:00.342572677 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:<testsink>[00m dispose
0:00:00.342583921 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:<testsink>[00m removing pad 'sink'
0:00:00.342599076 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:<testsink>[00m parent class dispose
0:00:00.342611787 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:<testsink>[00m finalize
0:00:00.342622822 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:<testsink>[00m finalize parent
0:00:00.342638117 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad bin1:sink
0:00:00.342650828 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad0 and bin1:sink
0:00:00.342663329 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad0 and bin1:sink, successful
0:00:00.342681558 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<bin1>[00m skipping transition from READY to  READY, since bin pending is READY : last change state return follows
0:00:00.342694059 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audio-sink>[00m child 'bin1' changed state to 2(READY) successfully
0:00:00.342707329 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audio-sink>[00m completed state change to READY
0:00:00.342718294 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audio-sink>[00m posting state-changed NULL to READY
0:00:00.342831924 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m               pulse pulsesink.c:2764:gst_pulsesink_change_state:<pulsesink0>[00m terminating pa main loop thread
0:00:00.342974608 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<pulsesink0>[00m completed state change to NULL
0:00:00.342995071 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<pulsesink0>[00m posting state-changed READY to NULL
0:00:00.343011973 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<bin1>[00m child 'pulsesink0' changed state to 1(NULL) successfully
0:00:00.343031109 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<bin1>[00m completed state change to NULL
0:00:00.343042633 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<bin1>[00m posting state-changed READY to NULL
0:00:00.343057578 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audio-sink>[00m child 'bin1' changed state to 1(NULL) successfully
0:00:00.343076435 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "fakesink" named "testsink"
0:00:00.343119667 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x7f0498004860>[00m adding pad 'sink'
0:00:00.343155495 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<testsink>[00m completed state change to NULL
0:00:00.343181336 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<pulsesink0>[00m skipping transition from NULL to  NULL, since bin pending is NULL : last change state return follows
0:00:00.343193837 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<bin1>[00m child 'pulsesink0' changed state to 1(NULL) successfully
0:00:00.343206618 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<bin1>[00m completed state change to NULL
0:00:00.343221494 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking sink:proxypad0(0x159b3d0) and bin1:sink(0x18ce540)
0:00:00.343235532 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked sink:proxypad0 and bin1:sink
0:00:00.343249151 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:<audio-sink>[00m removed child "bin1"
0:00:00.343265703 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking sink:proxypad3(0x159ba90) and pulsesink0:sink(0x15ac780)
0:00:00.343279322 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked sink:proxypad3 and pulsesink0:sink
0:00:00.343292591 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:<bin1>[00m removed child "pulsesink0"
0:00:00.343324369 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:<pulsesink0>[00m dispose
0:00:00.343336381 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:<pulsesink0>[00m removing pad 'sink'
0:00:00.343350559 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:<pulsesink0>[00m parent class dispose
0:00:00.343363479 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:<pulsesink0>[00m finalize
0:00:00.343374444 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:<pulsesink0>[00m finalize parent
0:00:00.343385689 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:<bin1>[00m dispose
0:00:00.343395885 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:<bin1>[00m removing pad 'sink'
0:00:00.343416837 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:<bin1>[00m parent class dispose
0:00:00.343428640 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:<bin1>[00m finalize
0:00:00.343439396 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:<bin1>[00m finalize parent
0:00:00.343450151 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad testsink:sink
0:00:00.343461675 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad0 and testsink:sink
0:00:00.343473268 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad0 and testsink:sink, successful
0:00:00.343485700 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audio-sink>[00m completed state change to NULL
0:00:00.343495827 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audio-sink>[00m posting state-changed READY to NULL
0:00:00.343511331 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "capsfilter" named "audiofilter"
0:00:00.343617978 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x18c8630>[00m adding pad 'sink'
0:00:00.343651012 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x18c8630>[00m adding pad 'src'
0:00:00.343675387 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "bin" named "audiosinkbin"
0:00:00.343733145 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full:[00m trying to link element audiofilter:src to element audio-sink:sink
0:00:00.343747392 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad audiofilter:src
0:00:00.343758427 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad audio-sink:sink
0:00:00.343769112 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting:[00m audiofilter and audio-sink in same bin, no need for ghost pads
0:00:00.343787271 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link audiofilter:src and audio-sink:sink
0:00:00.343816115 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked audiofilter:src and audio-sink:sink, successful
0:00:00.343837486 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad audiofilter:sink
0:00:00.343884838 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad4 and audiofilter:sink
0:00:00.343898108 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad4 and audiofilter:sink, successful
0:00:00.343913123 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<audiosinkbin>[00m adding pad 'sink'
0:00:00.343937009 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m            playbin2 gstplaybin2.c:1726:gst_play_bin_set_sink:<play>[00m Setting video sink to <video-sink>
0:00:00.343957891 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m            playbin2 gstplaybin2.c:1726:gst_play_bin_set_sink:<play>[00m Setting audio sink to <audiosinkbin>
0:00:00.343994348 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:1759:gst_bin_get_state_func:<video-sink>[00m getting state
0:00:00.345159495 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m               totem bacon-video-widget-gst-missing-plugins.c:328:bacon_video_widget_gst_missing_plugins_setup:[00m Set up support for automatic missing plugin installation
0:00:00.362425720 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstgoom.so" loaded
0:00:00.362452888 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "goom" named "vis"
0:00:00.362608143 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstGoom@0x19071c0>[00m adding pad 'sink'
0:00:00.362658288 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstGoom@0x19071c0>[00m adding pad 'src'
0:00:00.362868648 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m                goom plugin_info.c:69:setOptimizedMethods:[00m orc cpu flags: 0x00000233
0:00:00.480280502 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:1759:gst_bin_get_state_func:<play>[00m getting state
0:00:00.500259886 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<streamsynchronizer0>[00m completed state change to READY
0:00:00.500291943 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<streamsynchronizer0>[00m posting state-changed NULL to READY
0:00:00.500331402 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<playsink0>[00m child 'streamsynchronizer0' changed state to 2(READY) successfully
0:00:00.500348653 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<playsink0>[00m completed state change to READY
0:00:00.500360805 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<playsink0>[00m posting state-changed NULL to READY
0:00:00.500379383 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<play>[00m child 'playsink0' changed state to 2(READY) successfully
0:00:00.500394329 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<play>[00m completed state change to READY
0:00:00.500406271 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<play>[00m posting state-changed NULL to READY
0:00:00.501136383 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstdecodebin2.so" loaded
0:00:00.501160827 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "uridecodebin"
0:00:00.501414697 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<uridecodebin0>[00m completed state change to READY
0:00:00.501430620 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<uridecodebin0>[00m posting state-changed NULL to READY
0:00:00.501459325 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m            playsink gstplaysink.c:1035:do_async_start:<playsink0>[00m Sending async_start message
0:00:00.501483559 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<streamsynchronizer0>[00m completed state change to PAUSED
0:00:00.501497108 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<streamsynchronizer0>[00m posting state-changed READY to PAUSED
0:00:00.501516594 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<playsink0>[00m child 'streamsynchronizer0' changed state to 3(PAUSED) successfully
0:00:00.501534263 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2498:gst_bin_change_state_func:<play>[00m child 'playsink0' is changing state asynchronously to PAUSED
0:00:00.501752165 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "filesrc" named "source"
0:00:00.501891427 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x1a12060>[00m adding pad 'src'
0:00:00.501970906 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "decodebin2"
0:00:00.502106815 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "typefind" named "typefind"
0:00:00.502226801 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstTypeFindElement@0x1445af0>[00m adding pad 'sink'
0:00:00.502269194 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstTypeFindElement@0x1445af0>[00m adding pad 'src'
0:00:00.502294127 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad typefind:sink
0:00:00.502358729 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad5 and typefind:sink
0:00:00.502406640 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad5 and typefind:sink, successful
0:00:00.502423751 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstDecodeBin2@0x19c0150>[00m adding pad 'sink'
0:00:00.502501274 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full:[00m trying to link element source:(any) to element decodebin20:sink
0:00:00.502517547 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad decodebin20:sink
0:00:00.502531725 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting:[00m source and decodebin20 in same bin, no need for ghost pads
0:00:00.502549743 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link source:src and decodebin20:sink
0:00:00.502567273 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked source:src and decodebin20:sink, successful
0:00:00.502600168 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<typefind>[00m completed state change to READY
0:00:00.502613577 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<typefind>[00m posting state-changed NULL to READY
0:00:00.502634599 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'typefind' changed state to 2(READY) successfully
0:00:00.502650453 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2314:gst_element_continue_state:<decodebin20>[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.502669659 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2323:gst_element_continue_state:<decodebin20>[00m continue state change READY to PAUSED, final PAUSED
0:00:00.502703741 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m             filesrc gstfilesrc.c:963:gst_file_src_start:<source>[00m opening file /dev/shm/test.mp3
0:00:00.502749417 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m             filesrc gstfilesrc.c:963:gst_file_src_start:<source>[00m opening file /dev/shm/test.mp3
0:00:00.503442024 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-ms-asf
0:00:00.503521991 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-musepack
0:00:00.503563966 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-au
0:00:00.503597559 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-msvideo
0:00:00.503629616 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/qcelp
0:00:00.503662161 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-cdxa
0:00:00.503696732 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-vcd
0:00:00.503728789 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-imelody
0:00:00.503761125 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/midi
0:00:00.503793461 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/riff-midi
0:00:00.503825867 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/mobile-xmf
0:00:00.503858203 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-fli
0:00:00.503890958 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-id3v2
0:00:00.503925669 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-id3v1
0:00:00.503958634 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-apetag
0:00:00.503991668 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-ttafile
0:00:00.504023725 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-mod
0:00:00.504061369 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/mpeg
0:00:00.504096359 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-ac3
0:00:00.504128974 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-dts
0:00:00.504165710 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-gsm
0:00:00.504207405 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg-sys
0:00:00.504244141 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpegts
0:00:00.504282064 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/ogg
0:00:00.504316356 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg-elementary
0:00:00.504347784 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg4
0:00:00.504378514 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-h264
0:00:00.504410641 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-nuv
0:00:00.504442278 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-m4a
0:00:00.504474405 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-3gp
0:00:00.504510722 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/quicktime
0:00:00.504543128 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-quicktime
0:00:00.504575743 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/jp2
0:00:00.504608359 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mj2
0:00:00.504642930 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/html
0:00:00.504676383 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/vnd.rn-realmedia
0:00:00.504709488 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-pn-realaudio
0:00:00.504743290 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-shockwave-flash
0:00:00.504775417 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-flv
0:00:00.504807683 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/plain
0:00:00.504839740 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/uri-list
0:00:00.504873892 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/sdp
0:00:00.504911536 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/smil
0:00:00.504944850 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/xml
0:00:00.504977675 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-wav
0:00:00.505010011 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-aiff
0:00:00.505042766 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-svx
0:00:00.505074962 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-paris
0:00:00.505109533 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-nist
0:00:00.505141590 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-voc
0:00:00.505173787 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-sds
0:00:00.505205774 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-ircam
0:00:00.505241183 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-w64
0:00:00.505273449 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-shorten
0:00:00.505305785 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ape
0:00:00.505341264 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/jpeg
0:00:00.505377721 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/gif
0:00:00.505409987 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/png
0:00:00.505445256 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/bmp
0:00:00.505483180 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/tiff
0:00:00.505519566 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-portable-pixmap
0:00:00.505552391 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-matroska
0:00:00.505587591 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/webm
0:00:00.505624886 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/mxf
0:00:00.505657292 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-mve
0:00:00.505694237 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-dv
0:00:00.505748015 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-amr-nb-sh
0:00:00.505780770 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-amr-wb-sh
0:00:00.505813455 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/iLBC-sh
0:00:00.505847957 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-sid
0:00:00.505880432 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-xcf
0:00:00.505912419 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-mng
0:00:00.505944546 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-jng
0:00:00.505976463 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-xpixmap
0:00:00.506008101 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-sun-raster
0:00:00.506040157 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-bzip
0:00:00.506074589 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-gzip
0:00:00.506106645 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/zip
0:00:00.506138423 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-compress
0:00:00.506173273 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for subtitle/x-kate
0:00:00.506205470 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-flac
0:00:00.506238504 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-vorbis
0:00:00.506269862 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-theora
0:00:00.506302129 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ogm-video
0:00:00.506337887 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ogm-audio
0:00:00.506370502 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ogm-text
0:00:00.506402769 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-speex
0:00:00.506434825 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-celt
0:00:00.506468698 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ogg-skeleton
0:00:00.506501313 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/x-cmml
0:00:00.506539307 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-executable
0:00:00.506576462 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/aac
0:00:00.506609706 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-spc
0:00:00.506643439 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-wavpack
0:00:00.506678289 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-wavpack-correction
0:00:00.506711603 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/postscript
0:00:00.506744637 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/svg+xml
0:00:00.506779278 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-rar
0:00:00.506812313 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-tar
0:00:00.506845906 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ar
0:00:00.506879499 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ms-dos-executable
0:00:00.506912254 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-dirac
0:00:00.506944381 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for multipart/x-mixed-replace
0:00:00.506976996 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-mmsh
0:00:00.507010869 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/vivo
0:00:00.507049910 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-nsf
0:00:00.507082316 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-gym
0:00:00.507113884 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-ay
0:00:00.507145032 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-gbs
0:00:00.507175972 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-vgm
0:00:00.507207330 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-sap
0:00:00.507243158 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-ivf
0:00:00.507275005 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-kss
0:00:00.507306713 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/pdf
0:00:00.507338630 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/msword
0:00:00.507370407 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/octet-stream
0:00:00.507402115 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/vnd.adobe.photoshop
0:00:00.507434172 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-yuv4mpeg
0:00:00.507466787 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for xdgmime-base
0:00:00.507498914 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgsttypefindfunctions.so" loaded
0:00:00.507663039 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32;43m            typefind gsttypefindelement.c:170:gst_type_find_element_have_type:<typefind>[00m found caps application/x-id3, probability=100
0:00:00.507706340 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad typefind:src
0:00:00.507721076 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad typefind:sink
0:00:00.507830586 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link typefind:src and decodepad0:proxypad6
0:00:00.507847906 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked typefind:src and decodepad0:proxypad6, successful
0:00:00.511664056 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking typefind:src(0x19ab920) and decodepad0:proxypad6(0x159bdf0)
0:00:00.511718671 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked typefind:src and decodepad0:proxypad6
0:00:00.511749331 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link typefind:src and decodepad0:proxypad6
0:00:00.511764835 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked typefind:src and decodepad0:proxypad6, successful
0:00:00.511795007 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking typefind:src(0x19ab920) and decodepad0:proxypad6(0x159bdf0)
0:00:00.511814841 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked typefind:src and decodepad0:proxypad6
0:00:00.512698951 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstid3demux.so" loaded
0:00:00.512724094 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "id3demux"
0:00:00.512852810 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstTagDemux@0x15181f0>[00m adding pad 'sink'
0:00:00.512891711 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<id3demux0>[00m completed state change to READY
0:00:00.512905050 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<id3demux0>[00m posting state-changed NULL to READY
0:00:00.512941996 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link typefind:src and id3demux0:sink
0:00:00.512959037 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked typefind:src and id3demux0:sink, successful
0:00:00.512981525 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:960:gst_element_get_static_pad:[00m no such pad 'src' in element "id3demux0"
0:00:00.513019030 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m             filesrc gstfilesrc.c:963:gst_file_src_start:<source>[00m opening file /dev/shm/test.mp3
0:00:00.513054090 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m             filesrc gstfilesrc.c:963:gst_file_src_start:<source>[00m opening file /dev/shm/test.mp3
0:00:00.513121835 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m            id3demux gstid3demux.c:154:gst_id3demux_identify_tag:<id3demux0>[00m Found ID3v1 marker, tag_size = 128
0:00:00.513919622 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;32;41m   typefindfunctions gsttypefindfunctions.c:1068:mp3_type_find_at_offset:[00m audio/mpeg calculated 100  =  100  *  5 / 5  *  (10000 - 0) / 10000
0:00:00.514027525 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<id3demux0>[00m adding pad 'src'
0:00:00.514120413 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link id3demux0:src and decodepad1:proxypad7
0:00:00.514137105 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked id3demux0:src and decodepad1:proxypad7, successful
0:00:00.514407946 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking id3demux0:src(0x19abc20) and decodepad1:proxypad7(0x19f1050)
0:00:00.514430085 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked id3demux0:src and decodepad1:proxypad7
0:00:00.514455786 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link id3demux0:src and decodepad1:proxypad7
0:00:00.514469894 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked id3demux0:src and decodepad1:proxypad7, successful
0:00:00.514497900 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking id3demux0:src(0x19abc20) and decodepad1:proxypad7(0x19f1050)
0:00:00.514517386 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked id3demux0:src and decodepad1:proxypad7
0:00:00.515093359 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstaudioparsersbad.so" loaded
0:00:00.515113124 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "mpegaudioparse"
0:00:00.515225916 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstAudioBaseParseBad@0x1375100>[00m adding pad 'sink'
0:00:00.515259719 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstAudioBaseParseBad@0x1375100>[00m adding pad 'src'
0:00:00.515292055 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<mpegaudioparse0>[00m completed state change to READY
0:00:00.515305954 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<mpegaudioparse0>[00m posting state-changed NULL to READY
0:00:00.515338290 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link id3demux0:src and mpegaudioparse0:sink
0:00:00.515355401 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked id3demux0:src and mpegaudioparse0:sink, successful
0:00:00.515376842 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad mpegaudioparse0:src
0:00:00.515452479 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link mpegaudioparse0:src and decodepad2:proxypad8
0:00:00.515468472 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked mpegaudioparse0:src and decodepad2:proxypad8, successful
0:00:00.515500040 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking mpegaudioparse0:src(0x19d80a0) and decodepad2:proxypad8(0x19f1200)
0:00:00.515520503 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked mpegaudioparse0:src and decodepad2:proxypad8
0:00:00.516055970 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstcoreindexers.so" loaded
0:00:00.516142363 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m             filesrc gstfilesrc.c:963:gst_file_src_start:<source>[00m opening file /dev/shm/test.mp3
0:00:00.516182241 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00m             filesrc gstfilesrc.c:963:gst_file_src_start:<source>[00m opening file /dev/shm/test.mp3
0:00:00.516208152 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;34m           GST_EVENT gstevent.c:599:gst_event_new_new_segment_full:[00m creating newsegment update 0, rate 1,000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
0:00:00.516312145 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<mpegaudioparse0>[00m completed state change to PAUSED
0:00:00.516332538 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<mpegaudioparse0>[00m posting state-changed READY to PAUSED
0:00:00.516388061 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<id3demux0>[00m completed state change to PAUSED
0:00:00.516404893 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<id3demux0>[00m posting state-changed READY to PAUSED
0:00:00.516454270 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<typefind>[00m completed state change to PAUSED
0:00:00.516469286 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<typefind>[00m posting state-changed READY to PAUSED
0:00:00.516491495 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'typefind' changed state to 3(PAUSED) successfully
0:00:00.516512866 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<mpegaudioparse0>[00m skipping transition from PAUSED to  PAUSED, since bin pending is PAUSED : last change state return follows
0:00:00.516527672 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'mpegaudioparse0' changed state to 3(PAUSED) successfully
0:00:00.516542129 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<id3demux0>[00m skipping transition from PAUSED to  PAUSED, since bin pending is PAUSED : last change state return follows
0:00:00.516555329 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'id3demux0' changed state to 3(PAUSED) successfully
0:00:00.516569227 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<typefind>[00m skipping transition from PAUSED to  PAUSED, since bin pending is PAUSED : last change state return follows
0:00:00.516582567 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'typefind' changed state to 3(PAUSED) successfully
0:00:00.516600655 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2498:gst_bin_change_state_func:<uridecodebin0>[00m child 'decodebin20' is changing state asynchronously to PAUSED
0:00:00.516617277 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2314:gst_element_continue_state:<source>[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.516628103 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link mpegaudioparse0:src and decodepad3:proxypad9
0:00:00.516637810 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2323:gst_element_continue_state:<source>[00m continue state change READY to PAUSED, final PAUSED
0:00:00.516664559 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked mpegaudioparse0:src and decodepad3:proxypad9, successful
0:00:00.516674826 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<source>[00m completed state change to PAUSED
0:00:00.516688095 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<source>[00m posting state-changed READY to PAUSED
0:00:00.516708210 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<uridecodebin0>[00m child 'source' changed state to 3(PAUSED) successfully
0:00:00.516726228 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2498:gst_bin_change_state_func:<play>[00m child 'uridecodebin0' is changing state asynchronously to PAUSED
0:00:00.517929718 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:1759:gst_bin_get_state_func:<play>[00m getting state
0:00:00.518209569 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking mpegaudioparse0:src(0x19d80a0) and decodepad3:proxypad9(0x19f1560)
0:00:00.518239181 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked mpegaudioparse0:src and decodepad3:proxypad9
0:00:00.518287510 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link mpegaudioparse0:src and decodepad3:proxypad9
0:00:00.518303155 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked mpegaudioparse0:src and decodepad3:proxypad9, successful
0:00:00.518338354 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking mpegaudioparse0:src(0x19d80a0) and decodepad3:proxypad9(0x19f1560)
0:00:00.518359446 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked mpegaudioparse0:src and decodepad3:proxypad9
0:00:00.519715747 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstmad.so" loaded
0:00:00.519740051 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "mad"
0:00:00.519904176 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstMad@0x1897a10>[00m adding pad 'sink'
0:00:00.519951808 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstMad@0x1897a10>[00m adding pad 'src'
0:00:00.519981001 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<mad0>[00m completed state change to READY
0:00:00.520805537 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<mad0>[00m posting state-changed NULL to READY
0:00:00.520858266 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link mpegaudioparse0:src and mad0:sink
0:00:00.520887459 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked mpegaudioparse0:src and mad0:sink, successful
0:00:00.520911205 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad mad0:src
0:00:00.520998855 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link mad0:src and decodepad4:proxypad10
0:00:00.521014709 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked mad0:src and decodepad4:proxypad10, successful
0:00:00.521072048 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<mad0>[00m completed state change to PAUSED
0:00:00.521086365 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<mad0>[00m posting state-changed READY to PAUSED
0:00:00.521174923 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<decodebin20>[00m adding pad 'src0'
0:00:00.521255309 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link decodebin20:src0 and src0:proxypad11
0:00:00.521271651 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked decodebin20:src0 and src0:proxypad11, successful
0:00:00.521295677 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<uridecodebin0>[00m adding pad 'src0'
0:00:00.521326965 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "input-selector"
0:00:00.521428653 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstInputSelector@0x16e3330>[00m adding pad 'src'
0:00:00.521468951 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2314:gst_element_continue_state:<inputselector0>[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.521490671 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2323:gst_element_continue_state:<inputselector0>[00m continue state change READY to PAUSED, final PAUSED
0:00:00.521507014 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<inputselector0>[00m completed state change to PAUSED
0:00:00.521519236 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<inputselector0>[00m posting state-changed READY to PAUSED
0:00:00.521537674 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad inputselector0:src
0:00:00.521601368 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<inputselector0>[00m adding pad 'sink0'
0:00:00.521630491 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link uridecodebin0:src0 and inputselector0:sink0
0:00:00.521660383 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked uridecodebin0:src0 and inputselector0:sink0, successful
0:00:00.521741538 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "tee" named "audiotee"
0:00:00.521851606 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstTee@0x1a14140>[00m adding pad 'sink'
0:00:00.521875212 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad audiotee:sink
0:00:00.521897771 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2314:gst_element_continue_state:<audiotee>[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.521919142 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2323:gst_element_continue_state:<audiotee>[00m continue state change READY to PAUSED, final PAUSED
0:00:00.521935205 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audiotee>[00m completed state change to PAUSED
0:00:00.521947707 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audiotee>[00m posting state-changed READY to PAUSED
0:00:00.521997503 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link audio_raw_sink:proxypad12 and audiotee:sink
0:00:00.522012449 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked audio_raw_sink:proxypad12 and audiotee:sink, successful
0:00:00.522027814 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<playsink0>[00m adding pad 'audio_raw_sink'
0:00:00.522045623 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link inputselector0:src and playsink0:audio_raw_sink
0:00:00.522065318 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked inputselector0:src and playsink0:audio_raw_sink, successful
0:00:00.522086968 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m            playbin2 gstplaybin2.c:2746:no_more_pads_cb:<play>[00m setting default audio sink <audiosinkbin>
0:00:00.522102473 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m            playbin2 gstplaybin2.c:2757:no_more_pads_cb:<play>[00m setting default video sink <video-sink>
0:00:00.522141164 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m        GST_PIPELINE gstparse.c:299:gst_parse_launch_full:[00m parsing pipeline description 'bin.( pulsesink )'
0:00:00.522161488 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "pulsesink"
0:00:00.522204859 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x137e000>[00m adding pad 'sink'
0:00:00.522320794 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create:[00m creating element "bin"
0:00:00.522416266 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad13 and pulsesink1:sink
0:00:00.522432469 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad13 and pulsesink1:sink, successful
0:00:00.522446856 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<bin2>[00m adding pad 'sink'
0:00:00.522475770 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m               pulse pulsesink.c:2727:gst_pulsesink_change_state:<pulsesink1>[00m new pa main loop thread
0:00:00.522579134 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m               pulse pulsesink.c:463:gst_pulseringbuffer_open_device:<pulsesink1>[00m new context with name Lecteur vidéo Totem, pbuf=0x19f1c20, pctx=0x1a22060

** (totem:8144): WARNING **: chapters: failed to load CMML file file:///dev/shm/test.cmml: Erreur à l'ouverture du fichier : Aucun fichier ou dossier de ce type
0:00:00.567591067 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<pulsesink1>[00m completed state change to READY
0:00:00.567618235 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<pulsesink1>[00m posting state-changed NULL to READY
0:00:00.567647987 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<bin2>[00m child 'pulsesink1' changed state to 2(READY) successfully
0:00:00.567667054 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<bin2>[00m completed state change to READY
0:00:00.567679415 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<bin2>[00m posting state-changed NULL to READY
0:00:00.567728932 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<testsink>[00m completed state change to NULL
0:00:00.567744786 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1713:gst_pad_unlink:[00m unlinking sink:proxypad0(0x159b3d0) and testsink:sink(0x15ac900)
0:00:00.567761827 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1758:gst_pad_unlink:[00m unlinked sink:proxypad0 and testsink:sink
0:00:00.567777751 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:1440:gst_bin_remove_func:<audio-sink>[00m removed child "testsink"
0:00:00.567794862 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2955:gst_element_dispose:<testsink>[00m dispose
0:00:00.567807503 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:835:gst_element_remove_pad:<testsink>[00m removing pad 'sink'
0:00:00.567825452 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2979:gst_element_dispose:<testsink>[00m parent class dispose
0:00:00.567840258 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3010:gst_element_finalize:<testsink>[00m finalize
0:00:00.567852829 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:3021:gst_element_finalize:<testsink>[00m finalize parent
0:00:00.567865959 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad bin2:sink
0:00:00.567880067 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad0 and bin2:sink
0:00:00.567894175 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad0 and bin2:sink, successful
0:00:00.567914778 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<bin2>[00m skipping transition from READY to  READY, since bin pending is READY : last change state return follows
0:00:00.567928955 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audio-sink>[00m child 'bin2' changed state to 2(READY) successfully
0:00:00.567950047 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audio-sink>[00m completed state change to READY
0:00:00.567962269 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audio-sink>[00m posting state-changed NULL to READY
0:00:00.567978961 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audiosinkbin>[00m child 'audio-sink' changed state to 2(READY) successfully
0:00:00.567996142 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audiofilter>[00m completed state change to READY
0:00:00.568008364 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audiofilter>[00m posting state-changed NULL to READY
0:00:00.568023519 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audiosinkbin>[00m child 'audiofilter' changed state to 2(READY) successfully
0:00:00.568038674 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audiosinkbin>[00m completed state change to READY
0:00:00.568050757 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audiosinkbin>[00m posting state-changed NULL to READY
0:00:00.568069195 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "bin" named "abin"
0:00:00.568121575 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "queue" named "aqueue"
0:00:00.568300366 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x1a98030>[00m adding pad 'sink'
0:00:00.568344226 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x1a98030>[00m adding pad 'src'
0:00:00.568380683 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m            playsink gstplaysink.c:968:find_property:<pulsesink1>[00m found ts-offset with sink property
0:00:00.568399819 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m            playsink gstplaysink.c:968:find_property:<pulsesink1>[00m found volume with sink property
0:00:00.568421540 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m            playsink gstplaysink.c:968:find_property:<pulsesink1>[00m found mute with sink property
0:00:00.580487798 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstaudioconvert.so" loaded
0:00:00.580523626 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "audioconvert" named "aconv"
0:00:00.580786575 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1bf8030>[00m adding pad 'sink'
0:00:00.580819400 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1bf8030>[00m adding pad 'src'
0:00:00.580855438 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full:[00m trying to link element aqueue:src to element aconv:sink
0:00:00.580870943 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad aqueue:src
0:00:00.580889520 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad aconv:sink
0:00:00.580902301 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting:[00m aqueue and aconv in same bin, no need for ghost pads
0:00:00.580924859 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link aqueue:src and aconv:sink
0:00:00.580941761 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked aqueue:src and aconv:sink, successful
0:00:00.582746786 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m       audioresample gstaudioresample.c:1556:_benchmark_integer_resampling:[00m Using integer resampler if appropiate: 81900,000000 < 109725,333333
0:00:00.582794068 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstaudioresample.so" loaded
0:00:00.582809852 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:369:gst_element_factory_create:[00m creating element "audioresample" named "aresample"
0:00:00.583005754 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1bfc090>[00m adding pad 'sink'
0:00:00.583037601 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x1bfc090>[00m adding pad 'src'
0:00:00.583073499 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full:[00m trying to link element aconv:src to element aresample:sink
0:00:00.583089213 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad aconv:src
0:00:00.583102343 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad aresample:sink
0:00:00.583114286 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting:[00m aconv and aresample in same bin, no need for ghost pads
0:00:00.583135168 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link aconv:src and aresample:sink
0:00:00.583154863 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked aconv:src and aresample:sink, successful
0:00:00.583175746 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full:[00m trying to link element aresample:src to element audiosinkbin:(any)
0:00:00.583189574 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad aresample:src
0:00:00.583204520 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstutils.c:1028:gst_pad_check_link:[00m trying to link aresample:src and audiosinkbin:sink
0:00:00.584166292 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting:[00m aresample and audiosinkbin in same bin, no need for ghost pads
0:00:00.584190527 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link aresample:src and audiosinkbin:sink
0:00:00.584211898 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked aresample:src and audiosinkbin:sink, successful
0:00:00.584233409 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:963:gst_element_get_static_pad:[00m found pad aqueue:sink
0:00:00.584290608 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link sink:proxypad14 and aqueue:sink
0:00:00.584306112 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked sink:proxypad14 and aqueue:sink, successful
0:00:00.584320919 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<abin>[00m adding pad 'sink'
0:00:00.584399140 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<streamsynchronizer0>[00m adding pad 'src_0'
0:00:00.584414924 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<streamsynchronizer0>[00m adding pad 'sink_0'
0:00:00.584449285 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<audiotee>[00m adding pad 'src0'
0:00:00.584497336 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2213:gst_bin_element_set_state:<audiosinkbin>[00m skipping transition from READY to  READY, since bin pending is PAUSED : last change state return follows
0:00:00.584513189 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'audiosinkbin' changed state to 2(READY) successfully
0:00:00.584529183 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aresample>[00m completed state change to READY
0:00:00.584541824 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aresample>[00m posting state-changed NULL to READY
0:00:00.584565430 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aresample' changed state to 2(READY) successfully
0:00:00.584581423 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aconv>[00m completed state change to READY
0:00:00.584593576 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aconv>[00m posting state-changed NULL to READY
0:00:00.584612013 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aconv' changed state to 2(READY) successfully
0:00:00.584627518 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aqueue>[00m completed state change to READY
0:00:00.584639740 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aqueue>[00m posting state-changed NULL to READY
0:00:00.584658178 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aqueue' changed state to 2(READY) successfully
0:00:00.584673752 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2314:gst_element_continue_state:<abin>[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.584692539 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2323:gst_element_continue_state:<abin>[00m continue state change READY to PAUSED, final PAUSED
0:00:00.584775580 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2498:gst_bin_change_state_func:<bin2>[00m child 'pulsesink1' is changing state asynchronously to PAUSED
0:00:00.584795903 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2498:gst_bin_change_state_func:<audio-sink>[00m child 'bin2' is changing state asynchronously to PAUSED
0:00:00.584813643 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2498:gst_bin_change_state_func:<audiosinkbin>[00m child 'audio-sink' is changing state asynchronously to PAUSED
0:00:00.584835712 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audiofilter>[00m completed state change to PAUSED
0:00:00.584848493 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audiofilter>[00m posting state-changed READY to PAUSED
0:00:00.584868677 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audiosinkbin>[00m child 'audiofilter' changed state to 3(PAUSED) successfully
0:00:00.584887045 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2498:gst_bin_change_state_func:<abin>[00m child 'audiosinkbin' is changing state asynchronously to PAUSED
0:00:00.584906321 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aresample>[00m completed state change to PAUSED
0:00:00.584918822 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aresample>[00m posting state-changed READY to PAUSED
0:00:00.584938168 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aresample' changed state to 3(PAUSED) successfully
0:00:00.584957514 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aconv>[00m completed state change to PAUSED
0:00:00.584970225 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aconv>[00m posting state-changed READY to PAUSED
0:00:00.584988872 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aconv' changed state to 3(PAUSED) successfully
0:00:00.585097404 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aqueue>[00m completed state change to PAUSED
0:00:00.585115912 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aqueue>[00m posting state-changed READY to PAUSED
0:00:00.585137353 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aqueue' changed state to 3(PAUSED) successfully
0:00:00.585160819 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link audiotee:src0 and streamsynchronizer0:sink_0
0:00:00.585175975 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked audiotee:src0 and streamsynchronizer0:sink_0, successful
0:00:00.585198044 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link streamsynchronizer0:src_0 and abin:sink
0:00:00.585215993 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:2124:gst_pad_link_full:[00m linked streamsynchronizer0:src_0 and abin:sink, successful
0:00:00.585237434 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00m            playsink gstplaysink.c:1047:do_async_done:<playsink0>[00m Sending async_done message
0:00:00.585255593 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;34m           GST_EVENT gstevent.c:1205:gst_event_new_sink_message:[00m creating sink-message event
0:00:00.585291421 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<decodebin20>[00m committing state from READY to PAUSED, old pending PAUSED
0:00:00.585305389 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2925:bin_handle_async_done:<decodebin20>[00m completed state change, pending VOID
0:00:00.585326830 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<uridecodebin0>[00m committing state from READY to PAUSED, old pending PAUSED
0:00:00.585340379 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2925:bin_handle_async_done:<uridecodebin0>[00m completed state change, pending VOID
0:00:00.585399534 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x1384400 (newsegment) to all internally linked pads
0:00:00.585429984 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x137f580 (sink-message) to all internally linked pads
0:00:00.585457920 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<mad0:sink>[00m Sending event 0x1384540 (tag) to all internally linked pads
0:00:00.585534186 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x1384540 (tag) to all internally linked pads
0:00:00.585565684 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<mad0:sink>[00m Sending event 0x137f400 (tag) to all internally linked pads
0:00:00.585610452 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x137f400 (tag) to all internally linked pads
0:00:00.585652915 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<mad0:sink>[00m Sending event 0x137a740 (tag) to all internally linked pads
0:00:00.585726667 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x137a740 (tag) to all internally linked pads
0:00:00.587190591 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<mad0:sink>[00m Sending event 0x13845c0 (tag) to all internally linked pads
0:00:00.587259733 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x13845c0 (tag) to all internally linked pads
0:00:00.587402836 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<mad0:sink>[00m Sending event 0x137f640 (tag) to all internally linked pads
0:00:00.587457521 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x137f640 (tag) to all internally linked pads
0:00:00.587942563 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m       basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<aconv>[00m reuse caps
0:00:00.588005978 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m        audioconvert audioconvert.c:655:audio_convert_prepare_context:[00m use int mixing
0:00:00.588018060 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m        audioconvert audioconvert.c:661:audio_convert_prepare_context:[00m unitsizes: 4 -> 4
0:00:00.588029165 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m        audioconvert audioconvert.c:671:audio_convert_prepare_context:[00m in default 1, mix passthrough 1, out default 1
0:00:00.588128478 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m       basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<aresample>[00m reuse caps
0:00:00.588180788 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m       basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<audiofilter>[00m reuse caps
0:00:00.588320679 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:815:gst_pulseringbuffer_acquire:<pulsesink1>[00m tlength:   35280
0:00:00.588334926 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:816:gst_pulseringbuffer_acquire:<pulsesink1>[00m maxlength: -1
0:00:00.588346031 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:817:gst_pulseringbuffer_acquire:<pulsesink1>[00m prebuf:    0
0:00:00.588356716 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:818:gst_pulseringbuffer_acquire:<pulsesink1>[00m minreq:    1764
0:00:00.591250344 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:885:gst_pulseringbuffer_acquire:<pulsesink1>[00m tlength:   19404 (wanted: 35280)
0:00:00.591274229 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:886:gst_pulseringbuffer_acquire:<pulsesink1>[00m maxlength: 4194304
0:00:00.591286172 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:887:gst_pulseringbuffer_acquire:<pulsesink1>[00m prebuf:    0
0:00:00.591297137 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00m               pulse pulsesink.c:889:gst_pulseringbuffer_acquire:<pulsesink1>[00m minreq:    1764 (wanted 1764)
0:00:00.591426551 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<bin2>[00m committing state from READY to PAUSED, old pending PAUSED
0:00:00.591445827 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2925:bin_handle_async_done:<bin2>[00m completed state change, pending VOID
0:00:00.591468735 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<audio-sink>[00m committing state from READY to PAUSED, old pending PAUSED
0:00:00.591482633 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2925:bin_handle_async_done:<audio-sink>[00m completed state change, pending VOID
0:00:00.591504354 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<audiosinkbin>[00m committing state from READY to PAUSED, old pending PAUSED
0:00:00.591518252 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2925:bin_handle_async_done:<audiosinkbin>[00m completed state change, pending VOID
0:00:00.591538086 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<abin>[00m committing state from READY to PAUSED, old pending PAUSED
0:00:00.591551426 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2925:bin_handle_async_done:<abin>[00m completed state change, pending VOID
0:00:00.591579083 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<playsink0>[00m committing state from READY to PAUSED, old pending PAUSED
0:00:00.591592981 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2925:bin_handle_async_done:<playsink0>[00m completed state change, pending VOID
0:00:00.591612746 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2905:bin_handle_async_done:<play>[00m committing state from READY to PAUSED, old pending PLAYING
0:00:00.591626015 [333m 8144[00m      0x1bf6e00 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2934:bin_handle_async_done:<play>[00m continue state change, pending PLAYING
0:00:00.591701792 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2727:gst_bin_continue_func:<play>[00m continue state change PAUSED to PLAYING, final PLAYING
0:00:00.591907891 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;34m           GST_EVENT gstevent.c:1067:gst_event_new_latency:[00m creating latency event 0:00:00.000000000
0:00:00.591950843 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:src0>[00m Sending event 0x1c37800 (latency) to all internally linked pads
0:00:00.591982690 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<mpegaudioparse0:src>[00m Sending event 0x1c37800 (latency) to all internally linked pads
0:00:00.592013769 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01m                 bin gstbin.c:2368:gst_bin_do_latency_func:<play>[00m configured latency of 0:00:00.000000000
0:00:00.593547325 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<pulsesink1>[00m completed state change to PLAYING
0:00:00.593571700 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<pulsesink1>[00m posting state-changed PAUSED to PLAYING
0:00:00.593605013 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<bin2>[00m child 'pulsesink1' changed state to 4(PLAYING) successfully
0:00:00.593622543 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<bin2>[00m completed state change to PLAYING
0:00:00.593635254 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<bin2>[00m posting state-changed PAUSED to PLAYING
0:00:00.593654879 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audio-sink>[00m child 'bin2' changed state to 4(PLAYING) successfully
0:00:00.593670803 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audio-sink>[00m completed state change to PLAYING
0:00:00.593683095 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audio-sink>[00m posting state-changed PAUSED to PLAYING
0:00:00.593701952 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audiosinkbin>[00m child 'audio-sink' changed state to 4(PLAYING) successfully
0:00:00.593719831 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audiofilter>[00m completed state change to PLAYING
0:00:00.593732193 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audiofilter>[00m posting state-changed PAUSED to PLAYING
0:00:00.593757056 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<audiosinkbin>[00m child 'audiofilter' changed state to 4(PLAYING) successfully
0:00:00.593772910 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audiosinkbin>[00m completed state change to PLAYING
0:00:00.593785481 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audiosinkbin>[00m posting state-changed PAUSED to PLAYING
0:00:00.593804478 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'audiosinkbin' changed state to 4(PLAYING) successfully
0:00:00.593822077 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aresample>[00m completed state change to PLAYING
0:00:00.593834369 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aresample>[00m posting state-changed PAUSED to PLAYING
0:00:00.593853296 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aresample' changed state to 4(PLAYING) successfully
0:00:00.593869918 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aconv>[00m completed state change to PLAYING
0:00:00.593882489 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aconv>[00m posting state-changed PAUSED to PLAYING
0:00:00.593900997 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aconv' changed state to 4(PLAYING) successfully
0:00:00.593917130 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<aqueue>[00m completed state change to PLAYING
0:00:00.593929422 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<aqueue>[00m posting state-changed PAUSED to PLAYING
0:00:00.593948000 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<abin>[00m child 'aqueue' changed state to 4(PLAYING) successfully
0:00:00.593963225 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<abin>[00m completed state change to PLAYING
0:00:00.593975098 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<abin>[00m posting state-changed PAUSED to PLAYING
0:00:00.593993536 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<playsink0>[00m child 'abin' changed state to 4(PLAYING) successfully
0:00:00.594010996 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<streamsynchronizer0>[00m completed state change to PLAYING
0:00:00.594023288 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<streamsynchronizer0>[00m posting state-changed PAUSED to PLAYING
0:00:00.594043262 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<playsink0>[00m child 'streamsynchronizer0' changed state to 4(PLAYING) successfully
0:00:00.594083630 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<audiotee>[00m completed state change to PLAYING
0:00:00.594100042 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<audiotee>[00m posting state-changed PAUSED to PLAYING
0:00:00.594119597 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<playsink0>[00m child 'audiotee' changed state to 4(PLAYING) successfully
0:00:00.594135381 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<playsink0>[00m completed state change to PLAYING
0:00:00.594147673 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<playsink0>[00m posting state-changed PAUSED to PLAYING
0:00:00.594165343 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<play>[00m child 'playsink0' changed state to 4(PLAYING) successfully
0:00:00.594183362 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<inputselector0>[00m completed state change to PLAYING
0:00:00.594195723 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<inputselector0>[00m posting state-changed PAUSED to PLAYING
0:00:00.594213393 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<play>[00m child 'inputselector0' changed state to 4(PLAYING) successfully
0:00:00.594245939 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<mad0>[00m completed state change to PLAYING
0:00:00.594258720 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<mad0>[00m posting state-changed PAUSED to PLAYING
0:00:00.594281348 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'mad0' changed state to 4(PLAYING) successfully
0:00:00.594298179 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<mpegaudioparse0>[00m completed state change to PLAYING
0:00:00.594310541 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<mpegaudioparse0>[00m posting state-changed PAUSED to PLAYING
0:00:00.594329049 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'mpegaudioparse0' changed state to 4(PLAYING) successfully
0:00:00.594345461 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<id3demux0>[00m completed state change to PLAYING
0:00:00.594357614 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<id3demux0>[00m posting state-changed PAUSED to PLAYING
0:00:00.594376680 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'id3demux0' changed state to 4(PLAYING) successfully
0:00:00.594392813 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<typefind>[00m completed state change to PLAYING
0:00:00.594405035 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<typefind>[00m posting state-changed PAUSED to PLAYING
0:00:00.594427733 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<decodebin20>[00m child 'typefind' changed state to 4(PLAYING) successfully
0:00:00.594443447 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<decodebin20>[00m completed state change to PLAYING
0:00:00.594456019 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<decodebin20>[00m posting state-changed PAUSED to PLAYING
0:00:00.594474457 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<uridecodebin0>[00m child 'decodebin20' changed state to 4(PLAYING) successfully
0:00:00.594490729 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<source>[00m completed state change to PLAYING
0:00:00.594502951 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<source>[00m posting state-changed PAUSED to PLAYING
0:00:00.594521459 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<uridecodebin0>[00m child 'source' changed state to 4(PLAYING) successfully
0:00:00.594536684 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<uridecodebin0>[00m completed state change to PLAYING
0:00:00.594548697 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<uridecodebin0>[00m posting state-changed PAUSED to PLAYING
0:00:00.594566925 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:2492:gst_bin_change_state_func:<play>[00m child 'uridecodebin0' changed state to 4(PLAYING) successfully
0:00:00.594582360 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2341:gst_element_continue_state:<play>[00m completed state change to PLAYING
0:00:00.594594931 [333m 8144[00m 0x7f049804a1c0 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2354:gst_element_continue_state:<play>[00m posting state-changed PAUSED to PLAYING
0:00:00.632683935 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link audiotee:src0 and streamsynchronizer0:sink_0
0:00:00.632719274 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1971:gst_pad_link_prepare:[00m src audiotee:src0 was already linked to streamsynchronizer0:sink_0
0:00:00.632743508 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link streamsynchronizer0:src_0 and abin:sink
0:00:00.632757407 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1971:gst_pad_link_prepare:[00m src streamsynchronizer0:src_0 was already linked to abin:sink
0:00:00.637745269 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link audiotee:src0 and streamsynchronizer0:sink_0
0:00:00.637785497 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1971:gst_pad_link_prepare:[00m src audiotee:src0 was already linked to streamsynchronizer0:sink_0
0:00:00.637810011 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link streamsynchronizer0:src_0 and abin:sink
0:00:00.637823979 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1971:gst_pad_link_prepare:[00m src streamsynchronizer0:src_0 was already linked to abin:sink
0:00:00.638256989 [333m 8144[00m      0x12dc220 [33;01mWARN   [00m [00m               totem bacon-video-widget-gst-0.10.c:1619:bvw_handle_element_message:[00m Unhandled element message playbin2-stream-changed from play: element message from element 'play': playbin2-stream-changed, uri=(string)file:///dev/shm/test.mp3;
0:00:00.669913761 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<mad0:sink>[00m Sending event 0x130f080 (tag) to all internally linked pads
0:00:00.670015867 [333m 8144[00m      0x19d79b0 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:3516:gst_pad_event_default_dispatch:<audiotee:sink>[00m Sending event 0x130f080 (tag) to all internally linked pads
0:00:00.679125082 [333m 8144[00m      0x12dc220 [33;01mWARN   [00m [00;04m             default xoverlay.c:354:gst_x_overlay_set_xwindow_id:<xvimagesink0>[00m Using deprecated gst_x_overlay_set_xwindow_id()
0:00:00.685583713 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link audiotee:src0 and streamsynchronizer0:sink_0
0:00:00.685620938 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1971:gst_pad_link_prepare:[00m src audiotee:src0 was already linked to streamsynchronizer0:sink_0
0:00:00.685648106 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1941:gst_pad_link_prepare:[00m trying to link streamsynchronizer0:src_0 and abin:sink
0:00:00.685662772 [333m 8144[00m      0x12dc220 [32;01mINFO   [00m [00;01;31;41m            GST_PADS gstpad.c:1971:gst_pad_link_prepare:[00m src streamsynchronizer0:src_0 was already linked to abin:sink
0:00:00.718349272 [333m 8144[00m      0x12dc220 [33;01mWARN   [00m [00;04m             default xoverlay.c:354:gst_x_overlay_set_xwindow_id:<xvimagesink0>[00m Using deprecated gst_x_overlay_set_xwindow_id()
0:00:01.504895439 [333m 8144[00m      0x12dc220 [33;01mWARN   [00m [00;04m             default xoverlay.c:354:gst_x_overlay_set_xwindow_id:<xvimagesink0>[00m Using deprecated gst_x_overlay_set_xwindow_id()
0:00:01.610096254 [333m 8144[00m      0x12dc220 [33;01mWARN   [00m [00;04m             default xoverlay.c:354:gst_x_overlay_set_xwindow_id:<xvimagesink0>[00m Using deprecated gst_x_overlay_set_xwindow_id()
0:00:01.800856037 [333m 8144[00m      0x12dc220 [33;01mWARN   [00m [00;04m             default xoverlay.c:354:gst_x_overlay_set_xwindow_id:<xvimagesink0>[00m Using deprecated gst_x_overlay_set_xwindow_id()
