(09:14:08) [0x813f6c0] [rb_shell_player_sync_with_selected_source] rb-shell-player.c:2660: syncing with selected source: 0x8317010
(09:14:08) [0x813f6c0] [rb_shell_player_sync_with_selected_source] rb-shell-player.c:2663: no playing source, new source is 0x8317010
(09:14:08) [0x813f6c0] [rb_shell_player_sync_with_source] rb-shell-player.c:2323: playing source: (nil), active entry: (nil)
(09:14:08) [0x813f6c0] [rb_shell_set_window_title] rb-shell.c:2035: clearing title
(09:14:08) [0x813f6c0] [rb_shell_player_get_playing_song_duration] rb-shell-player.c:2646: Did not get playing entry : return -1 as length
(09:14:08) [0x813f6c0] [rb_header_sync] rb-header.c:353: syncing with entry = (nil)
(09:14:08) [0x813f6c0] [rb_header_sync] rb-header.c:382: not playing
(09:14:08) [0x813f6c0] [rb_shell_player_sync_buttons] rb-shell-player.c:2389: syncing with source 0x8317010
(09:14:08) [0x813f6c0] [rb_source_header_set_source_internal] rb-source-header.c:319: selected source 0x8317010
(09:14:08) [0x813f6c0] [rb_source_header_view_browser_changed_cb] rb-source-header.c:539: got view browser toggle
(09:14:08) [0x813f6c0] [rb_source_header_view_browser_changed_cb] rb-source-header.c:549: got view browser toggle
(09:14:08) [0x813f6c0] [rb_statusbar_set_property] rb-statusbar.c:277: selected source 0x8317010
(09:14:08) [0x813f6c0] [shell_selected_source_notify_cb] rb-cd-recorder-plugin.c:300: RBCdRecorderPlugin selected source changed
(09:14:08) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:14:08) [0x813f6c0] [rb_iradio_source_state_pref_changed] rb-iradio-source.c:681: state prefs changed
(09:14:08) [0x813f6c0] [rb_iradio_source_state_prefs_sync] rb-iradio-source.c:668: syncing state
(09:14:08) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
(09:14:08) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:14:08) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:14:08) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:14:08) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
(09:14:11) [0x813f6c0] [rb_shell_clipboard_entryview_changed_cb] rb-shell-clipboard.c:743: entryview changed
(09:14:11) [0x813f6c0] [rb_shell_clipboard_sync] rb-shell-clipboard.c:527: syncing clipboard
(09:14:11) [0x813f6c0] [rb_entry_view_row_activated_cb] rb-entry-view.c:1649: row activated
(09:14:11) [0x813f6c0] [rb_entry_view_row_activated_cb] rb-entry-view.c:1653: emitting entry activated
(09:14:11) [0x813f6c0] [rb_shell_player_entry_activated_cb] rb-shell-player.c:2125: got entry 0x85cf918 activated
(09:14:11) [0x813f6c0] [rb_shell_player_set_playing_source_internal] rb-shell-player.c:2455: setting playing source to 0x8317010
(09:14:11) [0x813f6c0] [rb_shell_player_sync_with_source] rb-shell-player.c:2323: playing source: 0x8317010, active entry: (nil)
(09:14:11) [0x813f6c0] [rb_shell_set_window_title] rb-shell.c:2035: clearing title
(09:14:11) [0x813f6c0] [rb_shell_player_get_playing_song_duration] rb-shell-player.c:2646: Did not get playing entry : return -1 as length
(09:14:11) [0x813f6c0] [rb_header_sync] rb-header.c:353: syncing with entry = (nil)
(09:14:11) [0x813f6c0] [rb_header_sync] rb-header.c:382: not playing
(09:14:11) [0x813f6c0] [rb_shell_player_sync_buttons] rb-shell-player.c:2389: syncing with source 0x8317010
(09:14:11) [0x813f6c0] [rb_shell_playing_source_changed_cb] rb-shell.c:1850: playing source changed
(09:14:11) [0x813f6c0] [rb_shell_player_open_location] rb-shell-player.c:1161: Opening http://Radio1190.Colorado.EDU:8000/high.ogg...
(09:14:11) [0x813f6c0] [rb_shell_player_set_playing_entry] rb-shell-player.c:1312: Success!
(09:14:11) [0x813f6c0] [rb_shell_hidden_notify] rb-shell.c:2867: shell is visible, not notifying
(09:14:11) [0x813f6c0] [LocalCoverArtSearch.search] /usr/lib/rhythmbox/plugins/artdisplay/LocalCoverArtSearch.py:94: not searching for local art to
(09:14:11) [0x813f6c0] [LocalCoverArtSearch.search] /usr/lib/rhythmbox/plugins/artdisplay/LocalCoverArtSearch.py:94:  
(09:14:11) [0x813f6c0] [LocalCoverArtSearch.search] /usr/lib/rhythmbox/plugins/artdisplay/LocalCoverArtSearch.py:94: http://radio1190.colorado.edu:8000/high.ogg
(09:14:11) [0x813f6c0] [rb_shell_player_sync_with_source] rb-shell-player.c:2323: playing source: 0x8317010, active entry: 0x85cf918
(09:14:11) [0x813f6c0] [rb_shell_set_window_title] rb-shell.c:2058: setting title to "boulder"
(09:14:11) [0x813f6c0] [rb_header_sync] rb-header.c:353: syncing with entry = 0x85cf918
(09:14:11) [0x813f6c0] [rb_shell_player_sync_buttons] rb-shell-player.c:2389: syncing with source 0x8317010
(09:14:11) [0x813f6c0] [rb_shell_clipboard_entryview_changed_cb] rb-shell-clipboard.c:743: entryview changed
(09:14:11) [0x813f6c0] [rb_shell_clipboard_sync] rb-shell-clipboard.c:527: syncing clipboard
(09:14:11) [0x813f6c0] [paned_size_allocate_cb] rb-shell.c:2708: paned position 181
(09:14:11) [0x8559618] [open_location_thread] rb-shell-player.c:1144: playlist parser failed, playing http://Radio1190.Colorado.EDU:8000/high.ogg directly
(09:14:11) [0x8559618] [rb_shell_player_open_playlist_url] rb-shell-player.c:586: playing stream url http://Radio1190.Colorado.EDU:8000/high.ogg
(09:14:11) [0x8559618] [rb_player_gst_construct] rb-player-gst.c:535: constructing element "playbin"
0:00:19.148289000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstplaybin.so" loaded
0:00:19.148404000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "playbin" named "playbin"
(09:14:11) [0x813f6c0] [sidebar_paned_size_allocate_cb] rb-shell.c:2718: sidebar paned position 300
(09:14:11) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
0:00:19.170009000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
0:00:19.170097000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "fakesink" named "fakesink"
0:00:19.170615000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseSink@0x8650028>[00m adding pad 'sink'
0:00:19.173320000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstgconfelements.so" loaded
0:00:19.173385000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "gconfaudiosink" named "audiosink"
0:00:19.173980000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstGConfAudioSink@0x82ce5c0>[00m adding pad 'sink'
0:00:19.174142000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "fakesink" named "testsink"
0:00:19.174212000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseSink@0x8650258>[00m adding pad 'sink'
0:00:19.174491000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad testsink:sink
0:00:19.174533000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link sink:proxypad0 and testsink:sink
0:00:19.174735000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked sink:proxypad0 and testsink:sink, successful
(09:14:11) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:14:11) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:14:11) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:14:11) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
(09:14:11) [0x8559618] [rb_player_gst_construct] rb-player-gst.c:586: pipeline construction complete
(09:14:11) [0x8559618] [rb_player_gst_sync_pipeline] rb-player-gst.c:615: syncing pipeline
(09:14:11) [0x8559618] [rb_player_gst_sync_pipeline] rb-player-gst.c:626: PAUSING pipeline
0:00:19.231905000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<playbin>[00m committing state from NULL to READY, pending PAUSED
0:00:19.232425000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<playbin>[00m continue state change READY to PAUSED, final PAUSED
0:00:19.232461000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "fakesink" named "test"
0:00:19.232551000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseSink@0x8650488>[00m adding pad 'sink'
0:00:19.240574000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstgnomevfs.so" loaded
0:00:19.240645000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "gnomevfssrc" named "source"
0:00:19.240791000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseSrc@0x86610a0>[00m adding pad 'src'
0:00:19.243751000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstdecodebin.so" loaded
0:00:19.243823000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "decodebin" named "decoder"
0:00:19.244369000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "typefind" named "typefind"
0:00:19.244505000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstTypeFindElement@0x837c558>[00m adding pad 'sink'
0:00:19.244575000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstTypeFindElement@0x837c558>[00m adding pad 'src'
0:00:19.244645000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad typefind:sink
0:00:19.244812000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstDecodeBin@0x8585130>[00m adding pad 'sink'
0:00:19.244841000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link sink:proxypad1 and typefind:sink
0:00:19.244869000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked sink:proxypad1 and typefind:sink, successful
0:00:19.244903000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "fakesink" named "fakesink"
0:00:19.244966000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseSink@0x86506b8>[00m adding pad 'sink'
0:00:19.245468000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1315:gst_element_link_pads:[00m trying to link element source:(any) to element decoder:(any)
0:00:19.245539000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1981:gst_pad_can_link:[00m trying to link source:src and decoder:sink
0:00:19.245562000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1219:prepare_link_maybe_ghosting:[00m source and decoder in same bin, no need for ghost pads
0:00:19.245581000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link source:src and decoder:sink
0:00:19.245628000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked source:src and decoder:sink, successful
0:00:19.245810000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<test>[00m committing state from NULL to READY, pending PAUSED
0:00:19.245884000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<test>[00m continue state change READY to PAUSED, final PAUSED
0:00:19.246005000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1935:gst_bin_change_state_func:<playbin>[00m child 'test' is changing state asynchronously
0:00:19.246041000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<fakesink>[00m completed state change
0:00:19.246105000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<decoder>[00m child 'fakesink' changed state to 2(READY) successfully
0:00:19.246131000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<typefind>[00m completed state change
0:00:19.246189000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<decoder>[00m child 'typefind' changed state to 2(READY) successfully
0:00:19.246213000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<decoder>[00m committing state from NULL to READY, pending PAUSED
0:00:19.246270000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<decoder>[00m continue state change READY to PAUSED, final PAUSED
0:00:19.246307000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1935:gst_bin_change_state_func:<decoder>[00m child 'fakesink' is changing state asynchronously
0:00:19.246397000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<typefind>[00m completed state change
0:00:19.246460000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<decoder>[00m child 'typefind' changed state to 3(PAUSED) successfully
0:00:19.246489000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1935:gst_bin_change_state_func:<playbin>[00m child 'decoder' is changing state asynchronously
0:00:19.246512000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<source>[00m committing state from NULL to READY, pending PAUSED
0:00:19.246569000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<source>[00m continue state change READY to PAUSED, final PAUSED
0:00:22.616682000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;34m           GST_EVENT gstevent.c:527:gst_event_new_new_segment_full:[00m creating newsegment update 0, rate 1,000000, format 2, start 0, stop -1, position 0
0:00:22.617028000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<source>[00m completed state change
0:00:22.617079000 [333m12134[00m 0x8559618 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<playbin>[00m child 'source' changed state to 3(PAUSED) successfully
(09:14:15) [0x8559618] [rb_player_gst_sync_pipeline] rb-player-gst.c:615: syncing pipeline
(09:14:15) [0x8559618] [rb_player_gst_sync_pipeline] rb-player-gst.c:617: PLAYING pipeline
(09:14:15) [0x813f6c0] [notify_playing_idle] rb-shell-player.c:572: emitting playing notification: 1
(09:14:15) [0x813f6c0] [rb_shell_player_sync_buttons] rb-shell-player.c:2389: syncing with source 0x8317010
0:00:22.786676000 [333m12134[00m 0x85af5b0 [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:22.786815000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-musepack
0:00:22.786869000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-au
0:00:22.786920000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-msvideo
0:00:22.786970000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-cdxa
0:00:22.787019000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-vcd
0:00:22.787068000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-flac
0:00:22.787118000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-fli
0:00:22.787166000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-id3v2
0:00:22.787214000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-id3v1
0:00:22.787265000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-apetag
0:00:22.787341000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-ttafile
0:00:22.787391000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-mod
0:00:22.787466000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/mpeg
0:00:22.787518000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-ac3
0:00:22.787581000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg1
0:00:22.787628000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg2
0:00:22.787685000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpegts
0:00:22.787734000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/ogg
0:00:22.787788000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg
0:00:22.787834000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg-stream
0:00:22.787880000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/mpeg4
0:00:22.787928000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-m4a
0:00:22.787977000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-3gp
0:00:22.788026000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/quicktime
0:00:22.788075000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/html
0:00:22.788122000 [333m12134[00m 0x85af5b0 [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:22.788180000 [333m12134[00m 0x85af5b0 [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:22.788230000 [333m12134[00m 0x85af5b0 [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:22.788284000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-flv
0:00:22.788334000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/plain
0:00:22.788388000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/uri-list
0:00:22.788436000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/smil
0:00:22.788554000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/xml
0:00:22.788619000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-wav
0:00:22.788670000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-aiff
0:00:22.788720000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-svx
0:00:22.788769000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-paris
0:00:22.788818000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-nist
0:00:22.788867000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-voc
0:00:22.788916000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-sds
0:00:22.788964000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-ircam
0:00:22.789012000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-w64
0:00:22.789066000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-shorten
0:00:22.789115000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ape
0:00:22.789165000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/jpeg
0:00:22.789212000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/gif
0:00:22.789265000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/png
0:00:22.789312000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/bmp
0:00:22.789368000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/tiff
0:00:22.789416000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-matroska
0:00:22.789473000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-mve
0:00:22.789525000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-dv
0:00:22.789574000 [333m12134[00m 0x85af5b0 [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:22.789623000 [333m12134[00m 0x85af5b0 [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:22.789684000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/iLBC-sh
0:00:22.789732000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-sid
0:00:22.789783000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-xcf
0:00:22.789831000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-mng
0:00:22.789878000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-jng
0:00:22.789925000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for image/x-xpixmap
0:00:22.789971000 [333m12134[00m 0x85af5b0 [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:22.790018000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-bzip
0:00:22.790068000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-gzip
0:00:22.790116000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/zip
0:00:22.790164000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-compress
0:00:22.790213000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-vorbis
0:00:22.790261000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-theora
0:00:22.790309000 [333m12134[00m 0x85af5b0 [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:22.790358000 [333m12134[00m 0x85af5b0 [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:22.790406000 [333m12134[00m 0x85af5b0 [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:22.790468000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-speex
0:00:22.790520000 [333m12134[00m 0x85af5b0 [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:22.790568000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for text/x-cmml
0:00:22.790616000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-executable
0:00:22.790672000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for adts_mpeg_stream
0:00:22.790732000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-spc
0:00:22.790784000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for audio/x-wavpack
0:00:22.790836000 [333m12134[00m 0x85af5b0 [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:22.790885000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-rar
0:00:22.790940000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-tar
0:00:22.790990000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for application/x-ar
0:00:22.791041000 [333m12134[00m 0x85af5b0 [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:22.791092000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32m        GST_TYPEFIND gsttypefind.c:83:gst_type_find_register:[00m registering typefind function for video/x-dirac
0:00:22.791140000 [333m12134[00m 0x85af5b0 [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:22.791191000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgsttypefindfunctions.so" loaded
0:00:22.791750000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;32;43m            typefind gsttypefindelement.c:160:gst_type_find_element_have_type:<typefind>[00m found caps application/ogg
0:00:22.791894000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad typefind:src
0:00:22.814621000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstogg.so" loaded
0:00:22.814694000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "oggdemux"
0:00:22.814778000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstOggDemux@0x81f2a88>[00m adding pad 'sink'
0:00:22.814815000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad oggdemux0:sink
0:00:22.814872000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<oggdemux0>[00m completed state change
0:00:22.814917000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link typefind:src and oggdemux0:sink
0:00:22.814949000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked typefind:src and oggdemux0:sink, successful
0:00:22.814979000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:820:gst_element_get_static_pad:[00m no such pad 'src_%d' in element "oggdemux0"
0:00:22.815060000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<oggdemux0>[00m completed state change
0:00:22.825223000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstvorbis.so" loaded
0:00:22.825317000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "vorbisdec"
0:00:22.825408000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a0b0>[00m adding pad 'sink'
0:00:22.825488000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a0b0>[00m adding pad 'src'
0:00:22.825524000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec0:sink
0:00:22.825548000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<vorbisdec0>[00m committing state from NULL to READY, pending PAUSED
0:00:22.825582000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<vorbisdec0>[00m continue state change READY to PAUSED, final PAUSED
0:00:22.825620000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec0>[00m completed state change
0:00:22.825687000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec0:src
0:00:22.825709000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link vorbisdec0:src and '':internal
0:00:22.825879000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked vorbisdec0:src and '':internal, successful
0:00:22.828507000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:2827:gst_pad_event_default_dispatch:<'':internal>[00m Sending event 0x85748c8 to all internally linked pads
0:00:22.958813000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;34m           GST_EVENT gstevent.c:522:gst_event_new_new_segment_full:[00m creating newsegment update 0, rate 1,000000, format GST_FORMAT_TIME, start 0:00:09.910666666, stop 99:99:99.999999999, position 0:00:00.000000000
0:00:22.958904000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<oggdemux0>[00m adding pad 'serial_49c4f9cf'
0:00:22.959268000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "queue"
0:00:22.959373000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cf820>[00m adding pad 'sink'
0:00:22.959447000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cf820>[00m adding pad 'src'
0:00:22.959542000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<queue0>[00m completed state change
0:00:22.959590000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad queue0:sink
0:00:22.959610000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad queue0:src
0:00:22.959629000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link oggdemux0:serial_49c4f9cf and queue0:sink
0:00:22.959669000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked oggdemux0:serial_49c4f9cf and queue0:sink, successful
0:00:22.959722000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "vorbisdec"
0:00:22.959790000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a2c0>[00m adding pad 'sink'
0:00:22.959857000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a2c0>[00m adding pad 'src'
0:00:22.959889000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec1:sink
0:00:22.959925000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec1>[00m completed state change
0:00:22.959955000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link queue0:src and vorbisdec1:sink
0:00:22.959983000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked queue0:src and vorbisdec1:sink, successful
0:00:22.960020000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec1:src
0:00:22.960143000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<decoder>[00m adding pad 'src0'
0:00:22.960169000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link vorbisdec1:src and src0:proxypad2
0:00:22.960207000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked vorbisdec1:src and src0:proxypad2, successful
0:00:22.960446000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstStreamSelector@0x81ba890>[00m adding pad 'src'
0:00:22.960492000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "queue" named "preroll_audio_src0"
0:00:22.960563000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cf910>[00m adding pad 'sink'
0:00:22.960623000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cf910>[00m adding pad 'src'
0:00:22.960685000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src0:sink
0:00:22.960719000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src0:src
0:00:22.960758000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1315:gst_element_link_pads:[00m trying to link element selector_audio_src0:(any) to element preroll_audio_src0:(any)
0:00:22.960782000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1981:gst_pad_can_link:[00m trying to link selector_audio_src0:src and preroll_audio_src0:src
0:00:22.960802000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:2001:gst_pad_can_link:[00m Sink pad preroll_audio_src0:src is not sink pad, failed
0:00:22.960820000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1981:gst_pad_can_link:[00m trying to link selector_audio_src0:src and preroll_audio_src0:sink
0:00:22.960839000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1219:prepare_link_maybe_ghosting:[00m selector_audio_src0 and preroll_audio_src0 in same bin, no need for ghost pads
0:00:22.960871000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link selector_audio_src0:src and preroll_audio_src0:sink
0:00:22.960897000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked selector_audio_src0:src and preroll_audio_src0:sink, successful
0:00:22.960919000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<selector_audio_src0>[00m committing state from NULL to READY, pending PAUSED
0:00:22.960949000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<selector_audio_src0>[00m continue state change READY to PAUSED, final PAUSED
0:00:22.960975000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<selector_audio_src0>[00m completed state change
0:00:22.961002000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<preroll_audio_src0>[00m committing state from NULL to READY, pending PAUSED
0:00:22.961029000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<preroll_audio_src0>[00m continue state change READY to PAUSED, final PAUSED
0:00:22.961059000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<preroll_audio_src0>[00m completed state change
0:00:22.961086000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:820:gst_element_get_static_pad:[00m no such pad 'sink%d' in element "selector_audio_src0"
0:00:22.961137000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<selector_audio_src0>[00m adding pad 'sink0'
0:00:22.961166000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link decoder:src0 and selector_audio_src0:sink0
0:00:22.961208000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked decoder:src0 and selector_audio_src0:sink0, successful
0:00:22.961248000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec1>[00m completed state change
0:00:22.961335000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<queue0>[00m completed state change
0:00:22.961398000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad selector_audio_src0:sink0
0:00:22.961433000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src0:src
0:00:22.961452000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src0:sink
0:00:22.961471000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad selector_audio_src0:src
0:00:22.961627000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "bin" named "abin"
0:00:22.964733000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstaudioconvert.so" loaded
0:00:22.964805000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "audioconvert" named "aconv"
0:00:22.964925000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseTransform@0x86bd008>[00m adding pad 'sink'
0:00:22.964979000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseTransform@0x86bd008>[00m adding pad 'src'
0:00:23.004669000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstaudioresample.so" loaded
0:00:23.004752000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "audioresample" named "aresample"
0:00:23.004834000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseTransform@0x86be030>[00m adding pad 'sink'
0:00:23.004888000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseTransform@0x86be030>[00m adding pad 'src'
0:00:23.009849000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstvolume.so" loaded
0:00:23.009928000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "volume" named "volume"
0:00:23.010008000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseTransform@0x842f100>[00m adding pad 'sink'
0:00:23.010062000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseTransform@0x842f100>[00m adding pad 'src'
0:00:23.010241000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1315:gst_element_link_pads:[00m trying to link element aconv:src to element aresample:sink
0:00:23.010311000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad aconv:src
0:00:23.010331000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad aresample:sink
0:00:23.010350000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1219:prepare_link_maybe_ghosting:[00m aconv and aresample in same bin, no need for ghost pads
0:00:23.010369000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link aconv:src and aresample:sink
0:00:23.010903000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked aconv:src and aresample:sink, successful
0:00:23.010926000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1315:gst_element_link_pads:[00m trying to link element aresample:src to element volume:sink
0:00:23.010945000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad aresample:src
0:00:23.010963000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad volume:sink
0:00:23.010979000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1219:prepare_link_maybe_ghosting:[00m aresample and volume in same bin, no need for ghost pads
0:00:23.010997000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link aresample:src and volume:sink
0:00:23.011675000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked aresample:src and volume:sink, successful
0:00:23.011697000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1315:gst_element_link_pads:[00m trying to link element volume:src to element audiosink:sink
0:00:23.011717000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad volume:src
0:00:23.011735000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad audiosink:sink
0:00:23.011752000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1219:prepare_link_maybe_ghosting:[00m volume and audiosink in same bin, no need for ghost pads
0:00:23.011770000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link volume:src and audiosink:sink
0:00:23.012259000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked volume:src and audiosink:sink, successful
0:00:23.012280000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad aconv:sink
0:00:23.012390000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<abin>[00m adding pad 'sink'
0:00:23.012425000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link sink:proxypad3 and aconv:sink
0:00:23.013727000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked sink:proxypad3 and aconv:sink, successful
0:00:23.013801000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<testsink>[00m completed state change
0:00:23.013848000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1486:gst_pad_unlink:[00m unlinking sink:proxypad0(0x861f4c0) and testsink:sink(0x822af00)
0:00:23.013871000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1521:gst_pad_unlink:[00m unlinked sink:proxypad0 and testsink:sink
0:00:23.013918000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:961:gst_bin_remove_func:<audiosink>[00m removed child "testsink"
0:00:23.013964000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2469:gst_element_dispose:<testsink>[00m dispose
0:00:23.014004000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<testsink>[00m removing pad 'sink'
0:00:23.014026000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2494:gst_element_dispose:<testsink>[00m parent class dispose
0:00:23.014093000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2517:gst_element_finalize:<testsink>[00m finalize
0:00:23.014134000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2528:gst_element_finalize:<testsink>[00m finalize parent
0:00:23.014185000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m        GST_PIPELINE gstparse.c:150:gst_parse_launch:[00m parsing pipeline description bin.( alsasink )
0:00:23.039740000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;36m  GST_PLUGIN_LOADING gstplugin.c:467:gst_plugin_load_file:[00m plugin "/usr/lib/gstreamer-0.10/libgstalsa.so" loaded
0:00:23.039811000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "alsasink"
0:00:23.039909000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseSink@0x86802f0>[00m adding pad 'sink'
0:00:23.040252000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "bin"
0:00:23.040671000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<bin1>[00m adding pad 'sink'
0:00:23.040703000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link sink:proxypad4 and alsasink0:sink
0:00:23.040843000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked sink:proxypad4 and alsasink0:sink, successful
0:00:23.040889000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<alsasink0>[00m completed state change
0:00:23.040910000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<bin1>[00m child 'alsasink0' changed state to 1(NULL) successfully
0:00:23.040932000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<bin1>[00m completed state change
0:00:23.040975000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad bin1:sink
0:00:23.040996000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1486:gst_pad_unlink:[00m unlinking sink:proxypad0(0x861f4c0) and '':sink(0x822af00)
0:00:23.041024000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link sink:proxypad0 and bin1:sink
0:00:23.044099000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked sink:proxypad0 and bin1:sink, successful
0:00:23.053143000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<alsasink0>[00m completed state change
0:00:23.053226000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<bin1>[00m child 'alsasink0' changed state to 2(READY) successfully
0:00:23.053255000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<bin1>[00m completed state change
0:00:23.053284000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<audiosink>[00m child 'bin1' changed state to 2(READY) successfully
0:00:23.053306000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<audiosink>[00m completed state change
0:00:23.053333000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'audiosink' changed state to 2(READY) successfully
0:00:23.053365000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<volume>[00m completed state change
0:00:23.053392000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'volume' changed state to 2(READY) successfully
0:00:23.053475000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<aresample>[00m completed state change
0:00:23.053502000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'aresample' changed state to 2(READY) successfully
0:00:23.053551000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<aconv>[00m completed state change
0:00:23.053578000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'aconv' changed state to 2(READY) successfully
0:00:23.053601000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<abin>[00m completed state change
0:00:23.053632000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src0:src
0:00:23.053704000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1935:gst_bin_change_state_func:<bin1>[00m child 'alsasink0' is changing state asynchronously
0:00:23.053732000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1935:gst_bin_change_state_func:<audiosink>[00m child 'bin1' is changing state asynchronously
0:00:23.053758000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1935:gst_bin_change_state_func:<abin>[00m child 'audiosink' is changing state asynchronously
0:00:23.053789000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<volume>[00m completed state change
0:00:23.053817000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'volume' changed state to 3(PAUSED) successfully
0:00:23.053866000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<aresample>[00m completed state change
0:00:23.053894000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'aresample' changed state to 3(PAUSED) successfully
0:00:23.053923000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<aconv>[00m completed state change
0:00:23.053949000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'aconv' changed state to 3(PAUSED) successfully
0:00:23.054078000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad abin:sink
0:00:23.054100000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link preroll_audio_src0:src and abin:sink
0:00:23.054659000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00m                alsa gstalsasink.c:326:gst_alsasink_getcaps:<alsasink0>[00m returning caps audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)32, depth=(int)32, rate=(int)[ 4000, 2147483647 ], channels=(int)[ 1, 2 ]; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)32, depth=(int)32, rate=(int)[ 4000, 2147483647 ], channels=(int)3, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_LFE >; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)32, depth=(int)32, rate=(int)[ 4000, 2147483647 ], channels=(int)4, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT >; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)32, depth=(int)32, rate=(int)[ 4000, 2147483647 ], channels=(int)6, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT, GST_AUDIO_CHANNEL_POSITION_FRONT_CENTER, GST_AUDIO_CHANNEL_POSITION_LFE >; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)32, depth=(int)32, rate=(int)[ 4000, 2147483647 ], channels=(int)8, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT, GST_AUDIO_CHANNEL_POSITION_FRONT_CENTER, GST_AUDIO_CHANNEL_POSITION_LFE, GST_AUDIO_CHANNEL_POSITION_SIDE_LEFT, GST_AUDIO_CHANNEL_POSITION_SIDE_RIGHT >; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)16, depth=(int)16, rate=(int)[ 4000, 2147483647 ], channels=(int)[ 1, 2 ]; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)16, depth=(int)16, rate=(int)[ 4000, 2147483647 ], channels=(int)3, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_LFE >; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)16, depth=(int)16, rate=(int)[ 4000, 2147483647 ], channels=(int)4, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT >; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)16, depth=(int)16, rate=(int)[ 4000, 2147483647 ], channels=(int)6, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT, GST_AUDIO_CHANNEL_POSITION_FRONT_CENTER, GST_AUDIO_CHANNEL_POSITION_LFE >; audio/x-raw-int, endianness=(int)1234, signed=(boolean){ true, false }, width=(int)16, depth=(int)16, rate=(int)[ 4000, 2147483647 ], channels=(int)8, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT, GST_AUDIO_CHANNEL_POSITION_FRONT_CENTER, GST_AUDIO_CHANNEL_POSITION_LFE, GST_AUDIO_CHANNEL_POSITION_SIDE_LEFT, GST_AUDIO_CHANNEL_POSITION_SIDE_RIGHT >; audio/x-raw-int, signed=(boolean){ true, false }, width=(int)8, depth=(int)8, rate=(int)[ 4000, 2147483647 ], channels=(int)[ 1, 2 ]; audio/x-raw-int, signed=(boolean){ true, false }, width=(int)8, depth=(int)8, rate=(int)[ 4000, 2147483647 ], channels=(int)3, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_LFE >; audio/x-raw-int, signed=(boolean){ true, false }, width=(int)8, depth=(int)8, rate=(int)[ 4000, 2147483647 ], channels=(int)4, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT >; audio/x-raw-int, signed=(boolean){ true, false }, width=(int)8, depth=(int)8, rate=(int)[ 4000, 2147483647 ], channels=(int)6, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT, GST_AUDIO_CHANNEL_POSITION_FRONT_CENTER, GST_AUDIO_CHANNEL_POSITION_LFE >; audio/x-raw-int, signed=(boolean){ true, false }, width=(int)8, depth=(int)8, rate=(int)[ 4000, 2147483647 ], channels=(int)8, channel-positions=(GstAudioChannelPosition)< GST_AUDIO_CHANNEL_POSITION_FRONT_LEFT, GST_AUDIO_CHANNEL_POSITION_FRONT_RIGHT, GST_AUDIO_CHANNEL_POSITION_REAR_LEFT, GST_AUDIO_CHANNEL_POSITION_REAR_RIGHT, GST_AUDIO_CHANNEL_POSITION_FRONT_CENTER, GST_AUDIO_CHANNEL_POSITION_LFE, GST_AUDIO_CHANNEL_POSITION_SIDE_LEFT, GST_AUDIO_CHANNEL_POSITION_SIDE_RIGHT >
0:00:23.059118000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked preroll_audio_src0:src and abin:sink, successful
0:00:23.059235000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<test>[00m committing state from READY to READY, pending NULL
0:00:23.059327000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<test>[00m continue state change READY to NULL, final NULL
0:00:23.059355000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<test>[00m completed state change
0:00:23.059501000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:961:gst_bin_remove_func:<playbin>[00m removed child "test"
0:00:23.059529000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2469:gst_element_dispose:<test>[00m dispose
0:00:23.059549000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<test>[00m removing pad 'sink'
0:00:23.059580000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2494:gst_element_dispose:<test>[00m parent class dispose
0:00:23.059603000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2517:gst_element_finalize:<test>[00m finalize
0:00:23.059622000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2528:gst_element_finalize:<test>[00m finalize parent
0:00:23.062535000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:2827:gst_pad_event_default_dispatch:<selector_audio_src0:sink0>[00m Sending event 0x85748c8 to all internally linked pads
0:00:23.062600000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:961:gst_bin_remove_func:<decoder>[00m removed child "fakesink"
0:00:23.062649000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<fakesink>[00m committing state from READY to READY, pending NULL
0:00:23.062681000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<fakesink>[00m continue state change READY to NULL, final NULL
0:00:23.062707000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<fakesink>[00m completed state change
0:00:23.062736000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2469:gst_element_dispose:<fakesink>[00m dispose
0:00:23.062756000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<fakesink>[00m removing pad 'sink'
0:00:23.062784000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2494:gst_element_dispose:<fakesink>[00m parent class dispose
0:00:23.062805000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2517:gst_element_finalize:<fakesink>[00m finalize
0:00:23.062824000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2528:gst_element_finalize:<fakesink>[00m finalize parent
0:00:23.062960000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:2827:gst_pad_event_default_dispatch:<selector_audio_src0:sink0>[00m Sending event 0x85b3740 to all internally linked pads
(09:14:15) [0x813f6c0] [info_available_cb] rb-shell-player.c:2763: info: 0
(09:14:15) [0x813f6c0] [rb_shell_hidden_notify] rb-shell.c:2867: shell is visible, not notifying
(09:14:15) [0x813f6c0] [rb_shell_player_sync_with_source] rb-shell-player.c:2323: playing source: 0x8317010, active entry: 0x85cf918
(09:14:15) [0x813f6c0] [rb_shell_set_window_title] rb-shell.c:2058: setting title to "Ambient Overnights (boulder)"
(09:14:15) [0x813f6c0] [rb_header_sync] rb-header.c:353: syncing with entry = 0x85cf918
(09:14:15) [0x813f6c0] [info_available_cb] rb-shell-player.c:2763: info: 20
0:00:23.096334000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<playbin>[00m recalc state
0:00:23.096802000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<playbin>[00m checking element states
0:00:23.096886000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<abin>[00m getting state
0:00:23.096906000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<abin>[00m recalc state
0:00:23.096922000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<abin>[00m checking element states
0:00:23.096941000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<audiosink>[00m getting state
0:00:23.096958000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<audiosink>[00m recalc state
0:00:23.096975000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<audiosink>[00m checking element states
0:00:23.096992000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<bin1>[00m getting state
0:00:23.097008000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<bin1>[00m recalc state
0:00:23.097024000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<bin1>[00m checking element states
0:00:23.097070000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<bin1>[00m bin RETURN is now 2
0:00:23.097089000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<audiosink>[00m bin RETURN is now 2
0:00:23.097112000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<abin>[00m bin RETURN is now 2
0:00:23.097133000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<decoder>[00m getting state
0:00:23.097150000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<decoder>[00m recalc state
0:00:23.097166000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<decoder>[00m checking element states
0:00:23.097189000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<decoder>[00m completed state change
0:00:23.097313000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<decoder>[00m bin RETURN is now 1
0:00:23.097335000 [333m12134[00m 0x8706ec0 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<playbin>[00m bin RETURN is now 2
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-shell.c:2708: paned position 181
0:00:23.647939000 [333m12134[00m 0x86d96b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src0:sink
0:00:23.654266000 [333m12134[00m 0x86d96b0 [32;01mINFO [00m [00m              volume gstvolume.c:447:volume_set_caps:<volume>[00m use int16
(09:14:16) [0x813f6c0] [sidebar_paned_size_allocate_cb] rb-shell.c:2718: sidebar paned position 300
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:14:16) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:14:16) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-shell.c:2708: paned position 181
(09:14:16) [0x813f6c0] [sidebar_paned_size_allocate_cb] rb-shell.c:2718: sidebar paned position 300
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:14:16) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:14:16) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
0:00:23.725662000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<playbin>[00m recalc state
0:00:23.725720000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<playbin>[00m checking element states
0:00:23.725740000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<abin>[00m getting state
0:00:23.725757000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<abin>[00m recalc state
0:00:23.725774000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<abin>[00m checking element states
0:00:23.725791000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<audiosink>[00m getting state
0:00:23.725808000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<audiosink>[00m recalc state
0:00:23.725824000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<audiosink>[00m checking element states
0:00:23.725841000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<bin1>[00m getting state
0:00:23.725858000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1321:gst_bin_recalc_state:<bin1>[00m recalc state
0:00:23.725874000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1331:gst_bin_recalc_state:<bin1>[00m checking element states
0:00:23.725893000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<bin1>[00m completed state change
0:00:23.725960000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<bin1>[00m bin RETURN is now 1
0:00:23.725981000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<audiosink>[00m completed state change
0:00:23.726040000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<audiosink>[00m bin RETURN is now 1
0:00:23.726066000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<abin>[00m completed state change
0:00:23.726122000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<abin>[00m bin RETURN is now 1
0:00:23.726206000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1282:gst_bin_get_state_func:<decoder>[00m getting state
0:00:23.726247000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1426:gst_bin_recalc_state:<decoder>[00m not dirty
0:00:23.726268000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<playbin>[00m committing state from READY to PAUSED, pending PLAYING
0:00:23.726335000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<playbin>[00m continue state change PAUSED to PLAYING, final PLAYING
0:00:23.729785000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<alsasink0>[00m completed state change
0:00:23.729887000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<bin1>[00m child 'alsasink0' changed state to 4(PLAYING) successfully
0:00:23.729913000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<bin1>[00m completed state change
0:00:23.729972000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<audiosink>[00m child 'bin1' changed state to 4(PLAYING) successfully
0:00:23.729996000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<audiosink>[00m completed state change
0:00:23.730054000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'audiosink' changed state to 4(PLAYING) successfully
0:00:23.730081000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<volume>[00m completed state change
0:00:23.730138000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'volume' changed state to 4(PLAYING) successfully
0:00:23.730164000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<aresample>[00m completed state change
0:00:23.730221000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'aresample' changed state to 4(PLAYING) successfully
0:00:23.730245000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<aconv>[00m completed state change
0:00:23.730310000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<abin>[00m child 'aconv' changed state to 4(PLAYING) successfully
0:00:23.730335000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<abin>[00m completed state change
0:00:23.730391000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<playbin>[00m child 'abin' changed state to 4(PLAYING) successfully
0:00:23.730418000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<preroll_audio_src0>[00m completed state change
0:00:23.730476000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<playbin>[00m child 'preroll_audio_src0' changed state to 4(PLAYING) successfully
0:00:23.730501000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<selector_audio_src0>[00m completed state change
0:00:23.730557000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<playbin>[00m child 'selector_audio_src0' changed state to 4(PLAYING) successfully
0:00:23.730613000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec1>[00m completed state change
0:00:23.730673000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<decoder>[00m child 'vorbisdec1' changed state to 4(PLAYING) successfully
0:00:23.730698000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<queue0>[00m completed state change
0:00:23.730756000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<decoder>[00m child 'queue0' changed state to 4(PLAYING) successfully
0:00:23.730781000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<oggdemux0>[00m completed state change
0:00:23.730838000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<decoder>[00m child 'oggdemux0' changed state to 4(PLAYING) successfully
0:00:23.730864000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<typefind>[00m completed state change
0:00:23.730921000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<decoder>[00m child 'typefind' changed state to 4(PLAYING) successfully
0:00:23.730945000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<decoder>[00m completed state change
0:00:23.731002000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<playbin>[00m child 'decoder' changed state to 4(PLAYING) successfully
0:00:23.731026000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<source>[00m completed state change
0:00:23.731083000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1930:gst_bin_change_state_func:<playbin>[00m child 'source' changed state to 4(PLAYING) successfully
0:00:23.731107000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<playbin>[00m completed state change
0:00:23.731162000 [333m12134[00m 0x8689a18 [32;01mINFO [00m [00;01;31m          GST_STATES gstbin.c:1420:gst_bin_recalc_state:<playbin>[00m bin RETURN is now 1
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-shell.c:2708: paned position 181
(09:14:16) [0x813f6c0] [sidebar_paned_size_allocate_cb] rb-shell.c:2718: sidebar paned position 300
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:14:16) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:14:16) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:14:16) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
(09:14:22) [0x813f6c0] [rb_tray_icon_show_window_changed_cb] rb-tray-icon.c:475: show window clicked for 0x82fc0c8
(09:14:54) [0x813f6c0] [rhythmdb_read_enter] rhythmdb.c:749: counter: 1
(09:14:54) [0x86c2ae8] [query_thread_main] rhythmdb.c:3178: entering query thread
(09:14:54) [0x86c2ae8] [rhythmdb_query_internal] rhythmdb.c:3155: doing query
(09:14:54) [0x86c2ae8] [do_query_recurse] rhythmdb-tree.c:2022: doing recursive query, 1 conjunctions
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 33 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 14 entries
(09:14:54) [0x86c2ae8] [rhythmdb_query_internal] rhythmdb.c:3161: completed
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 33 rows
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 14 rows
(09:14:54) [0x813f6c0] [rhythmdb_read_enter] rhythmdb.c:749: counter: 2
(09:14:54) [0x86c2ae8] [query_thread_main] rhythmdb.c:3178: entering query thread
(09:14:54) [0x86c2ae8] [rhythmdb_query_internal] rhythmdb.c:3155: doing query
(09:14:54) [0x86c2ae8] [do_query_recurse] rhythmdb-tree.c:2022: doing recursive query, 1 conjunctions
(09:14:54) [0x86c2ae8] [rhythmdb_query_model_add_results] rhythmdb-query-model.c:1806: adding 0 entries
(09:14:54) [0x813f6c0] [idle_process_update] rhythmdb-query-model.c:947: inserting 0 rows
(09:14:54) [0x86c2ae8] [rhythmdb_query_internal] rhythmdb.c:3161: completed
(09:14:55) [0x813f6c0] [rhythmdb_process_events] rhythmdb.c:1863: processing RHYTHMDB_EVENT_QUERY_COMPLETE
(09:14:55) [0x813f6c0] [rhythmdb_read_leave] rhythmdb.c:763: counter: 1
(09:14:55) [0x813f6c0] [rhythmdb_process_events] rhythmdb.c:1856: processing RHYTHMDB_EVENT_THREAD_EXITED
(09:14:55) [0x813f6c0] [rhythmdb_process_events] rhythmdb.c:1863: processing RHYTHMDB_EVENT_QUERY_COMPLETE
(09:14:55) [0x813f6c0] [rhythmdb_read_leave] rhythmdb.c:763: counter: 0
(09:14:55) [0x813f6c0] [rhythmdb_process_events] rhythmdb.c:1856: processing RHYTHMDB_EVENT_THREAD_EXITED
0:01:09.538423000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<oggdemux0>[00m removing pad 'serial_49c4f9cf'
0:01:09.538511000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1486:gst_pad_unlink:[00m unlinking oggdemux0:serial_49c4f9cf(0x8680050) and queue0:sink(0x85aef18)
0:01:09.538565000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<decoder>[00m removing pad 'src0'
0:01:09.538585000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1486:gst_pad_unlink:[00m unlinking decoder:src0(0x85a89c0) and selector_audio_src0:sink0(0x867acc8)
0:01:09.538644000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "fakesrc"
0:01:09.538750000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstBaseSrc@0x8767000>[00m adding pad 'src'
0:01:09.538873000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad fakesrc0:src
0:01:09.538908000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link fakesrc0:src and selector_audio_src0:sink0
0:01:09.542153000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked fakesrc0:src and selector_audio_src0:sink0, successful
0:01:09.542191000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1521:gst_pad_unlink:[00m unlinked decoder:src0 and selector_audio_src0:sink0
0:01:09.542219000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1486:gst_pad_unlink:[00m unlinking vorbisdec1:src(0x867a9c8) and src0:proxypad2(0x861f650)
0:01:09.542241000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1521:gst_pad_unlink:[00m unlinked vorbisdec1:src and src0:proxypad2
0:01:09.542267000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<vorbisdec1>[00m committing state from PLAYING to PAUSED, pending NULL
0:01:09.542309000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<vorbisdec1>[00m continue state change PAUSED to READY, final NULL
0:01:09.559719000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<vorbisdec1>[00m committing state from PAUSED to READY, pending NULL
0:01:09.559782000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<vorbisdec1>[00m continue state change READY to NULL, final NULL
0:01:09.559811000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec1>[00m completed state change
0:01:09.559846000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1486:gst_pad_unlink:[00m unlinking queue0:src(0x867a848) and vorbisdec1:sink(0x867a908)
0:01:09.559868000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1521:gst_pad_unlink:[00m unlinked queue0:src and vorbisdec1:sink
0:01:09.559889000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:961:gst_bin_remove_func:<decoder>[00m removed child "vorbisdec1"
0:01:09.559930000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<queue0>[00m committing state from PLAYING to PAUSED, pending NULL
0:01:09.559958000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<queue0>[00m continue state change PAUSED to READY, final NULL
0:01:09.560113000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2469:gst_element_dispose:<vorbisdec1>[00m dispose
0:01:09.560136000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<vorbisdec1>[00m removing pad 'src'
0:01:09.560159000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<vorbisdec1>[00m removing pad 'sink'
0:01:09.560194000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2494:gst_element_dispose:<vorbisdec1>[00m parent class dispose
0:01:09.560216000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2517:gst_element_finalize:<vorbisdec1>[00m finalize
0:01:09.560236000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2528:gst_element_finalize:<vorbisdec1>[00m finalize parent
0:01:09.560432000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<queue0>[00m committing state from PAUSED to READY, pending NULL
0:01:09.560466000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<queue0>[00m continue state change READY to NULL, final NULL
0:01:09.560492000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<queue0>[00m completed state change
0:01:09.560525000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m       GST_PARENTAGE gstbin.c:961:gst_bin_remove_func:<decoder>[00m removed child "queue0"
0:01:09.560573000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1521:gst_pad_unlink:[00m unlinked oggdemux0:serial_49c4f9cf and queue0:sink
0:01:09.560698000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<vorbisdec0>[00m committing state from PAUSED to READY, pending NULL
0:01:09.560729000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<vorbisdec0>[00m continue state change READY to NULL, final NULL
0:01:09.560754000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec0>[00m completed state change
0:01:09.560782000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2469:gst_element_dispose:<vorbisdec0>[00m dispose
0:01:09.560801000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<vorbisdec0>[00m removing pad 'src'
0:01:09.560819000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1486:gst_pad_unlink:[00m unlinking vorbisdec0:src(0x85aed98) and '':internal(0x85aee58)
0:01:09.560840000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstpad.c:1521:gst_pad_unlink:[00m unlinked vorbisdec0:src and '':internal
0:01:09.560872000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<vorbisdec0>[00m removing pad 'sink'
0:01:09.560901000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2494:gst_element_dispose:<vorbisdec0>[00m parent class dispose
0:01:09.560923000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2517:gst_element_finalize:<vorbisdec0>[00m finalize
0:01:09.560942000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2528:gst_element_finalize:<vorbisdec0>[00m finalize parent
0:01:09.561385000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2469:gst_element_dispose:<queue0>[00m dispose
0:01:09.561423000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<queue0>[00m removing pad 'src'
0:01:09.561453000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:699:gst_element_remove_pad:<queue0>[00m removing pad 'sink'
0:01:09.561481000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2494:gst_element_dispose:<queue0>[00m parent class dispose
0:01:09.561507000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2517:gst_element_finalize:<queue0>[00m finalize
0:01:09.561525000 [333m12134[00m 0x813f6c0 [32;01mINFO [00m [00;01;31;44m     GST_REFCOUNTING gstelement.c:2528:gst_element_finalize:<queue0>[00m finalize parent
0:01:09.561976000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "vorbisdec"
0:01:09.562060000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a4d0>[00m adding pad 'sink'
0:01:09.562125000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a4d0>[00m adding pad 'src'
0:01:09.562160000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec2:sink
0:01:09.562182000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<vorbisdec2>[00m committing state from NULL to READY, pending PAUSED
0:01:09.562212000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<vorbisdec2>[00m continue state change READY to PAUSED, final PAUSED
0:01:09.562246000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec2>[00m completed state change
0:01:09.562311000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec2:src
0:01:09.562339000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link vorbisdec2:src and '':internal
0:01:09.562381000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked vorbisdec2:src and '':internal, successful
0:01:09.564943000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:2827:gst_pad_event_default_dispatch:<'':internal>[00m Sending event 0x8574968 to all internally linked pads
0:01:09.568969000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;34m           GST_EVENT gstevent.c:522:gst_event_new_new_segment_full:[00m creating newsegment update 0, rate 1,000000, format GST_FORMAT_TIME, start 5124095:33:53.452218282, stop 99:99:99.999999999, position 0:00:40.257333334
0:01:09.569033000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<oggdemux0>[00m adding pad 'serial_10062050'
0:01:09.569336000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "queue"
0:01:09.569424000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cfa00>[00m adding pad 'sink'
0:01:09.569487000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cfa00>[00m adding pad 'src'
0:01:09.569576000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<queue2>[00m completed state change
0:01:09.569637000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad queue2:sink
0:01:09.569658000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad queue2:src
0:01:09.569675000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link oggdemux0:serial_10062050 and queue2:sink
0:01:09.569703000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked oggdemux0:serial_10062050 and queue2:sink, successful
0:01:09.569734000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:375:gst_element_factory_create:[00m creating element "vorbisdec"
0:01:09.569801000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a6e0>[00m adding pad 'sink'
0:01:09.569865000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstVorbisDec@0x868a6e0>[00m adding pad 'src'
0:01:09.569897000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec3:sink
0:01:09.569934000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec3>[00m completed state change
0:01:09.569963000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link queue2:src and vorbisdec3:sink
0:01:09.569991000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked queue2:src and vorbisdec3:sink, successful
0:01:09.570027000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad vorbisdec3:src
0:01:09.570146000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<decoder>[00m adding pad 'src1'
0:01:09.570172000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link vorbisdec3:src and src1:proxypad5
0:01:09.570209000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked vorbisdec3:src and src1:proxypad5, successful
0:01:09.570298000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstStreamSelector@0x81b7630>[00m adding pad 'src'
0:01:09.570348000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:373:gst_element_factory_create:[00m creating element "queue" named "preroll_audio_src1"
0:01:09.570414000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cfaf0>[00m adding pad 'sink'
0:01:09.570480000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<GstQueue@0x86cfaf0>[00m adding pad 'src'
0:01:09.570542000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src1:sink
0:01:09.570576000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src1:src
0:01:09.570616000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstutils.c:1315:gst_element_link_pads:[00m trying to link element selector_audio_src1:(any) to element preroll_audio_src1:(any)
0:01:09.570653000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1981:gst_pad_can_link:[00m trying to link selector_audio_src1:src and preroll_audio_src1:src
0:01:09.570672000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:2001:gst_pad_can_link:[00m Sink pad preroll_audio_src1:src is not sink pad, failed
0:01:09.570691000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1981:gst_pad_can_link:[00m trying to link selector_audio_src1:src and preroll_audio_src1:sink
0:01:09.570710000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstutils.c:1219:prepare_link_maybe_ghosting:[00m selector_audio_src1 and preroll_audio_src1 in same bin, no need for ghost pads
0:01:09.570728000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link selector_audio_src1:src and preroll_audio_src1:sink
0:01:09.570753000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked selector_audio_src1:src and preroll_audio_src1:sink, successful
0:01:09.570775000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<selector_audio_src1>[00m committing state from NULL to READY, pending PLAYING
0:01:09.570805000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<selector_audio_src1>[00m continue state change READY to PAUSED, final PLAYING
0:01:09.570830000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<selector_audio_src1>[00m committing state from READY to PAUSED, pending PLAYING
0:01:09.570857000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<selector_audio_src1>[00m continue state change PAUSED to PLAYING, final PLAYING
0:01:09.570876000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<selector_audio_src1>[00m completed state change
0:01:09.570903000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<preroll_audio_src1>[00m committing state from NULL to READY, pending PLAYING
0:01:09.570929000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<preroll_audio_src1>[00m continue state change READY to PAUSED, final PLAYING
0:01:09.570956000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1919:gst_element_continue_state:<preroll_audio_src1>[00m committing state from READY to PAUSED, pending PLAYING
0:01:09.570983000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1928:gst_element_continue_state:<preroll_audio_src1>[00m continue state change PAUSED to PLAYING, final PLAYING
0:01:09.571003000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<preroll_audio_src1>[00m completed state change
0:01:09.571030000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:820:gst_element_get_static_pad:[00m no such pad 'sink%d' in element "selector_audio_src1"
0:01:09.571081000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:602:gst_element_add_pad:<selector_audio_src1>[00m adding pad 'sink0'
0:01:09.571109000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1689:gst_pad_link_prepare:[00m trying to link decoder:src1 and selector_audio_src1:sink0
0:01:09.571151000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:1826:gst_pad_link:[00m linked decoder:src1 and selector_audio_src1:sink0, successful
0:01:09.571204000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<vorbisdec3>[00m completed state change
0:01:09.571268000 [333m12134[00m 0x85af5b0 [32;01mINFO [00m [00;01;31m          GST_STATES gstelement.c:1945:gst_element_continue_state:<queue2>[00m completed state change
(09:15:02) [0x813f6c0] [info_available_cb] rb-shell-player.c:2763: info: 0
(09:15:02) [0x813f6c0] [info_available_cb] rb-shell-player.c:2763: info: 20
0:01:09.574632000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:2827:gst_pad_event_default_dispatch:<selector_audio_src1:sink0>[00m Sending event 0x8574990 to all internally linked pads
0:01:09.574694000 [333m12134[00m 0x86d16d8 [32;01mINFO [00m [00;01;37;41m            GST_PADS gstpad.c:2827:gst_pad_event_default_dispatch:<selector_audio_src1:sink0>[00m Sending event 0x85b3768 to all internally linked pads
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-shell.c:2708: paned position 181
(09:15:02) [0x813f6c0] [sidebar_paned_size_allocate_cb] rb-shell.c:2718: sidebar paned position 300
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:15:02) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:15:02) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-shell.c:2708: paned position 181
(09:15:02) [0x813f6c0] [sidebar_paned_size_allocate_cb] rb-shell.c:2718: sidebar paned position 300
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:15:02) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:15:02) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:15:02) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
0:01:12.588743000 [333m12134[00m 0x86d96b0 [32;01mINFO [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:823:gst_element_get_static_pad:[00m found pad preroll_audio_src0:sink
(09:15:05) [0x813f6c0] [paned_size_allocate_cb] rb-shell.c:2708: paned position 181
(09:15:05) [0x813f6c0] [sidebar_paned_size_allocate_cb] rb-shell.c:2718: sidebar paned position 300
(09:15:05) [0x813f6c0] [paned_size_allocate_cb] rb-browser-source.c:712: paned size allocate
(09:15:05) [0x813f6c0] [paned_size_allocate_cb] rb-iradio-source.c:660: paned size allocate
(09:15:05) [0x813f6c0] [paned_size_allocate_cb] rb-podcast-source.c:955: paned size allocate
(09:15:05) [0x813f6c0] [rb_browser_source_state_pref_changed] rb-browser-source.c:723: state prefs changed
(09:15:05) [0x813f6c0] [rb_browser_source_state_prefs_sync] rb-browser-source.c:733: syncing state
(09:15:11) [0x813f6c0] [rb_tray_icon_show_window_changed_cb] rb-tray-icon.c:475: show window clicked for 0x82fc0c8
(09:15:13) [0x813f6c0] [rb_tray_icon_show_window_changed_cb] rb-tray-icon.c:475: show window clicked for 0x82fc0c8
