0:00:08.660433830 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:775:gst_decode_bin_set_subs_encoding:<decodebin250>[00m Setting new encoding: (NULL)
0:00:08.660486773 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:777:gst_decode_bin_set_subs_encoding:<decodebin250>[00m locking from thread 0x6034d0
0:00:08.660507657 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:777:gst_decode_bin_set_subs_encoding:<decodebin250>[00m locked from thread 0x6034d0
0:00:08.660526864 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:788:gst_decode_bin_set_subs_encoding:<decodebin250>[00m unlocking from thread 0x6034d0
0:00:08.662184711 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1416:type_found:<decodebin250>[00m typefind found caps application/x-id3
0:00:08.662247083 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:958:analyze_new_pad:<decodebin250>[00m Pad typefind:src caps:application/x-id3
0:00:08.662484697 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:860:gst_decode_bin_autoplug_continue:<decodebin250>[00m autoplug-continue returns TRUE
0:00:08.662515428 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1623:are_raw_caps:<decodebin250>[00m Checking with caps application/x-id3
0:00:08.662543087 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1634:are_raw_caps:<decodebin250>[00m Caps are not final caps
0:00:08.663100243 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:891:gst_decode_bin_autoplug_sort:<decodebin250>[00m autoplug-sort returns 0x919020
0:00:08.663143617 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1009:analyze_new_pad:<typefind:src>[00m Let's continue discovery on this pad
0:00:08.663163592 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1103:connect_pad:<decodebin250>[00m pad typefind:src , group:(nil)
0:00:08.663204452 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1140:connect_pad:<decodebin250>[00m autoplug select requested try
0:00:08.663979804 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1206:connect_pad:<decodebin250>[00m linked on pad typefind:src
0:00:08.664013051 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1260:connect_element:<decodebin250>[00m Attempting to connect element id3demux50 [group:(nil)] further
0:00:08.664036658 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1273:connect_element:<decodebin250>[00m got a source pad template src
0:00:08.664082756 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1308:connect_element:<decodebin250>[00m did not get the sometimes pad of template src
0:00:08.669693775 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1498:pad_added_cb:<id3demux50:src>[00m Pad added to non-grouped element
0:00:08.669742876 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:958:analyze_new_pad:<decodebin250>[00m Pad id3demux50:src caps:application/ogg
0:00:08.669981537 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:860:gst_decode_bin_autoplug_continue:<decodebin250>[00m autoplug-continue returns TRUE
0:00:08.670008777 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1623:are_raw_caps:<decodebin250>[00m Checking with caps application/ogg
0:00:08.670034969 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1634:are_raw_caps:<decodebin250>[00m Caps are not final caps
0:00:08.670636407 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:891:gst_decode_bin_autoplug_sort:<decodebin250>[00m autoplug-sort returns 0x8af220
0:00:08.670666021 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1009:analyze_new_pad:<id3demux50:src>[00m Let's continue discovery on this pad
0:00:08.670685647 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1103:connect_pad:<decodebin250>[00m pad id3demux50:src , group:(nil)
0:00:08.670723364 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1140:connect_pad:<decodebin250>[00m autoplug select requested try
0:00:08.670926474 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1206:connect_pad:<decodebin250>[00m linked on pad id3demux50:src
0:00:08.670950431 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1260:connect_element:<decodebin250>[00m Attempting to connect element oggdemux50 [group:(nil)] further
0:00:08.671322357 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1273:connect_element:<decodebin250>[00m got a source pad template src_%d
0:00:08.671344498 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1308:connect_element:<decodebin250>[00m did not get the sometimes pad of template src_%d
0:00:08.683866635 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1498:pad_added_cb:<oggdemux50:serial_5f001488>[00m Pad added to non-grouped element
0:00:08.683917832 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:958:analyze_new_pad:<decodebin250>[00m Pad oggdemux50:serial_5f001488 caps:audio/x-vorbis
0:00:08.684130371 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:860:gst_decode_bin_autoplug_continue:<decodebin250>[00m autoplug-continue returns TRUE
0:00:08.684158099 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1623:are_raw_caps:<decodebin250>[00m Checking with caps audio/x-vorbis
0:00:08.684184222 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1634:are_raw_caps:<decodebin250>[00m Caps are not final caps
0:00:08.684642057 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:891:gst_decode_bin_autoplug_sort:<decodebin250>[00m autoplug-sort returns 0x86d680
0:00:08.684670484 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1009:analyze_new_pad:<oggdemux50:serial_5f001488>[00m Let's continue discovery on this pad
0:00:08.684691089 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1103:connect_pad:<decodebin250>[00m pad oggdemux50:serial_5f001488 , group:(nil)
0:00:08.684741866 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1107:connect_pad:<oggdemux50>[00m is a demuxer, connecting the pad through multiqueue
0:00:08.684761493 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1726:get_current_group:<decodebin250>[00m locking from thread 0x820900
0:00:08.684779792 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1726:get_current_group:<decodebin250>[00m locked from thread 0x820900
0:00:08.684797253 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1666:gst_decode_group_new:<decodebin250>[00m Creating new group
0:00:08.684936315 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1704:gst_decode_group_new:<decodebin250>[00m Returning new group 0x7fd31c00d140
0:00:08.684959574 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1739:get_current_group:<decodebin250>[00m added group 0x7fd31c00d140, demux 1
0:00:08.684978502 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1744:get_current_group:<decodebin250>[00m unlocking from thread 0x820900
0:00:08.685007208 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1746:get_current_group:<decodebin250>[00m Returning group 0x7fd31c00d140
0:00:08.685062735 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1764:gst_decode_group_control_demuxer_pad:[00m group:0x7fd31c00d140 pad oggdemux50:serial_5f001488
0:00:08.685299720 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1785:gst_decode_group_control_demuxer_pad:<decodebin250>[00m locking group 0x7fd31c00d140 from thread 0x820900
0:00:08.685413708 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1517:no_more_pads_cb:<id3demux50>[00m No more pads, setting current group to complete
0:00:08.685445417 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1726:get_current_group:<decodebin250>[00m locking from thread 0x6034d0
0:00:08.685467628 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1726:get_current_group:<decodebin250>[00m locked from thread 0x6034d0
0:00:08.685486626 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1730:get_current_group:<decodebin250>[00m group 0x7fd31c00d140, complete:0
0:00:08.685505484 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1744:get_current_group:<decodebin250>[00m unlocking from thread 0x6034d0
0:00:08.685523435 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1746:get_current_group:<decodebin250>[00m Returning group 0x7fd31c00d140
0:00:08.685542153 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2250:gst_decode_group_set_complete:<decodebin250>[00m Setting group 0x7fd31c00d140 to COMPLETE
0:00:08.685560383 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2252:gst_decode_group_set_complete:<decodebin250>[00m locking group 0x7fd31c00d140 from thread 0x6034d0
0:00:08.686058240 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1785:gst_decode_group_control_demuxer_pad:<decodebin250>[00m locked group 0x7fd31c00d140 from thread 0x820900
0:00:08.686105595 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1794:gst_decode_group_control_demuxer_pad:<decodebin250>[00m unlocking group 0x7fd31c00d140 from thread 0x820900
0:00:08.686139190 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2252:gst_decode_group_set_complete:<decodebin250>[00m locked group 0x7fd31c00d140 from thread 0x6034d0
0:00:08.686189409 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1834:gst_decode_group_check_if_blocked:[00m group : 0x7fd31c00d140 , ->complete:1 , ->nbdynamic:0
0:00:08.686209315 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1853:gst_decode_group_check_if_blocked:[00m group is blocked:1
0:00:08.686218046 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1140:connect_pad:<decodebin250>[00m autoplug select requested try
0:00:08.686228243 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1860:gst_decode_group_check_if_blocked:<decodebin250>[00m locking from thread 0x6034d0
0:00:08.686249336 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1860:gst_decode_group_check_if_blocked:<decodebin250>[00m locked from thread 0x6034d0
0:00:08.686267706 [334m18717[00m       0x6034d0 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1990:gst_decode_group_expose:<decodebin250>[00m going to expose group 0x7fd31c00d140
0:00:08.686364581 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2012:gst_decode_group_expose:[00m Disconnecting overrun
0:00:08.686388398 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2030:gst_decode_group_expose:[00m Exposing group 0x7fd31c00d140
0:00:08.686408025 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2067:gst_decode_group_expose:<decodebin250>[00m signalling no-more-pads
0:00:08.686446090 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2086:gst_decode_group_expose:<decodebin250>[00m removed group 0x7fd31c00d140
0:00:08.686492607 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2096:gst_decode_group_expose:<decodebin250>[00m Group 0x7fd31c00d140 exposed
0:00:08.686513142 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1863:gst_decode_group_check_if_blocked:<decodebin250>[00m unlocking from thread 0x6034d0
0:00:08.686531791 [334m18717[00m       0x6034d0 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2255:gst_decode_group_set_complete:<decodebin250>[00m unlocking group 0x7fd31c00d140 from thread 0x6034d0
0:00:08.686537937 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1206:connect_pad:<decodebin250>[00m linked on pad multiqueue5:src0
0:00:08.686564339 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1260:connect_element:<decodebin250>[00m Attempting to connect element vorbisdec53 [group:0x7fd31c00d140] further
0:00:08.686585781 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1273:connect_element:<decodebin250>[00m got a source pad template src
0:00:08.686606246 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1284:connect_element:<decodebin250>[00m got the pad for always template src
0:00:08.686642635 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:958:analyze_new_pad:<decodebin250>[00m Pad vorbisdec53:src caps:audio/x-raw-float, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 256 ], endianness=(int)1234, width=(int)32
0:00:08.686850425 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:860:gst_decode_bin_autoplug_continue:<decodebin250>[00m autoplug-continue returns TRUE
0:00:08.686879061 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1623:are_raw_caps:<decodebin250>[00m Checking with caps audio/x-raw-float, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 256 ], endianness=(int)1234, width=(int)32
0:00:08.686927674 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1634:are_raw_caps:<decodebin250>[00m Caps are final caps
0:00:08.686969860 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1019:analyze_new_pad:<decodebin250>[00m Pad is final. autoplug-continue:1
0:00:08.686990045 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1378:expose_pad:<decodebin250>[00m pad vorbisdec53:src, group:0x7fd31c00d140
0:00:08.687010650 [334m18717[00m       0x820900 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1807:gst_decode_group_control_source_pad:<'':decodepad113>[00m adding decode pad to group 0x7fd31c00d140
0:00:08.687041661 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1812:gst_decode_group_control_source_pad:<decodebin250>[00m locking group 0x7fd31c00d140 from thread 0x820900
0:00:08.687061986 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1812:gst_decode_group_control_source_pad:<decodebin250>[00m locked group 0x7fd31c00d140 from thread 0x820900
0:00:08.687081962 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1814:gst_decode_group_control_source_pad:<decodebin250>[00m unlocking group 0x7fd31c00d140 from thread 0x820900
0:00:08.687139305 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1517:no_more_pads_cb:<oggdemux50>[00m No more pads, setting current group to complete
0:00:08.687161515 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1726:get_current_group:<decodebin250>[00m locking from thread 0x820900
0:00:08.687179885 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1726:get_current_group:<decodebin250>[00m locked from thread 0x820900
0:00:08.687197486 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1744:get_current_group:<decodebin250>[00m unlocking from thread 0x820900
0:00:08.687215087 [334m18717[00m       0x820900 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1746:get_current_group:<decodebin250>[00m Returning group (nil)
0:00:08.687235621 [334m18717[00m       0x820900 [33;01mWARN [00m [00m          decodebin2 gstdecodebin2.c:1528:no_more_pads_cb:<decodebin250>[00m We couldn't find a non-completed group !!
ERROR: state change failed, sret=1
0:00:08.690265020 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2282:source_pad_blocked_cb:<'':decodepad113>[00m blocked:1, dpad->group:0x7fd31c00d140
0:00:08.690298615 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2288:source_pad_blocked_cb:<decodebin250>[00m locking group 0x7fd31c00d140 from thread 0x7c5b60
0:00:08.690319848 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2288:source_pad_blocked_cb:<decodebin250>[00m locked group 0x7fd31c00d140 from thread 0x7c5b60
0:00:08.690351279 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1834:gst_decode_group_check_if_blocked:[00m group : 0x7fd31c00d140 , ->complete:1 , ->nbdynamic:0
0:00:08.690369438 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1853:gst_decode_group_check_if_blocked:[00m group is blocked:1
0:00:08.690387878 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1860:gst_decode_group_check_if_blocked:<decodebin250>[00m locking from thread 0x7c5b60
0:00:08.690406387 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1860:gst_decode_group_check_if_blocked:<decodebin250>[00m locked from thread 0x7c5b60
0:00:08.690424546 [334m18717[00m       0x7c5b60 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1990:gst_decode_group_expose:<decodebin250>[00m going to expose group 0x7fd31c00d140
0:00:08.690442706 [334m18717[00m       0x7c5b60 [36mDEBUG[00m [00m          decodebin2 gstdecodebin2.c:1999:gst_decode_group_expose:<decodebin250>[00m Group 0x7fd31c00d140 is already exposed, all is fine
0:00:08.690483985 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:1863:gst_decode_group_check_if_blocked:<decodebin250>[00m unlocking from thread 0x7c5b60
0:00:08.690502773 [334m18717[00m       0x7c5b60 [37mLOG  [00m [00m          decodebin2 gstdecodebin2.c:2290:source_pad_blocked_cb:<decodebin250>[00m unlocking group 0x7fd31c00d140 from thread 0x7c5b60
