0:00:08.519341243 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3319:gst_pad_iterate_internal_links_default:<tee0:sink>[00m Making iterator
0:00:08.519370018 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:3554:gst_pad_event_default_dispatch:<tee0:sink>[00m Reffing and sending event 0x29c0b00 (flush-stop) to tee0:src0
0:00:08.519398663 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5188:gst_pad_push_event:<tee0:src0>[00m event: flush-stop
0:00:08.519434838 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5215:gst_pad_push_event:<tee0:src0>[00m Pad is blocked, not forwarding flush-stop
0:00:08.519460712 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5276:gst_pad_push_event:<tee0:src0>[00m Not forwarding event since we're flushing and blocking
0:00:08.519490457 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:3600:gst_pad_event_default_dispatch:<tee0:sink>[00m handled event 0x29c0b00, unreffing
0:00:08.519515547 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;34m           GST_EVENT gstevent.c:225:gst_event_finalize:[00m freeing event 0x29c0b00 type flush-stop
0:00:08.519544902 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<tee0:sink>[00m sent event, result 1
0:00:08.519570861 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<gestimeline1:track_0x389fbb0_src>[00m sent event to peerpad <tee0:sink>, result 1
0:00:08.519601466 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<track_0x389fbb0_src:proxypad35>[00m sent event, result 1
0:00:08.519627256 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<gestrack3:src>[00m sent event to peerpad <track_0x389fbb0_src:proxypad35>, result 1
0:00:08.519656476 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<src:proxypad34>[00m sent event, result 1
0:00:08.519681776 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<gnlcomposition3:src>[00m sent event to peerpad <src:proxypad34>, result 1
0:00:08.519711140 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<src:proxypad33>[00m sent event, result 1
0:00:08.519736455 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<gnlsource0:src>[00m sent event to peerpad <src:proxypad33>, result 1
0:00:08.519765470 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<src:proxypad32>[00m sent event, result 1
0:00:08.519791115 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<still-image-bin:src>[00m sent event to peerpad <src:proxypad32>, result 1
0:00:08.519819940 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<src:proxypad27>[00m sent event, result 1
0:00:08.519845265 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<imagefreeze0:src>[00m sent event to peerpad <src:proxypad27>, result 1
0:00:08.519879689 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00m         imagefreeze gstimagefreeze.c:693:gst_image_freeze_src_event:<imagefreeze0:src>[00m Seek successful
0:00:08.519904144 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<imagefreeze0:src>[00m sent event, result 1
0:00:08.519929739 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<src:proxypad27>[00m sent event to peerpad <imagefreeze0:src>, result 1
0:00:08.519959014 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<still-image-bin:src>[00m sent event, result 1
0:00:08.519984328 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<src:proxypad32>[00m sent event to peerpad <still-image-bin:src>, result 1
0:00:08.519954934 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3063:gst_pad_alloc_buffer_full:<imagefreeze0:src>[00m offset 18446744073709551615, size 3888000, caps video/x-raw-rgb, width=(int)1440, height=(int)900, bpp=(int)24, framerate=(fraction)0/1, depth=(int)24, endianness=(int)4321, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255
0:00:08.520010705 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;34m         gnlghostpad gnlghostpad.c:518:ghostpad_event_function:<gnlsource0:src>[00m Returned from calling priv->eventfunc : 1
0:00:08.520033183 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:2984:gst_pad_buffer_alloc_unchecked:<src:proxypad27>[00m calling bufferallocfunc &gst_proxy_pad_do_bufferalloc (@0x7fa813ace1f0) for size 3888000 offset NONE
0:00:08.520044462 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<gnlsource0:src>[00m sent event, result 1
0:00:08.520066634 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<src:proxypad33>[00m sent event to peerpad <gnlsource0:src>, result 1
0:00:08.520078228 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;34m         gnlghostpad gnlghostpad.c:518:ghostpad_event_function:<gnlcomposition3:src>[00m Returned from calling priv->eventfunc : 1
0:00:08.520088088 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;34m      gnlcomposition gnlcomposition.c:1074:gnl_composition_event_handler:<gnlcomposition3>[00m Done calling gnl_event_pad_func() 1
0:00:08.520057464 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3063:gst_pad_alloc_buffer_full:<still-image-bin:src>[00m offset 18446744073709551615, size 3888000, caps video/x-raw-rgb, width=(int)1440, height=(int)900, bpp=(int)24, framerate=(fraction)0/1, depth=(int)24, endianness=(int)4321, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255
0:00:08.520096852 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;34m      gnlcomposition gnlcomposition.c:1077:gnl_composition_event_handler:<gnlcomposition3>[00m unlocking objects_lock from thread 0x2477b10
0:00:08.520113094 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:2984:gst_pad_buffer_alloc_unchecked:<src:proxypad32>[00m calling bufferallocfunc &gst_proxy_pad_do_bufferalloc (@0x7fa813ace1f0) for size 3888000 offset NONE
0:00:08.520123124 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<gnlcomposition3:src>[00m sent event, result 1
0:00:08.520145383 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<src:proxypad34>[00m sent event to peerpad <gnlcomposition3:src>, result 1
0:00:08.520136444 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3063:gst_pad_alloc_buffer_full:<gnlsource0:src>[00m offset 18446744073709551615, size 3888000, caps video/x-raw-rgb, width=(int)1440, height=(int)900, bpp=(int)24, framerate=(fraction)0/1, depth=(int)24, endianness=(int)4321, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255
0:00:08.520157085 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<gestrack3:src>[00m sent event, result 1
0:00:08.520170751 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:2984:gst_pad_buffer_alloc_unchecked:<src:proxypad33>[00m calling bufferallocfunc &gst_proxy_pad_do_bufferalloc (@0x7fa813ace1f0) for size 3888000 offset NONE
0:00:08.520180296 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<track_0x389fbb0_src:proxypad35>[00m sent event to peerpad <gestrack3:src>, result 1
0:00:08.520194711 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3063:gst_pad_alloc_buffer_full:<gnlcomposition3:src>[00m offset 18446744073709551615, size 3888000, caps video/x-raw-rgb, width=(int)1440, height=(int)900, bpp=(int)24, framerate=(fraction)0/1, depth=(int)24, endianness=(int)4321, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255
0:00:08.520206863 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<gestimeline1:track_0x389fbb0_src>[00m sent event, result 1
0:00:08.520228616 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<tee0:sink>[00m sent event to peerpad <gestimeline1:track_0x389fbb0_src>, result 1
0:00:08.520218586 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:2984:gst_pad_buffer_alloc_unchecked:<src:proxypad34>[00m calling bufferallocfunc &gst_proxy_pad_do_bufferalloc (@0x7fa813ace1f0) for size 3888000 offset NONE
0:00:08.520239912 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<tee0:src0>[00m sent event, result 1
0:00:08.520260474 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<internal-sinks:video_sink>[00m sent event to peerpad <tee0:src0>, result 1
0:00:08.520252777 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3063:gst_pad_alloc_buffer_full:<gestrack3:src>[00m offset 18446744073709551615, size 3888000, caps video/x-raw-rgb, width=(int)1440, height=(int)900, bpp=(int)24, framerate=(fraction)0/1, depth=(int)24, endianness=(int)4321, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255
0:00:08.520272666 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<video_sink:proxypad36>[00m sent event, result 1
0:00:08.520302984 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<streamsynchronizer1:sink_0>[00m sent event to peerpad <video_sink:proxypad36>, result 1
0:00:08.520314516 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<streamsynchronizer1:src_0>[00m sent event, result 1
0:00:08.520286712 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:2984:gst_pad_buffer_alloc_unchecked:<track_0x389fbb0_src:proxypad35>[00m calling bufferallocfunc &gst_proxy_pad_do_bufferalloc (@0x7fa813ace1f0) for size 3888000 offset NONE
0:00:08.520323684 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<vbin:sink>[00m sent event to peerpad <streamsynchronizer1:src_0>, result 1
0:00:08.520354936 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<sink:proxypad38>[00m sent event, result 1
0:00:08.520364310 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<vqueue:sink>[00m sent event to peerpad <sink:proxypad38>, result 1
0:00:08.520349365 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3063:gst_pad_alloc_buffer_full:<gestimeline1:track_0x389fbb0_src>[00m offset 18446744073709551615, size 3888000, caps video/x-raw-rgb, width=(int)1440, height=(int)900, bpp=(int)24, framerate=(fraction)0/1, depth=(int)24, endianness=(int)4321, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255
0:00:08.520377004 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<vqueue:src>[00m sent event, result 1
0:00:08.520394042 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:2984:gst_pad_buffer_alloc_unchecked:<tee0:sink>[00m calling bufferallocfunc &gst_tee_buffer_alloc (@0x7fa80d46b6b0) for size 3888000 offset NONE
0:00:08.520402573 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<videosink:sink>[00m sent event to peerpad <vqueue:src>, result 1
0:00:08.520420319 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00m                 tee gsttee.c:587:gst_tee_buffer_alloc:<tee0>[00m finding pad for alloc
0:00:08.520429383 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:5403:gst_pad_send_event:<sink:proxypad37>[00m sent event, result 1
0:00:08.520451805 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;31;41m            GST_PADS gstpad.c:5254:gst_pad_push_event:<videosink-actual-sink-xvimage:sink>[00m sent event to peerpad <sink:proxypad37>, result 1
0:00:08.520442810 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00m                 tee gsttee.c:504:gst_tee_find_buffer_alloc:<tee0>[00m try alloc on pad tee0:src0
0:00:08.520466739 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<internal-sinks>[00m child streamsynchronizer1 is not sink
0:00:08.520485594 [333m21542[00m      0x2477b10 [37mLOG    [00m [00;01;34m           GST_EVENT gstevent.c:225:gst_event_finalize:[00m freeing event 0x29f3600 type seek
0:00:08.520477920 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;01;31;41m            GST_PADS gstpad.c:3063:gst_pad_alloc_buffer_full:<tee0:src0>[00m offset 18446744073709551615, size 3888000, caps video/x-raw-rgb, width=(int)1440, height=(int)900, bpp=(int)24, framerate=(fraction)0/1, depth=(int)24, endianness=(int)4321, red_mask=(int)16711680, green_mask=(int)65280, blue_mask=(int)255
0:00:08.520505002 [333m21542[00m      0x4058530 [37mLOG    [00m [00;01;35m      GST_SCHEDULING gstpad.c:4022:handle_pad_block:<tee0:src0>[00m signal block taken
0:00:08.520517270 [333m21542[00m      0x4058530 [36mDEBUG  [00m [00;33m                 ges ges-timeline-pipeline.c:390:pad_blocked:<tee0:src0>[00m blocked callback, blocked: 1
0:00:08.520528863 [333m21542[00m      0x4058530 [37mLOG    [00m [00;01;35m      GST_SCHEDULING gstpad.c:4074:handle_pad_block:<tee0:src0>[00m Waiting to be unblocked or set flushing
0:00:08.520810968 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00m               query gstquery.c:363:gst_query_new:[00m creating new query 0x7fa80400f2c0 1
0:00:08.520854038 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:1778:gst_element_query:[00m send query on element gestimelinepipeline1
0:00:08.520890747 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3630:gst_bin_query:<gestimelinepipeline1>[00m Sending query 0x7fa80400f2c0 (type position) to sink children
0:00:08.520919052 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<gestimelinepipeline1>[00m child tee0 is not sink
0:00:08.520946832 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<gestimelinepipeline1>[00m child gestimeline1 is not sink
0:00:08.520973141 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<gestimelinepipeline1>[00m child internal-sinks is sink
0:00:08.520997821 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:1778:gst_element_query:[00m send query on element internal-sinks
0:00:08.521026626 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3630:gst_bin_query:<internal-sinks>[00m Sending query 0x7fa80400f2c0 (type position) to sink children
0:00:08.521052191 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<internal-sinks>[00m child vbin is sink
0:00:08.521088886 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:1778:gst_element_query:[00m send query on element vbin
0:00:08.521119040 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3630:gst_bin_query:<vbin>[00m Sending query 0x7fa80400f2c0 (type position) to sink children
0:00:08.521145406 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<vbin>[00m child vqueue is not sink
0:00:08.521172425 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<vbin>[00m child videosink is sink
0:00:08.521196270 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:1778:gst_element_query:[00m send query on element videosink
0:00:08.521225715 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3630:gst_bin_query:<videosink>[00m Sending query 0x7fa80400f2c0 (type position) to sink children
0:00:08.521251065 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<videosink>[00m child videosink-actual-sink-xvimage is sink
0:00:08.521275579 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;37;41m    GST_ELEMENT_PADS gstelement.c:1778:gst_element_query:[00m send query on element videosink-actual-sink-xvimage
0:00:08.521320159 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00m            basesink gstbasesink.c:4818:gst_base_sink_query:<videosink-actual-sink-xvimage>[00m position query in format time
0:00:08.521347544 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00m            basesink gstbasesink.c:4739:gst_base_sink_get_position:<videosink-actual-sink-xvimage>[00m position in wrong state, return -1
0:00:08.521371214 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00m            basesink gstbasesink.c:4728:gst_base_sink_get_position:<videosink-actual-sink-xvimage>[00m res: 0, POSITION: 99:99:99.999999999
0:00:08.521397758 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00m            basesink gstbasesink.c:4923:gst_base_sink_query:<videosink-actual-sink-xvimage>[00m query position returns 0
0:00:08.521423558 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3664:gst_bin_query:<videosink>[00m query 0x7fa80400f2c0 result 0
0:00:08.521449723 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3664:gst_bin_query:<vbin>[00m query 0x7fa80400f2c0 result 0
0:00:08.521474733 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstbin.c:1647:bin_element_is_sink:<internal-sinks>[00m child streamsynchronizer1 is not sink
0:00:08.521501433 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3664:gst_bin_query:<internal-sinks>[00m query 0x7fa80400f2c0 result 0
0:00:08.521526723 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01m                 bin gstbin.c:3664:gst_bin_query:<gestimelinepipeline1>[00m query 0x7fa80400f2c0 result 0
0:00:08.522770545 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;33m                 ges ges-timeline-object.c:1172:ges_timeline_object_get_top_effects:<GESTimelineFileSource@0x3d3a730>[00m Getting the 0 top effects
0:00:08.523147227 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;33m                 ges ges-timeline-object.c:1172:ges_timeline_object_get_top_effects:<GESTimelineFileSource@0x3d3a730>[00m Getting the 0 top effects
0:00:09.700029267 [333m21542[00m      0x2477b10 [32;01mINFO   [00m [00;01;31m          GST_STATES gstbin.c:1767:gst_bin_get_state_func:<gestimelinepipeline1>[00m getting state
0:00:09.700130182 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstelement.c:2114:gst_element_get_state_func:<gestimelinepipeline1>[00m getting state, timeout 99:99:99.999999999
0:00:09.700211736 [333m21542[00m      0x2477b10 [36mDEBUG  [00m [00;01;31m          GST_STATES gstelement.c:2119:gst_element_get_state_func:<gestimelinepipeline1>[00m RETURN is ASYNC
0:00:09.700260776 [333m21542[00m      0x2477b10 [32;01mINFO   [00m [00;01;31m          GST_STATES gstelement.c:2155:gst_element_get_state_func:<gestimelinepipeline1>[00m waiting for element to commit state
