issue to play a rtsp video with hardware acceleration in Clutter
Jezequel, Erwan
e.jezequel at fondation-parkings.ch
Fri Apr 4 01:29:13 PDT 2014
I am running ubuntu 13.10.
Here are the version installed on my system :
dpkg -l | grep -i 'gstreamer-vaapi\|clutter-gst'
ii gir1.2-clutter-gst-2.0 2.0.8-1
i386 Gobject introspection data for Clutter
GStreamer elements
ii libclutter-gst-1.0-0:i386 1.6.0-2
i386 Open GL based interactive canvas library
GStreamer elements
ii libclutter-gst-2.0-0:i386 2.0.8-1
i386 Open GL based interactive canvas library
GStreamer elements
ii libclutter-gst-2.0-dev 2.0.8-1
i386 Open GL based interactive canvas library
GStreamer elements (development files)
ii libgstreamer-vaapi0.10:i386 0.3.6-0ubuntu4
i386 GStreamer libraries from the "vaapi" set
ii libgstreamer-vaapi1.0-0:i386 0.5.7-0ubuntu4
i386 GStreamer libraries from the "vaapi" set
Here is the debug log filtered on vaapidecode and clutter :
GST_DEBUG=5 python3 simple_player.py aa 2>&1 | grep -i
'vaapidecode\|clutter'
0:00:00.014856126 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistry.c:463:gst_registry_add_plugin:<registry0> adding plugin
0x9ccf030 for filename
"/usr/lib/i386-linux-gnu/gstreamer-1.0/libgstclutter.so"
0:00:00.014862120 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistrychunks.c:815:_priv_gst_registry_chunks_load_plugin: Added plugin
'clutter' plugin with 2 features from binary registry
0:00:00.014866986 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistrychunks.c:547:gst_registry_chunks_load_feature: Plugin 'clutter'
feature 'cluttersink' typename : 'GstElementFactory'
0:00:00.014933701 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistry.c:574:gst_registry_add_feature:<registry0> adding feature
0x9ccebc0 (cluttersink)
0:00:00.014938804 29253 0x9c8fe40 DEBUG GST_REFCOUNTING
gstobject.c:684:gst_object_set_parent:<cluttersink> set parent (ref and
sink)
0:00:00.014943583 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistrychunks.c:667:gst_registry_chunks_load_feature: Added feature
cluttersink, plugin 0x9ccf030 clutter
0:00:00.014951510 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistrychunks.c:547:gst_registry_chunks_load_feature: Plugin 'clutter'
feature 'autocluttersink' typename : 'GstElementFactory'
0:00:00.015013986 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistry.c:574:gst_registry_add_feature:<registry0> adding feature
0x9ccec48 (autocluttersink)
0:00:00.015019358 29253 0x9c8fe40 DEBUG GST_REFCOUNTING
gstobject.c:684:gst_object_set_parent:<autocluttersink> set parent (ref and
sink)
0:00:00.015024067 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistrychunks.c:667:gst_registry_chunks_load_feature: Added feature
autocluttersink, plugin 0x9ccf030 clutter
0:00:00.290983695 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistrychunks.c:547:gst_registry_chunks_load_feature: Plugin 'vaapi'
feature 'vaapidecode' typename : 'GstElementFactory'
0:00:00.291084534 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistry.c:574:gst_registry_add_feature:<registry0> adding feature
0x9cfbaa8 (vaapidecode)
0:00:00.291092874 29253 0x9c8fe40 DEBUG GST_REFCOUNTING
gstobject.c:684:gst_object_set_parent:<vaapidecode> set parent (ref and
sink)
0:00:00.291100294 29253 0x9c8fe40 DEBUG GST_REGISTRY
gstregistrychunks.c:667:gst_registry_chunks_load_feature: Added feature
vaapidecode, plugin 0x9dc21b0 vaapi
0:00:00.388637572 29253 0x9c8fe40 DEBUG GST_ELEMENT_FACTORY
gstelementfactory.c:226:gst_element_register:<registry0> update existing
feature 0x9ccebc0 (cluttersink)
0:00:00.388728758 29253 0x9c8fe40 INFO GST_PLUGIN_LOADING
gstplugin.c:225:gst_plugin_register_static: registered static plugin
"cluttersink"
0:00:00.388817696 29253 0x9c8fe40 INFO GST_PLUGIN_LOADING
gstplugin.c:227:gst_plugin_register_static: added static plugin
"cluttersink", result: 1
0:00:00.400090904 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:278:gst_element_base_class_init: type ClutterGstVideoSink :
factory 0x9ccebc0
0:00:00.400706743 29253 0x9c8fe40 INFO cluttersink
./clutter-gst-video-sink.c:1269:clutter_gst_build_renderers_list: GL
features: 0x00000007
0:00:00.422103406 29253 0x9c8fe40 DEBUG GST_PLUGIN_LOADING
gstpluginfeature.c:105:gst_plugin_feature_load: loading plugin for feature
0x9cfbaa8; 'vaapidecode'
0:00:00.434552448 29253 0x9c8fe40 DEBUG GST_ELEMENT_FACTORY
gstelementfactory.c:226:gst_element_register:<registry0> update existing
feature 0x9cfbaa8 (vaapidecode)
0:00:00.435304154 29253 0x9c8fe40 INFO GST_ELEMENT_FACTORY
gstelementfactory.c:365:gst_element_factory_create: creating element
"vaapidecode"
0:00:00.435341006 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:278:gst_element_base_class_init: type GstVaapiDecode : factory
0x9cfbaa8
0:00:00.435762618 29253 0x9c8fe40 DEBUG GST_ELEMENT_FACTORY
gstelementfactory.c:391:gst_element_factory_create: created element
"vaapidecode"
0:00:00.436868339 29253 0x9c8fe40 DEBUG GST_PARENTAGE
gstbin.c:1303:gst_bin_add: adding element vaapidecode0 to bin pipeline0
0:00:00.436882785 29253 0x9c8fe40 DEBUG bin
gstbin.c:1103:gst_bin_add_func:<pipeline0> element :vaapidecode0
0:00:00.436888381 29253 0x9c8fe40 DEBUG GST_REFCOUNTING
gstobject.c:684:gst_object_set_parent:<vaapidecode0> set parent (ref and
sink)
0:00:00.436893824 29253 0x9c8fe40 DEBUG GST_PARENTAGE
gstelement.c:2965:gst_element_set_bus_func:<vaapidecode0> setting bus to
0xa085b18
0:00:00.436899293 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:465:gst_element_set_base_time:<vaapidecode0> set
base_time=0:00:00.000000000, old 0:00:00.000000000
0:00:00.436908104 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:527:gst_element_set_start_time:<vaapidecode0> set
start_time=0:00:00.000000000, old 0:00:00.000000000
0:00:00.436915802 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:408:gst_element_set_clock:<vaapidecode0> setting clock (nil)
0:00:00.436927299 29253 0x9c8fe40 DEBUG GST_PARENTAGE
gstbin.c:1228:gst_bin_add_func:<pipeline0> added element "vaapidecode0"
0:00:00.436943341 29253 0x9c8fe40 DEBUG GST_PARENTAGE
gstbin.c:1303:gst_bin_add: adding element cluttergstvideosink0 to bin
pipeline0
0:00:00.436951036 29253 0x9c8fe40 DEBUG bin
gstbin.c:1103:gst_bin_add_func:<pipeline0> element :cluttergstvideosink0
0:00:00.436956608 29253 0x9c8fe40 DEBUG GST_REFCOUNTING
gstobject.c:684:gst_object_set_parent:<cluttergstvideosink0> set parent
(ref and sink)
0:00:00.436961531 29253 0x9c8fe40 DEBUG GST_PARENTAGE
gstbin.c:1137:gst_bin_add_func:<pipeline0> element "cluttergstvideosink0"
was sink
0:00:00.436967709 29253 0x9c8fe40 DEBUG GST_PARENTAGE
gstelement.c:2965:gst_element_set_bus_func:<cluttergstvideosink0> setting
bus to 0xa085b18
0:00:00.436973063 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:465:gst_element_set_base_time:<cluttergstvideosink0> set
base_time=0:00:00.000000000, old 0:00:00.000000000
0:00:00.436981304 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:527:gst_element_set_start_time:<cluttergstvideosink0> set
start_time=0:00:00.000000000, old 0:00:00.000000000
0:00:00.436989112 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:408:gst_element_set_clock:<cluttergstvideosink0> setting clock
(nil)
0:00:00.437000456 29253 0x9c8fe40 DEBUG GST_PARENTAGE
gstbin.c:1228:gst_bin_add_func:<pipeline0> added element
"cluttergstvideosink0"
0:00:00.437118865 29253 0x9c8fe40 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
rtph264depay0:(any) to element vaapidecode0:(any)
0:00:00.437152577 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1006:gst_element_get_compatible_pad: finding pad in vaapidecode0
compatible with rtph264depay0:src
0:00:00.437161754 29253 0x9c8fe40 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link rtph264depay0:src and
vaapidecode0:sink
0:00:00.440023586 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<vaapidecode0:sink> get pad caps with
filter (NULL)
0:00:00.440035226 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:sink> doing query 0xa0f46c0 (caps)
0:00:00.440042390 29253 0x9c8fe40 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type caps
0:00:00.440065137 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3570:gst_pad_peer_query:<vaapidecode0:src> peer query 0xa0f46f0
(context)
0:00:00.440071288 29253 0x9c8fe40 INFO GST_PADS
gstpad.c:3626:gst_pad_peer_query:<vaapidecode0:src> pad has no peer
0:00:00.440075933 29253 0x9c8fe40 INFO GST_CONTEXT
../../../gst/vaapi/gstvaapivideocontext.c:83:context_pad_query:<vaapidecode0:src>
context pad peer query failed
0:00:00.440082050 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3570:gst_pad_peer_query:<vaapidecode0:sink> peer query 0xa0f46f0
(context)
0:00:00.440087726 29253 0x9c8fe40 INFO GST_PADS
gstpad.c:3626:gst_pad_peer_query:<vaapidecode0:sink> pad has no peer
0:00:00.440092053 29253 0x9c8fe40 INFO GST_CONTEXT
../../../gst/vaapi/gstvaapivideocontext.c:83:context_pad_query:<vaapidecode0:sink>
context pad peer query failed
0:00:00.440096457 29253 0x9c8fe40 INFO GST_CONTEXT
../../../gst/vaapi/gstvaapivideocontext.c:152:gst_vaapi_video_context_prepare:<vaapidecode0>
posting `need-context' message
0:00:00.440104049 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa0de948] posting on bus
need-context message: 0xa0de948, time 99:99:99.999999999, seq-num 0,
element 'vaapidecode0', GstMessageNeedContext,
context-type=(string)gst.vaapi.Display;
0:00:00.440120348 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa0de948]
handling child vaapidecode0 message of type need-context
0:00:00.440133480 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xa0de948] posting on bus
need-context message: 0xa0de948, time 99:99:99.999999999, seq-num 0,
element 'vaapidecode0', GstMessageNeedContext,
context-type=(string)gst.vaapi.Display;
0:00:00.469197035 29253 0x9c8fe40 INFO GST_CONTEXT
../../../gst/vaapi/gstvaapivideocontext.c:181:gst_vaapi_video_context_propagate:<vaapidecode0>
posting `have-context' (0xa0f4720) message with display (0x9cc1880)
0:00:00.469211748 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa0de8a8] posting on bus
have-context message: 0xa0de8a8, time 99:99:99.999999999, seq-num 1,
element 'vaapidecode0', GstMessageHaveContext, context=(GstContext)NULL;
0:00:00.469247195 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa0de8a8]
handling child vaapidecode0 message of type have-context
0:00:00.469268926 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xa0de8a8] posting on bus
have-context message: 0xa0de8a8, time 99:99:99.999999999, seq-num 1,
element 'vaapidecode0', GstMessageHaveContext, context=(GstContext)NULL;
0:00:00.469458849 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:sink> sent query 0xa0f46c0
(caps), result 1
0:00:00.469471823 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<vaapidecode0:sink> query returned
video/mpeg, mpegversion=(int)2; video/x-h264; video/x-wmv, wmvversion=(int)3
0:00:00.469492793 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1065:gst_element_get_compatible_pad: found existing unlinked
compatible pad vaapidecode0:sink
0:00:00.469507534 29253 0x9c8fe40 INFO GST_PADS
gstutils.c:1443:prepare_link_maybe_ghosting: rtph264depay0 and vaapidecode0
in same bin, no need for ghost pads
0:00:00.469607121 29253 0x9c8fe40 INFO GST_PADS
gstpad.c:2083:gst_pad_link_prepare: trying to link rtph264depay0:src and
vaapidecode0:sink
0:00:00.469738321 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<vaapidecode0:sink> get pad caps with
filter (NULL)
0:00:00.469755578 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:sink> doing query 0xa0f4600 (caps)
0:00:00.469766262 29253 0x9c8fe40 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type caps
0:00:00.469775250 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:sink> sent query 0xa0f4600
(caps), result 1
0:00:00.469785413 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<vaapidecode0:sink> query returned
video/mpeg, mpegversion=(int)2; video/x-h264; video/x-wmv, wmvversion=(int)3
0:00:00.469815079 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:1985:gst_pad_link_check_compatible_unlocked:<vaapidecode0:sink>
sink caps video/mpeg, mpegversion=(int)2; video/x-h264; video/x-wmv,
wmvversion=(int)3
0:00:00.469840158 29253 0x9c8fe40 INFO GST_PADS
gstpad.c:2285:gst_pad_link_full: linked rtph264depay0:src and
vaapidecode0:sink, successful
0:00:00.469936072 29253 0x9c8fe40 DEBUG bin
gstbin.c:960:bin_remove_messages:<vaapidecode0:sink> deleting message
0xa0de808 of types 0x00001000
0:00:00.469970197 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1649:gst_element_link_pads_full: linked pad rtph264depay0:src to
pad vaapidecode0:sink
0:00:00.470026161 29253 0x9c8fe40 INFO GST_ELEMENT_PADS
gstutils.c:1543:gst_element_link_pads_full: trying to link element
vaapidecode0:(any) to element cluttergstvideosink0:(any)
0:00:00.470048209 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1635:gst_element_link_pads_full: trying src pad vaapidecode0:sink
0:00:00.470057610 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1635:gst_element_link_pads_full: trying src pad vaapidecode0:src
0:00:00.470066704 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1006:gst_element_get_compatible_pad: finding pad in
cluttergstvideosink0 compatible with vaapidecode0:src
0:00:00.470091672 29253 0x9c8fe40 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link vaapidecode0:src and
cluttergstvideosink0:sink
0:00:00.470102674 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<vaapidecode0:src> get pad caps with
filter (NULL)
0:00:00.470119878 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:src> doing query 0xa0f3b50 (caps)
0:00:00.470130088 29253 0x9c8fe40 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type caps
0:00:00.470143203 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2852:gst_pad_query_caps_default:<vaapidecode0:src> query caps caps
query: 0xa0f3b50, GstQueryCaps, filter=(GstCaps)NULL, caps=(GstCaps)NULL;
0:00:00.470169528 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2869:gst_pad_query_caps_default:<vaapidecode0:src> fixed pad caps:
trying pad caps
0:00:00.470177748 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2875:gst_pad_query_caps_default:<vaapidecode0:src> trying pad
template caps
0:00:00.470185225 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2905:gst_pad_query_caps_default:<vaapidecode0:src> using caps
0xa0d9a50 video/x-raw(memory:VASurface), format=(string){ ENCODED, NV12,
I420, YV12 }, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw(meta:GstVideoGLTextureUploadMeta), format=(string)RGBA,
width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470215676 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:2983:gst_pad_query_default:<vaapidecode0:src> not forwarding
0xa0f3b50 (caps) query
0:00:00.470236866 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:src> sent query 0xa0f3b50 (caps),
result 1
0:00:00.470246819 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<vaapidecode0:src> query returned
video/x-raw(memory:VASurface), format=(string){ ENCODED, NV12, I420, YV12
}, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw(meta:GstVideoGLTextureUploadMeta), format=(string)RGBA,
width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470271206 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<cluttergstvideosink0:sink> get pad caps
with filter (NULL)
0:00:00.470287578 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<cluttergstvideosink0:sink> doing query
0xa0f3b80 (caps)
0:00:00.470307063 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<cluttergstvideosink0:sink> sent query
0xa0f3b80 (caps), result 1
0:00:00.470317480 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<cluttergstvideosink0:sink> query
returned video/x-raw, format=(string)AYUV, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)I420, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)YV12, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)I420, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)YV12, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string){ RGBA, BGRA }, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string){ RGB, BGR }, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470402615 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1102:gst_element_get_compatible_pad:<cluttergstvideosink0> Could
not find a compatible unlinked always pad to link to vaapidecode0:src, now
checking request pads
0:00:00.470412957 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<vaapidecode0:src> get pad caps with
filter (NULL)
0:00:00.470440167 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:src> doing query 0xa0f3b80 (caps)
0:00:00.470459792 29253 0x9c8fe40 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type caps
0:00:00.470467450 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2852:gst_pad_query_caps_default:<vaapidecode0:src> query caps caps
query: 0xa0f3b80, GstQueryCaps, filter=(GstCaps)NULL, caps=(GstCaps)NULL;
0:00:00.470481450 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2869:gst_pad_query_caps_default:<vaapidecode0:src> fixed pad caps:
trying pad caps
0:00:00.470488945 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2875:gst_pad_query_caps_default:<vaapidecode0:src> trying pad
template caps
0:00:00.470495998 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2905:gst_pad_query_caps_default:<vaapidecode0:src> using caps
0xa0d9a50 video/x-raw(memory:VASurface), format=(string){ ENCODED, NV12,
I420, YV12 }, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw(meta:GstVideoGLTextureUploadMeta), format=(string)RGBA,
width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470522232 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:2983:gst_pad_query_default:<vaapidecode0:src> not forwarding
0xa0f3b80 (caps) query
0:00:00.470532677 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:src> sent query 0xa0f3b80 (caps),
result 1
0:00:00.470542978 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<vaapidecode0:src> query returned
video/x-raw(memory:VASurface), format=(string){ ENCODED, NV12, I420, YV12
}, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw(meta:GstVideoGLTextureUploadMeta), format=(string)RGBA,
width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470593342 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:798:gst_element_get_compatible_pad_template: Looking for a
suitable pad template in cluttergstvideosink0 out of 1 templates...
0:00:00.470677174 29253 0x9c8fe40 INFO GST_ELEMENT_PADS
gstutils.c:1123:gst_element_get_compatible_pad:<cluttergstvideosink0> Could
not find a compatible pad to link to vaapidecode0:src
0:00:00.470686640 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1687:gst_element_link_pads_full: trying dest pad
cluttergstvideosink0:sink
0:00:00.470695638 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1006:gst_element_get_compatible_pad: finding pad in vaapidecode0
compatible with cluttergstvideosink0:sink
0:00:00.470707713 29253 0x9c8fe40 INFO GST_PADS
gstutils.c:936:gst_pad_check_link: trying to link vaapidecode0:src and
cluttergstvideosink0:sink
0:00:00.470719626 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<cluttergstvideosink0:sink> get pad caps
with filter (NULL)
0:00:00.470737971 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<cluttergstvideosink0:sink> doing query
0xa0f3b50 (caps)
0:00:00.470749833 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<cluttergstvideosink0:sink> sent query
0xa0f3b50 (caps), result 1
0:00:00.470760568 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<cluttergstvideosink0:sink> query
returned video/x-raw, format=(string)AYUV, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)I420, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)YV12, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)I420, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)YV12, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string){ RGBA, BGRA }, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string){ RGB, BGR }, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470814678 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<vaapidecode0:src> get pad caps with
filter (NULL)
0:00:00.470831867 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:src> doing query 0xa0f4660 (caps)
0:00:00.470842180 29253 0x9c8fe40 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type caps
0:00:00.470849661 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2852:gst_pad_query_caps_default:<vaapidecode0:src> query caps caps
query: 0xa0f4660, GstQueryCaps, filter=(GstCaps)NULL, caps=(GstCaps)NULL;
0:00:00.470863946 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2869:gst_pad_query_caps_default:<vaapidecode0:src> fixed pad caps:
trying pad caps
0:00:00.470871765 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2875:gst_pad_query_caps_default:<vaapidecode0:src> trying pad
template caps
0:00:00.470879523 29253 0x9c8fe40 DEBUG GST_CAPS
gstpad.c:2905:gst_pad_query_caps_default:<vaapidecode0:src> using caps
0xa0d9a50 video/x-raw(memory:VASurface), format=(string){ ENCODED, NV12,
I420, YV12 }, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw(meta:GstVideoGLTextureUploadMeta), format=(string)RGBA,
width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470905902 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:2983:gst_pad_query_default:<vaapidecode0:src> not forwarding
0xa0f4660 (caps) query
0:00:00.470916852 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:src> sent query 0xa0f4660 (caps),
result 1
0:00:00.470927393 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<vaapidecode0:src> query returned
video/x-raw(memory:VASurface), format=(string){ ENCODED, NV12, I420, YV12
}, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw(meta:GstVideoGLTextureUploadMeta), format=(string)RGBA,
width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ],
framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.470968419 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1102:gst_element_get_compatible_pad:<vaapidecode0> Could not
find a compatible unlinked always pad to link to cluttergstvideosink0:sink,
now checking request pads
0:00:00.470978551 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<cluttergstvideosink0:sink> get pad caps
with filter (NULL)
0:00:00.470996680 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<cluttergstvideosink0:sink> doing query
0xa0f3af0 (caps)
0:00:00.471008270 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<cluttergstvideosink0:sink> sent query
0xa0f3af0 (caps), result 1
0:00:00.471018600 29253 0x9c8fe40 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<cluttergstvideosink0:sink> query
returned video/x-raw, format=(string)AYUV, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)I420, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)YV12, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)I420, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string)YV12, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string){ RGBA, BGRA }, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ];
video/x-raw, format=(string){ RGB, BGR }, width=(int)[ 1, 2147483647 ],
height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.471088322 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:798:gst_element_get_compatible_pad_template: Looking for a
suitable pad template in vaapidecode0 out of 2 templates...
0:00:00.471201629 29253 0x9c8fe40 INFO GST_ELEMENT_PADS
gstutils.c:1123:gst_element_get_compatible_pad:<vaapidecode0> Could not
find a compatible pad to link to cluttergstvideosink0:sink
0:00:00.471218649 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstutils.c:1779:gst_element_link_pads_full: no link possible from
vaapidecode0 to cluttergstvideosink0
0:00:00.472588329 29253 0x9c8fe40 DEBUG bin
gstbin.c:1893:add_to_queue:<pipeline0> adding 'cluttergstvideosink0' to
queue
0:00:00.472615711 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:00.472639607 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 0->1, linked to vaapidecode0
0:00:00.472688669 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
cluttergstvideosink0
0:00:00.472712793 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:00.472721289 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<cluttergstvideosink0> current NULL
pending VOID_PENDING, desired next READY
0:00:00.472746650 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
cluttergstvideosink0 to READY, base_time 0:00:00.000000000
0:00:00.472758312 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<cluttergstvideosink0>
set_state to READY
0:00:00.472767344 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<cluttergstvideosink0> setting
target state to READY
0:00:00.472775359 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<cluttergstvideosink0> current
NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:00.472785532 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<cluttergstvideosink0> final:
setting state from NULL to READY
0:00:00.472798564 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:589:clutter_gst_source_new:<cluttergstvideosink0>
Creating new GSource
0:00:00.472812394 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:1589:clutter_gst_video_sink_start:<cluttergstvideosink0>
Attaching our GSource to the main context
0:00:00.472821637 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<cluttergstvideosink0> element
changed state SUCCESS
0:00:00.472829092 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<cluttergstvideosink0>
completed state change to READY
0:00:00.472837335 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<cluttergstvideosink0>
notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.472852217 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa0de680] posting on bus
state-changed message: 0xa0de680, time 99:99:99.999999999, seq-num 5,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.472892264 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa0de680]
handling child cluttergstvideosink0 message of type state-changed
0:00:00.472910893 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xa0de680] posting on bus
state-changed message: 0xa0de680, time 99:99:99.999999999, seq-num 5,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.472957434 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<cluttergstvideosink0>
returned SUCCESS
0:00:00.472966056 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child
'cluttergstvideosink0' changed state to 2(READY) successfully
0:00:00.472978212 29253 0x9c8fe40 DEBUG bin
gstbin.c:2079:gst_bin_sort_iterator_next:<pipeline0> queue empty, next
best: vaapidecode0
0:00:00.472987202 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
vaapidecode0
0:00:00.473012234 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 1->0, linked to vaapidecode0
0:00:00.473031634 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<vaapidecode0> current NULL pending
VOID_PENDING, desired next READY
0:00:00.473057006 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
vaapidecode0 to READY, base_time 0:00:00.000000000
0:00:00.473068398 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<vaapidecode0> set_state to
READY
0:00:00.473076311 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<vaapidecode0> setting target
state to READY
0:00:00.473083849 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<vaapidecode0> current NULL,
old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:00.473094049 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<vaapidecode0> final: setting
state from NULL to READY
0:00:00.473121816 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3570:gst_pad_peer_query:<vaapidecode0:src> peer query 0xa0d4e90
(context)
0:00:00.473132249 29253 0x9c8fe40 INFO GST_PADS
gstpad.c:3626:gst_pad_peer_query:<vaapidecode0:src> pad has no peer
0:00:00.473140798 29253 0x9c8fe40 INFO GST_CONTEXT
../../../gst/vaapi/gstvaapivideocontext.c:83:context_pad_query:<vaapidecode0:src>
context pad peer query failed
0:00:00.473150758 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3570:gst_pad_peer_query:<vaapidecode0:sink> peer query 0xa0d4e90
(context)
0:00:00.473231487 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:3632:gst_pad_peer_query:<vaapidecode0:sink> query failed
0:00:00.473238990 29253 0x9c8fe40 INFO GST_CONTEXT
../../../gst/vaapi/gstvaapivideocontext.c:83:context_pad_query:<vaapidecode0:sink>
context pad peer query failed
0:00:00.473246432 29253 0x9c8fe40 INFO GST_CONTEXT
../../../gst/vaapi/gstvaapivideocontext.c:152:gst_vaapi_video_context_prepare:<vaapidecode0>
posting `need-context' message
0:00:00.473255814 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa0de808] posting on bus
need-context message: 0xa0de808, time 99:99:99.999999999, seq-num 6,
element 'vaapidecode0', GstMessageNeedContext,
context-type=(string)gst.vaapi.Display;
0:00:00.473272593 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa0de808]
handling child vaapidecode0 message of type need-context
0:00:00.473282950 29253 0x9c8fe40 DEBUG GST_CONTEXT
gstelement.c:3045:gst_element_set_context:<vaapidecode0> set context
0xa0f4720 context, display=(GstVaapiDisplay)NULL;
0:00:00.473298976 29253 0x9c8fe40 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:592:gst_vaapidecode_set_context:<vaapidecode0>
set display 0x9cc1880
0:00:00.473319571 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<vaapidecode0> element changed
state SUCCESS
0:00:00.473327026 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<vaapidecode0> completed state
change to READY
0:00:00.473335029 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<vaapidecode0> notifying
about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.473347340 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa0de858] posting on bus
state-changed message: 0xa0de858, time 99:99:99.999999999, seq-num 7,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.473367073 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa0de858]
handling child vaapidecode0 message of type state-changed
0:00:00.473383447 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xa0de858] posting on bus
state-changed message: 0xa0de858, time 99:99:99.999999999, seq-num 7,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.473426185 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<vaapidecode0> returned SUCCESS
0:00:00.473435233 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'vaapidecode0'
changed state to 2(READY) successfully
0:00:00.474176034 29253 0x9c8fe40 DEBUG bin
gstbin.c:1893:add_to_queue:<pipeline0> adding 'cluttergstvideosink0' to
queue
0:00:00.474200248 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:00.474222970 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 0->1, linked to vaapidecode0
0:00:00.474266942 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
cluttergstvideosink0
0:00:00.474289600 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:00.474297799 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<cluttergstvideosink0> current
READY pending VOID_PENDING, desired next PAUSED
0:00:00.474322339 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
cluttergstvideosink0 to PAUSED, base_time 0:00:00.000000000
0:00:00.474333772 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<cluttergstvideosink0>
set_state to PAUSED
0:00:00.474341577 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<cluttergstvideosink0> setting
target state to PAUSED
0:00:00.474349586 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<cluttergstvideosink0> current
READY, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:00.474360879 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<cluttergstvideosink0> final:
setting state from READY to PAUSED
0:00:00.474373522 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4845:gst_base_sink_change_state:<cluttergstvideosink0> READY
to PAUSED
0:00:00.474384677 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4866:gst_base_sink_change_state:<cluttergstvideosink0> doing
async state change
0:00:00.474395508 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa0de6d0] posting on bus async-start
message: 0xa0de6d0, time 99:99:99.999999999, seq-num 11, element
'cluttergstvideosink0', (NULL)
0:00:00.474409847 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa0de6d0]
handling child cluttergstvideosink0 message of type async-start
0:00:00.474419660 29253 0x9c8fe40 DEBUG bin
gstbin.c:3584:gst_bin_handle_message_func:<pipeline0> ASYNC_START message
0xa0de6d0, cluttergstvideosink0
0:00:00.474443467 29253 0x9c8fe40 DEBUG bin
gstbin.c:932:bin_replace_message:<pipeline0> got new message 0xa0de6d0,
async-start from cluttergstvideosink0
0:00:00.474468953 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2740:gst_element_pads_activate:<cluttergstvideosink0> activate
pads
0:00:00.474484529 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:953:gst_pad_set_active:<cluttergstvideosink0:sink> activating pad
from none
0:00:00.474495205 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4021:gst_base_sink_pad_activate:<cluttergstvideosink0> Trying
pull mode first
0:00:00.474503304 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4027:gst_base_sink_pad_activate:<cluttergstvideosink0> pull
mode disabled
0:00:00.474510679 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4077:gst_base_sink_pad_activate:<cluttergstvideosink0>
Falling back to push mode
0:00:00.474520148 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:870:pre_activate:<cluttergstvideosink0:sink> setting pad into push
mode, unset flushing
0:00:00.474530120 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:1091:gst_pad_activate_mode:<cluttergstvideosink0:sink> activated
in push mode
0:00:00.474540170 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4079:gst_base_sink_pad_activate:<cluttergstvideosink0>
Success activating push mode
0:00:00.474547585 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2759:gst_element_pads_activate:<cluttergstvideosink0> pad
activation successful
0:00:00.474556670 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2618:gst_element_change_state:<cluttergstvideosink0> element
will change state ASYNC
0:00:00.474563805 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<cluttergstvideosink0>
returned ASYNC
0:00:00.474571699 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2662:gst_bin_change_state_func:<pipeline0> child
'cluttergstvideosink0' is changing state asynchronously to PAUSED
0:00:00.474582328 29253 0x9c8fe40 DEBUG bin
gstbin.c:2079:gst_bin_sort_iterator_next:<pipeline0> queue empty, next
best: vaapidecode0
0:00:00.474590533 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
vaapidecode0
0:00:00.474615370 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 1->0, linked to vaapidecode0
0:00:00.474634217 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<vaapidecode0> current READY
pending VOID_PENDING, desired next PAUSED
0:00:00.474658811 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
vaapidecode0 to PAUSED, base_time 0:00:00.000000000
0:00:00.474669975 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<vaapidecode0> set_state to
PAUSED
0:00:00.474677733 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<vaapidecode0> setting target
state to PAUSED
0:00:00.474685771 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<vaapidecode0> current READY,
old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:00.474696463 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<vaapidecode0> final: setting
state from READY to PAUSED
0:00:00.474706571 29253 0x9c8fe40 DEBUG videodecoder
gstvideodecoder.c:1649:gst_video_decoder_reset:<vaapidecode0> reset full 1
0:00:00.474717094 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2740:gst_element_pads_activate:<vaapidecode0> activate pads
0:00:00.474727634 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:953:gst_pad_set_active:<vaapidecode0:src> activating pad from none
0:00:00.474735867 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:870:pre_activate:<vaapidecode0:src> setting pad into push mode,
unset flushing
0:00:00.474744965 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:1091:gst_pad_activate_mode:<vaapidecode0:src> activated in push
mode
0:00:00.474756682 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:953:gst_pad_set_active:<vaapidecode0:sink> activating pad from none
0:00:00.474764970 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:870:pre_activate:<vaapidecode0:sink> setting pad into push mode,
unset flushing
0:00:00.474773777 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:881:pre_activate:<vaapidecode0:sink> reschedule events on peer
rtph264depay0:src
0:00:00.474783376 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:1091:gst_pad_activate_mode:<vaapidecode0:sink> activated in push
mode
0:00:00.474793424 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2759:gst_element_pads_activate:<vaapidecode0> pad activation
successful
0:00:00.474802071 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<vaapidecode0> element changed
state SUCCESS
0:00:00.474809273 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<vaapidecode0> completed state
change to PAUSED
0:00:00.474817046 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<vaapidecode0> notifying
about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.474829324 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa106020] posting on bus
state-changed message: 0xa106020, time 99:99:99.999999999, seq-num 12,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_PAUSED,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.474848863 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa106020]
handling child vaapidecode0 message of type state-changed
0:00:00.474864810 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xa106020] posting on bus
state-changed message: 0xa106020, time 99:99:99.999999999, seq-num 12,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_PAUSED,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.474908691 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<vaapidecode0> returned SUCCESS
0:00:00.474916654 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'vaapidecode0'
changed state to 3(PAUSED) successfully
0:00:00.525886939 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:408:gst_element_set_clock:<cluttergstvideosink0> setting clock
0xa1070c0
0:00:00.525910640 29253 0x9c8fe40 DEBUG GST_CLOCK
gstelement.c:408:gst_element_set_clock:<vaapidecode0> setting clock
0xa1070c0
0:00:00.526051156 29253 0x9c8fe40 DEBUG GST_STATES
gstbin.c:1711:bin_element_is_sink:<pipeline0> child cluttergstvideosink0 is
sink
0:00:00.526060965 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:1661:gst_element_query: send query on element
cluttergstvideosink0
0:00:00.526073723 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:1099:gst_base_sink_query_latency:<cluttergstvideosink0> we
are not yet ready for LATENCY query
0:00:00.526078620 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:1109:gst_base_sink_query_latency:<cluttergstvideosink0>
latency query failed and we are live
0:00:00.526088462 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4746:default_element_query:<cluttergstvideosink0> query
latency returns 0
0:00:00.526094597 29253 0x9c8fe40 DEBUG bin
gstbin.c:3881:bin_query_latency_fold:<cluttergstvideosink0> failed query
0:00:00.526100044 29253 0x9c8fe40 DEBUG GST_STATES
gstbin.c:1711:bin_element_is_sink:<pipeline0> child vaapidecode0 is not sink
0:00:00.526174599 29253 0x9c8fe40 DEBUG GST_STATES
gstbin.c:1711:bin_element_is_sink:<pipeline0> child cluttergstvideosink0 is
sink
0:00:00.526181482 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:1560:gst_element_send_event: send latency event on element
cluttergstvideosink0
0:00:00.526191072 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4284:gst_base_sink_send_event:<cluttergstvideosink0> handling
event 0xa104900 latency event: 0xa104900, time 99:99:99.999999999, seq-num
19, GstEventLatency, latency=(guint64)0;
0:00:00.526208500 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4301:gst_base_sink_send_event:<cluttergstvideosink0> latency
set to 0:00:00.000000000
0:00:00.526216485 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:4331:gst_base_sink_send_event:<cluttergstvideosink0> handled
event 0xa104900 latency event: 0xa104900, time 99:99:99.999999999, seq-num
19, GstEventLatency, latency=(guint64)0;: 1
0:00:00.526226932 29253 0x9c8fe40 DEBUG GST_STATES
gstbin.c:1711:bin_element_is_sink:<pipeline0> child vaapidecode0 is not sink
0:00:00.526278787 29253 0x9c8fe40 DEBUG bin
gstbin.c:1893:add_to_queue:<pipeline0> adding 'cluttergstvideosink0' to
queue
0:00:00.526296211 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:00.526311217 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 0->1, linked to vaapidecode0
0:00:00.526338968 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
cluttergstvideosink0
0:00:00.526354251 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:00.526360572 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<cluttergstvideosink0> current
READY pending PAUSED, desired next PLAYING
0:00:00.526367025 29253 0x9c8fe40 DEBUG bin
gstbin.c:883:find_message:<pipeline0> we found a message 0xa0de6d0 from
cluttergstvideosink0 matching types 00100000
0:00:00.526372983 29253 0x9c8fe40 DEBUG bin
gstbin.c:2307:gst_bin_element_set_state:<cluttergstvideosink0> element
message 0xa0de6d0, cluttergstvideosink0 async busy
0:00:00.526378091 29253 0x9c8fe40 DEBUG bin
gstbin.c:2350:gst_bin_element_set_state:<cluttergstvideosink0> element was
busy, delaying state change
0:00:00.526382552 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2662:gst_bin_change_state_func:<pipeline0> child
'cluttergstvideosink0' is changing state asynchronously to PLAYING
0:00:00.526389024 29253 0x9c8fe40 DEBUG bin
gstbin.c:2079:gst_bin_sort_iterator_next:<pipeline0> queue empty, next
best: vaapidecode0
0:00:00.526394284 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
vaapidecode0
0:00:00.526408409 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 1->0, linked to vaapidecode0
0:00:00.526420107 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<vaapidecode0> current PAUSED
pending VOID_PENDING, desired next PLAYING
0:00:00.526435453 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
vaapidecode0 to PLAYING, base_time 154:37:05.095232820
0:00:00.526443415 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<vaapidecode0> set_state to
PLAYING
0:00:00.526448710 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<vaapidecode0> setting target
state to PLAYING
0:00:00.526453596 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<vaapidecode0> current PAUSED,
old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:00.526460210 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<vaapidecode0> final: setting
state from PAUSED to PLAYING
0:00:00.526468274 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<vaapidecode0> element changed
state SUCCESS
0:00:00.526472813 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<vaapidecode0> completed state
change to PLAYING
0:00:00.526478968 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<vaapidecode0> notifying
about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.526492892 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa106340] posting on bus
state-changed message: 0xa106340, time 99:99:99.999999999, seq-num 20,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PAUSED,
new-state=(GstState)GST_STATE_PLAYING,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.526508837 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xa106340]
handling child vaapidecode0 message of type state-changed
0:00:00.526519519 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xa106340] posting on bus
state-changed message: 0xa106340, time 99:99:99.999999999, seq-num 20,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PAUSED,
new-state=(GstState)GST_STATE_PLAYING,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.526546476 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<vaapidecode0> returned SUCCESS
0:00:00.526551678 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'vaapidecode0'
changed state to 4(PLAYING) successfully
0:00:00.526990538 29253 0x9c8fe40 DEBUG bin
gstbin.c:883:find_message:<pipeline0> we found a message 0xa0de6d0 from
cluttergstvideosink0 matching types 00100000
0:00:00.527629233 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.527646257 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xa0de948,
need-context from vaapidecode0, type mask is 4294967295
0:00:00.527657126 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with need-context message: 0xa0de948, time 99:99:99.999999999,
seq-num 0, element 'vaapidecode0', GstMessageNeedContext,
context-type=(string)gst.vaapi.Display;
0:00:00.527682561 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.527690203 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xa0de8a8,
have-context from vaapidecode0, type mask is 4294967295
0:00:00.527697622 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with have-context message: 0xa0de8a8, time 99:99:99.999999999,
seq-num 1, element 'vaapidecode0', GstMessageHaveContext,
context=(GstContext)NULL;
0:00:00.527719811 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.527726575 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xa0de680,
state-changed from cluttergstvideosink0, type mask is 4294967295
0:00:00.527733297 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with state-changed message: 0xa0de680, time 99:99:99.999999999,
seq-num 5, element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.555592468 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xa0de858,
state-changed from vaapidecode0, type mask is 4294967295
0:00:00.555629761 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with state-changed message: 0xa0de858, time 99:99:99.999999999,
seq-num 7, element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.555869502 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.555948793 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556012976 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556025296 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xa106020,
state-changed from vaapidecode0, type mask is 4294967295
0:00:00.556039246 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with state-changed message: 0xa106020, time 99:99:99.999999999,
seq-num 12, element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_PAUSED,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.556077575 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556141471 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556217233 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556279416 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556351356 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556414145 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556484353 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556495628 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xa106340,
state-changed from vaapidecode0, type mask is 4294967295
0:00:00.556507082 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with state-changed message: 0xa106340, time 99:99:99.999999999,
seq-num 20, element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PAUSED,
new-state=(GstState)GST_STATE_PLAYING,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:00.556547703 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556610838 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556680678 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556752764 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:00.556763806 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:00.566344949 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.478097393 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.478110724 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.478129656 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.478139318 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.478150013 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.483076764 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.483096455 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.483107615 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.483116949 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.483127399 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.509799511 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.509811506 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.509823416 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.509833257 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.509844527 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.619388051 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.619419764 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.619450107 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.619483415 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.619512258 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.620614412 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.620645764 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.620711401 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.620774656 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.620818503 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.625560779 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.625599003 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.625662544 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.625715987 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.625747047 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.626847044 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.626876956 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.626907665 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.626958269 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.627014622 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.627921453 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.627963013 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.628000900 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.628028139 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.628081507 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.628967400 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.629043747 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.629069358 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.629076236 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.629084102 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649384988 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649399660 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.649422505 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649434704 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.649453752 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649696287 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649707927 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.649721539 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649733176 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.649751767 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649933589 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649943483 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.649960622 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.649974552 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.649991392 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.650076245 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.650087583 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.650100647 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.650110690 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.650127624 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.650244350 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.650260526 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.650279441 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.650295659 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.650313297 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.653889018 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.653916214 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.653930101 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.653951947 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.653965775 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654146080 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654166170 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.654179857 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654206134 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.654220419 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654303193 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654331571 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.654347310 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654360889 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.654373354 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654662060 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654674858 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.654690228 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654703402 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.654716396 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.654794441 29253 0xb3a0f090 DEBUG GST_STATES
gstbin.c:1711:bin_element_is_sink:<pipeline0> child cluttergstvideosink0 is
sink
0:00:01.654825135 29253 0xb3a0f090 DEBUG bin
gstbin.c:1054:is_stream_start: sink 'cluttergstvideosink0' did not post
STREAM_START yet
0:00:01.659531580 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.659552342 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.659564641 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.659577615 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.659589741 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.660295293 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.660328408 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.660347056 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.664837785 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.664939702 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.665791254 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.665804543 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.665819701 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.665832413 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.665844310 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.666056383 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.666068453 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.666082360 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.666095026 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.666119254 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.669277390 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.669288443 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.669303115 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.669322065 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.669342164 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.669417037 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.669427991 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.669439241 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.669449132 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.669460248 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.776053588 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.776078733 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.776102824 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.776123222 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.776145281 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.805582807 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.805601907 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.805610500 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.805627130 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.805635287 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.805866508 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.805874603 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.805882393 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.805891721 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.805905180 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.806131302 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.806140813 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.806153224 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.806169146 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.806177202 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.806413834 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.806428523 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.806442617 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.806457903 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.806534116 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807039703 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807054516 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.807068374 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807087788 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.807103200 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807365918 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807438194 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807446984 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.807460154 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807627450 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807634183 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.807649385 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.807657612 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.807665110 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.823331311 29253 0xb1c02200 DEBUG bin
gstbin.c:966:bin_remove_messages:<cluttergstvideosink0> not deleting
message 0xa0de6d0 of type 0x00100000
0:00:01.823510480 29253 0xb1c02200 DEBUG GST_EVENT
gstpad.c:4935:gst_pad_send_event_unchecked:<vaapidecode0:sink> have event
type stream-start event: 0xb2602ac0, time 99:99:99.999999999, seq-num 41,
GstEventStreamStart,
stream-id=(string)81ca1228efd091bb49d49dc551d2b0570e074682c2b6934ba6a1684ea521ef20,
flags=(GstStreamFlags)GST_STREAM_FLAG_NONE, group-id=(uint)0;
0:00:01.823532508 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:1181:gst_video_decoder_sink_event:<vaapidecode0> received
event 10254, stream-start
0:00:01.823559242 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:985:gst_video_decoder_sink_event_default:<vaapidecode0>
received STREAM_START. Clearing taglist
0:00:01.823569399 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3376:check_sticky:<vaapidecode0:src> pushing all sticky events
0:00:01.823577583 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.823585959 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.823594312 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5001:gst_pad_send_event_unchecked:<vaapidecode0:sink> sent event,
ret ok
0:00:01.826988625 29253 0xb1c02200 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<vaapidecode0:sink> get pad caps with
filter video/x-h264, stream-format=(string)avc, alignment=(string)au;
video/x-h264, stream-format=(string)byte-stream, alignment=(string){ nal,
au }
0:00:01.827010448 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:sink> doing query 0xb080b0c0
(caps)
0:00:01.827022300 29253 0xb1c02200 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type caps
0:00:01.827031242 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:sink> sent query 0xb080b0c0
(caps), result 1
0:00:01.827041076 29253 0xb1c02200 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<vaapidecode0:sink> query returned
video/mpeg, mpegversion=(int)2; video/x-h264; video/x-wmv, wmvversion=(int)3
0:00:01.827197262 29253 0xb1c02200 DEBUG GST_EVENT
gstpad.c:4935:gst_pad_send_event_unchecked:<vaapidecode0:sink> have event
type caps event: 0xb0806538, time 99:99:99.999999999, seq-num 140,
GstEventCaps, caps=(GstCaps)video/x-h264,
stream-format=(string)byte-stream, alignment=(string)nal;
0:00:01.827214250 29253 0xb1c02200 DEBUG GST_CAPS
gstutils.c:2845:gst_pad_query_accept_caps:<vaapidecode0:sink> accept caps
of video/x-h264, stream-format=(string)byte-stream, alignment=(string)nal
0:00:01.827234629 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:sink> doing query 0xb080b0f0
(accept-caps)
0:00:01.827244208 29253 0xb1c02200 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type accept-caps
0:00:01.827251714 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:2813:gst_pad_query_accept_caps_default:<vaapidecode0:sink> query
accept-caps accept-caps query: 0xb080b0f0, GstQueryAcceptCaps,
caps=(GstCaps)video/x-h264, stream-format=(string)byte-stream,
alignment=(string)nal, result=(boolean)false;
0:00:01.827267344 29253 0xb1c02200 DEBUG GST_PERFORMANCE
gstpad.c:2824:gst_pad_query_accept_caps_default:<vaapidecode0:sink>
fallback ACCEPT_CAPS query, consider implementing a specialized version
0:00:01.827275290 29253 0xb1c02200 DEBUG GST_CAPS
gstutils.c:2762:gst_pad_query_caps:<vaapidecode0:sink> get pad caps with
filter video/x-h264, stream-format=(string)byte-stream,
alignment=(string)nal
0:00:01.827293982 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3445:gst_pad_query:<vaapidecode0:sink> doing query 0xb080b320
(caps)
0:00:01.827303124 29253 0xb1c02200 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:942:gst_vaapidecode_query:<vaapidecode0>
query type caps
0:00:01.827311069 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:sink> sent query 0xb080b320
(caps), result 1
0:00:01.827320833 29253 0xb1c02200 DEBUG GST_CAPS
gstutils.c:2769:gst_pad_query_caps:<vaapidecode0:sink> query returned
video/mpeg, mpegversion=(int)2; video/x-h264; video/x-wmv, wmvversion=(int)3
0:00:01.827333703 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:2830:gst_pad_query_accept_caps_default:<vaapidecode0:sink> allowed
caps video/mpeg, mpegversion=(int)2; video/x-h264; video/x-wmv,
wmvversion=(int)3
0:00:01.827347322 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:2983:gst_pad_query_default:<vaapidecode0:sink> not forwarding
0xb080b0f0 (accept-caps) query
0:00:01.827357408 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:3467:gst_pad_query:<vaapidecode0:sink> sent query 0xb080b0f0
(accept-caps), result 1
0:00:01.827366851 29253 0xb1c02200 DEBUG default
gstutils.c:2850:gst_pad_query_accept_caps:<vaapidecode0:sink> query
returned 1
0:00:01.827374763 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:1181:gst_video_decoder_sink_event:<vaapidecode0> received
event 12814, caps
0:00:01.827387085 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5001:gst_pad_send_event_unchecked:<vaapidecode0:sink> sent event,
ret ok
0:00:01.827395873 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:4528:store_sticky_event:<vaapidecode0:sink> notify caps
0:00:01.833273205 29253 0xb1c02200 DEBUG GST_EVENT
gstpad.c:4935:gst_pad_send_event_unchecked:<vaapidecode0:sink> have event
type segment event: 0xb0806570, time 99:99:99.999999999, seq-num 141,
GstEventSegment, segment=(GstSegment)"GstSegment,
flags=(GstSegmentFlags)GST_SEGMENT_FLAG_NONE, rate=(double)1,
applied-rate=(double)1, format=(GstFormat)GST_FORMAT_TIME, base=(guint64)0,
offset=(guint64)0, start=(guint64)0, stop=(guint64)18446744073709551615,
time=(guint64)217815000, position=(guint64)0,
duration=(guint64)18446744073709551615;";
0:00:01.833341203 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:1181:gst_video_decoder_sink_event:<vaapidecode0> received
event 17934, segment
0:00:01.833356982 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:1072:gst_video_decoder_sink_event_default:<vaapidecode0>
received TIME SEGMENT time segment start=0:00:00.000000000,
stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00,
time=0:00:00.217815000, base=0:00:00.000000000, position 0:00:00.000000000,
duration 99:99:99.999999999
0:00:01.833376821 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5001:gst_pad_send_event_unchecked:<vaapidecode0:sink> sent event,
ret ok
0:00:01.833416106 29253 0xb1c02200 DEBUG GST_CAPS
gstpad.c:2428:gst_pad_get_current_caps:<vaapidecode0:sink> get current pad
caps video/x-h264, stream-format=(string)byte-stream, alignment=(string)nal
0:00:01.833431100 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:760:gst_video_decoder_setcaps:<vaapidecode0> setcaps
video/x-h264, stream-format=(string)byte-stream, alignment=(string)nal
0:00:01.833502524 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:2825:gst_video_decoder_set_output_state:<vaapidecode0>
fmt:1, width:0, height:0, reference:0xb080d028
0:00:01.833563971 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5460:gst_pad_stop_task:<vaapidecode0:src> stop task
0:00:01.833572470 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5482:gst_pad_stop_task:<vaapidecode0:src> no task
0:00:01.833671072 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5356:gst_pad_start_task:<vaapidecode0:src> start task
0:00:01.833716153 29253 0xb1c02200 INFO GST_PADS
gstpad.c:5365:gst_pad_start_task:<vaapidecode0:src> created task 0xb1c05040
0:00:01.833725175 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5282:do_stream_status:<vaapidecode0:src> doing stream-status 0
0:00:01.833742945 29253 0xb1c02200 DEBUG GST_PADS
gstpad.c:5311:do_stream_status:<vaapidecode0:src> posting stream-status 0
0:00:01.833753850 29253 0xb1c02200 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb0803f78] posting on bus
stream-status message: 0xb0803f78, time 99:99:99.999999999, seq-num 142,
element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_CREATE,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ task6";
0:00:01.833806596 29253 0xb1c02200 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb0803f78] posting on bus
stream-status message: 0xb0803f78, time 99:99:99.999999999, seq-num 142,
element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_CREATE,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ task6";
0:00:01.833892193 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with stream-status message: 0xb0803f78, time 99:99:99.999999999,
seq-num 142, element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_CREATE,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ task6";
0:00:01.833954779 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.833973750 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.833994253 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:5282:do_stream_status:<vaapidecode0:src> doing stream-status 1
0:00:01.834007639 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.834020829 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.834025413 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:5311:do_stream_status:<vaapidecode0:src> posting stream-status 1
0:00:01.834035058 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.834045964 29253 0xb080b030 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb3a25e50] posting on bus
stream-status message: 0xb3a25e50, time 99:99:99.999999999, seq-num 143,
element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_ENTER,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ vaapidecode0:src";
0:00:01.834089341 29253 0xb080b030 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb3a25e50] posting on bus
stream-status message: 0xb3a25e50, time 99:99:99.999999999, seq-num 143,
element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_ENTER,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ vaapidecode0:src";
0:00:01.834151030 29253 0xb080b030 DEBUG task
gsttask.c:243:gst_task_configure_name:<vaapidecode0:src> Setting thread
name to 'vaapidecode0:src'
0:00:01.834155334 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:767:gst_bus_source_dispatch:<bus1> source 0xa1025c0 calling
dispatch with stream-status message: 0xb3a25e50, time 99:99:99.999999999,
seq-num 143, element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_ENTER,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ vaapidecode0:src";
0:00:01.834205580 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.834213514 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.834221077 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.834228103 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:01.834235146 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:01.834328556 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1019:parse_sps: parse
SPS
0:00:01.834409116 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1041:parse_pps: parse
PPS
0:00:01.834765058 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1084:parse_slice:
parse slice
0:00:01.877823339 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1084:parse_slice:
parse slice
0:00:01.877846381 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2481:is_new_picture:
frame_num differs in value
0:00:01.877950395 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:855:ensure_context:
profile changed
0:00:01.877956733 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:876:ensure_context:
size changed
0:00:01.877962667 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder.c:901:gst_vaapi_decoder_set_pixel_aspect_ratio:
pixel-aspect-ratio changed to 12/11
0:00:01.877979748 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:2825:gst_video_decoder_set_output_state:<vaapidecode0>
fmt:1, width:0, height:0, reference:0xb080d1c8
0:00:01.878027106 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder.c:847:gst_vaapi_decoder_set_picture_size:
picture width changed to 704
0:00:01.878035253 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder.c:855:gst_vaapi_decoder_set_picture_size:
picture height changed to 576
0:00:01.878044259 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:2825:gst_video_decoder_set_output_state:<vaapidecode0>
fmt:1, width:704, height:576, reference:0xb080d1c8
0:00:01.878210467 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:687:dpb_reset: DPB
size 1
0:00:01.878226224 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2008:init_picture:
<IDR>
0:00:01.878232826 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1128:init_picture_poc_0:
decode picture order count type 0
0:00:01.878238973 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1401:init_picture_refs_pic_num:
decode picture numbers
0:00:01.878245404 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1879:exec_picture_refs_modification:
execute ref_pic_list_modification()
0:00:01.878252211 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2739:decode_slice:
slice (18102 bytes)
0:00:01.878286746 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_objects.c:268:gst_vaapi_picture_decode:
decode picture 0x04000000
0:00:01.912072466 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1084:parse_slice:
parse slice
0:00:01.912152400 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2481:is_new_picture:
frame_num differs in value
0:00:01.912214797 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1128:init_picture_poc_0:
decode picture order count type 0
0:00:01.912241609 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1401:init_picture_refs_pic_num:
decode picture numbers
0:00:01.912264939 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1505:init_picture_refs_p_slice:
decode reference picture list for P and SP slices
0:00:01.912290076 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1879:exec_picture_refs_modification:
execute ref_pic_list_modification()
0:00:01.912315262 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2739:decode_slice:
slice (1511 bytes)
0:00:01.912417814 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2073:exec_ref_pic_marking_sliding_window:
reference picture marking process (sliding window)
0:00:01.912458140 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder.c:377:push_frame: queue
decoded surface 0x4000000
0:00:01.912509672 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_objects.c:268:gst_vaapi_picture_decode:
decode picture 0x04000001
0:00:01.912551213 29253 0xb080b030 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder.c:397:pop_frame: dequeue
decoded surface 0x4000000
0:00:01.916035341 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3025:gst_video_decoder_negotiate_default:<vaapidecode0>
output_state par 12/11 fps 0/1
0:00:01.916085135 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3030:gst_video_decoder_negotiate_default:<vaapidecode0>
setting caps video/x-raw, format=(string)NV12, width=(int)704,
height=(int)576, pixel-aspect-ratio=(fraction)12/11,
interlace-mode=(string)progressive, colorimetry=(string)bt601,
framerate=(fraction)0/1
0:00:01.916179415 29253 0xb080b030 DEBUG GST_CAPS
gstpad.c:2428:gst_pad_get_current_caps:<vaapidecode0:src> get current pad
caps (NULL)
0:00:01.916360902 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4528:store_sticky_event:<vaapidecode0:src> notify caps
0:00:01.916409396 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3376:check_sticky:<vaapidecode0:src> pushing all sticky events
0:00:01.916439778 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.916468941 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.916496426 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.916526812 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.916556144 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.916582861 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.916669558 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3570:gst_pad_peer_query:<vaapidecode0:src> peer query 0xb1205000
(allocation)
0:00:01.916703805 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3376:check_sticky:<vaapidecode0:src> pushing all sticky events
0:00:01.916732278 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.916760336 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.916788974 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.916819115 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.916847899 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.916905198 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.916934376 29253 0xb080b030 INFO GST_PADS
gstpad.c:3626:gst_pad_peer_query:<vaapidecode0:src> pad has no peer
0:00:01.916961387 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3075:gst_video_decoder_negotiate_default:<vaapidecode0>
didn't get downstream ALLOCATION hints
0:00:01.917081231 29253 0xb080b030 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:538:gst_vaapidecode_decide_allocation:
no pool or doesn't support GstVaapiVideoMeta, making new pool
0:00:01.917597700 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3082:gst_video_decoder_negotiate_default:<vaapidecode0>
ALLOCATION (1) params: allocation query: 0xb1205000, GstQueryAllocation,
caps=(GstCaps)video/x-raw, format=(string)NV12, width=(int)704,
height=(int)576, pixel-aspect-ratio=(fraction)12/11,
interlace-mode=(string)progressive, colorimetry=(string)bt601,
framerate=(fraction)0/1, need-pool=(boolean)true, pool=(GArray)NULL,
meta=(GArray)NULL;
0:00:01.917729567 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:1432:gst_pad_check_reconfigure:<vaapidecode0:src> remove
RECONFIGURE flag
0:00:01.917740111 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3025:gst_video_decoder_negotiate_default:<vaapidecode0>
output_state par 12/11 fps 0/1
0:00:01.917749697 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3030:gst_video_decoder_negotiate_default:<vaapidecode0>
setting caps video/x-raw, format=(string)NV12, width=(int)704,
height=(int)576, pixel-aspect-ratio=(fraction)12/11,
interlace-mode=(string)progressive, colorimetry=(string)bt601,
framerate=(fraction)0/1
0:00:01.917770611 29253 0xb080b030 DEBUG GST_CAPS
gstpad.c:2428:gst_pad_get_current_caps:<vaapidecode0:src> get current pad
caps video/x-raw, format=(string)NV12, width=(int)704, height=(int)576,
pixel-aspect-ratio=(fraction)12/11, interlace-mode=(string)progressive,
colorimetry=(string)bt601, framerate=(fraction)0/1
0:00:01.917803914 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3570:gst_pad_peer_query:<vaapidecode0:src> peer query 0xb1205090
(allocation)
0:00:01.917814875 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3376:check_sticky:<vaapidecode0:src> pushing all sticky events
0:00:01.917824113 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.917832347 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.917840544 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.917848897 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.917857344 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.917865451 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.917873486 29253 0xb080b030 INFO GST_PADS
gstpad.c:3626:gst_pad_peer_query:<vaapidecode0:src> pad has no peer
0:00:01.917882278 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3075:gst_video_decoder_negotiate_default:<vaapidecode0>
didn't get downstream ALLOCATION hints
0:00:01.917915434 29253 0xb080b030 INFO vaapidecode
../../../gst/vaapi/gstvaapidecode.c:538:gst_vaapidecode_decide_allocation:
no pool or doesn't support GstVaapiVideoMeta, making new pool
0:00:01.918188971 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:3082:gst_video_decoder_negotiate_default:<vaapidecode0>
ALLOCATION (1) params: allocation query: 0xb1205090, GstQueryAllocation,
caps=(GstCaps)video/x-raw, format=(string)NV12, width=(int)704,
height=(int)576, pixel-aspect-ratio=(fraction)12/11,
interlace-mode=(string)progressive, colorimetry=(string)bt601,
framerate=(fraction)0/1, need-pool=(boolean)true, pool=(GArray)NULL,
meta=(GArray)NULL;
0:00:01.918262690 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:889:gst_video_decoder_push_event:<vaapidecode0> segment
time segment start=0:00:00.000000000, stop=99:99:99.999999999,
rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.217815000,
base=0:00:00.000000000, position 0:00:00.000000000, duration
99:99:99.999999999
0:00:01.918305766 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3376:check_sticky:<vaapidecode0:src> pushing all sticky events
0:00:01.918320521 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918329417 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918341303 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918350585 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918359416 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918368268 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918379222 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918390183 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918400323 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918411751 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918422069 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918432290 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918441625 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918454319 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918475786 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:2202:gst_video_decoder_prepare_finish_frame:<vaapidecode0>
sync timestamp 0:00:01.320469208 diff 0:00:01.320469208
0:00:01.918555116 29253 0xb080b030 DEBUG videodecoder
gstvideodecoder.c:2578:gst_video_decoder_clip_and_push_buf:<vaapidecode0>
pushing buffer 0xb1c11d30 of size 608256, PTS 0:00:01.320469208, dur
99:99:99.999999999
0:00:01.918586373 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3376:check_sticky:<vaapidecode0:src> pushing all sticky events
0:00:01.918600589 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918613461 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918624315 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918633621 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918643758 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918653861 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918664602 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918673990 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918682939 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918691948 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918701344 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918709467 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918717740 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918726587 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918734819 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3376:check_sticky:<vaapidecode0:src> pushing all sticky events
0:00:01.918743441 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918752420 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918761108 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918769486 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918778394 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918787225 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918796005 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918804510 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918813110 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918821219 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918829955 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918838810 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918847326 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:4724:gst_pad_push_event_unchecked:<vaapidecode0:src> Dropping
event because pad is not linked
0:00:01.918855402 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:3348:push_sticky:<vaapidecode0:src> pad was not linked, mark
pending
0:00:01.918863629 29253 0xb080b030 ERROR vaapidecode
../../../gst/vaapi/gstvaapidecode.c:388:gst_vaapidecode_push_decoded_frame:
video sink rejected the video buffer (error -1)
0:00:01.918961368 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:5412:gst_pad_pause_task:<vaapidecode0:src> pause task
0:00:01.918972374 29253 0xb080b030 DEBUG task
gsttask.c:662:gst_task_set_state:<vaapidecode0:src> Changing task
0xb1c05040 to state 2
0:00:01.918983141 29253 0xb080b030 INFO task
gsttask.c:300:gst_task_func:<vaapidecode0:src> Task going to paused
0:00:01.951026759 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1084:parse_slice:
parse slice
0:00:01.951043652 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2481:is_new_picture:
frame_num differs in value
0:00:01.951064275 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1128:init_picture_poc_0:
decode picture order count type 0
0:00:01.951069382 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1401:init_picture_refs_pic_num:
decode picture numbers
0:00:01.951073273 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1505:init_picture_refs_p_slice:
decode reference picture list for P and SP slices
0:00:01.951079959 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:1879:exec_picture_refs_modification:
execute ref_pic_list_modification()
0:00:01.951084000 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2739:decode_slice:
slice (1194 bytes)
0:00:01.951113046 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_h264.c:2073:exec_ref_pic_marking_sliding_window:
reference picture marking process (sliding window)
0:00:01.951121356 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder.c:377:push_frame: queue
decoded surface 0x4000001
0:00:01.951128429 29253 0xb1c02200 DEBUG vaapi
../../../../gst-libs/gst/vaapi/gstvaapidecoder_objects.c:268:gst_vaapi_picture_decode:
decode picture 0x04000002
0:00:01.951547021 29253 0xb1c02200 DEBUG videodecoder
gstvideodecoder.c:2762:gst_video_decoder_decode_frame:<vaapidecode0> flow
error not-linked
0:00:03.490626140 29253 0xb3a0f0c0 DEBUG GST_STATES
gstbin.c:1711:bin_element_is_sink:<pipeline0> child cluttergstvideosink0 is
sink
0:00:03.490720677 29253 0xb3a0f0c0 DEBUG bin
gstbin.c:1054:is_stream_start: sink 'cluttergstvideosink0' did not post
STREAM_START yet
0:00:04.586595864 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:04.586688589 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:04.586792290 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:04.586842477 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:04.586897285 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:04.599699508 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:06.404729750 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:06.404759355 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:06.404932006 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:06.404989220 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:06.405003084 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:11.563846898 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:11.563934898 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:11.564035689 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:11.591650658 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.337608354 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.337708418 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.353100946 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.354188372 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.354867241 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.355479523 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.361325854 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.361413207 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.361473713 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.361520520 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.361571816 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.369092985 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.371261547 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.371729864 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.377785036 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.377882075 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.377949293 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.378004110 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.378060598 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.385125410 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.387364440 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.387764535 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.393253141 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.393296112 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.393313854 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.393327163 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.393343028 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.400782680 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.403937972 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.404301236 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.408931988 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.408993146 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.409034039 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.409066058 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.409098156 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.416888227 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.420021280 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.427163216 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.427184153 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.427198843 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.427211052 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.427223567 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.433123960 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.436333683 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.436822807 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.441175923 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.441261224 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.441331130 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.441384548 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.441437450 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.450333170 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.452513816 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.452924416 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.457065425 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.457130355 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.457170957 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.457201661 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.457233449 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.468449653 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.469046371 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.473154097 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.473237627 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.473304684 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.473356773 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.473411932 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.484574517 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.490448072 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.490509616 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.490549395 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.490581213 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.490612920 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.500773772 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.502060574 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.569595605 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.569671416 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.570230677 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.729334277 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.729417451 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.729897240 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.729949364 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.729997179 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.827008141 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:261:clutter_gst_source_prepare:<cluttergstvideosink0>
Preparing GSource
0:00:12.827077862 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:274:clutter_gst_source_check:<cluttergstvideosink0>
Asking to be dispatched : 0
0:00:12.828617056 29253 0x9c8fe40 DEBUG bin
gstbin.c:966:bin_remove_messages:<cluttergstvideosink0> not deleting
message 0xa0de6d0 of type 0x00100000
0:00:12.828694161 29253 0x9c8fe40 DEBUG bin
gstbin.c:1893:add_to_queue:<pipeline0> adding 'cluttergstvideosink0' to
queue
0:00:12.828804633 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.828958998 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 0->1, linked to vaapidecode0
0:00:12.829155269 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
cluttergstvideosink0
0:00:12.829250191 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.829284602 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<cluttergstvideosink0> current
READY pending PAUSED, desired next PAUSED
0:00:12.829327381 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2344:gst_bin_element_set_state:<cluttergstvideosink0> skipping
transition from READY to PAUSED
0:00:12.829363593 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child
'cluttergstvideosink0' changed state to 3(PAUSED) successfully
0:00:12.829408880 29253 0x9c8fe40 DEBUG bin
gstbin.c:2079:gst_bin_sort_iterator_next:<pipeline0> queue empty, next
best: vaapidecode0
0:00:12.829442448 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
vaapidecode0
0:00:12.829534175 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 1->0, linked to vaapidecode0
0:00:12.829612484 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<vaapidecode0> current PLAYING
pending VOID_PENDING, desired next PAUSED
0:00:12.829714515 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
vaapidecode0 to PAUSED, base_time 154:37:05.095232820
0:00:12.829761045 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<vaapidecode0> set_state to
PAUSED
0:00:12.829793771 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<vaapidecode0> setting target
state to PAUSED
0:00:12.829825940 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<vaapidecode0> current
PLAYING, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:12.829868102 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<vaapidecode0> final: setting
state from PLAYING to PAUSED
0:00:12.829909195 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<vaapidecode0> element changed
state SUCCESS
0:00:12.829939142 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<vaapidecode0> completed state
change to PAUSED
0:00:12.829971923 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<vaapidecode0> notifying
about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:12.830029560 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb0803c08] posting on bus
state-changed message: 0xb0803c08, time 99:99:99.999999999, seq-num 156,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PLAYING,
new-state=(GstState)GST_STATE_PAUSED,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.830129308 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xb0803c08]
handling child vaapidecode0 message of type state-changed
0:00:12.830200674 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb0803c08] posting on bus
state-changed message: 0xb0803c08, time 99:99:99.999999999, seq-num 156,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PLAYING,
new-state=(GstState)GST_STATE_PAUSED,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.830403581 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<vaapidecode0> returned SUCCESS
0:00:12.830443961 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'vaapidecode0'
changed state to 3(PAUSED) successfully
0:00:12.836617051 29253 0x9c8fe40 DEBUG bin
gstbin.c:960:bin_remove_messages:<cluttergstvideosink0> deleting message
0xa0de6d0 of types 0xffffffff
0:00:12.836756547 29253 0x9c8fe40 DEBUG bin
gstbin.c:1893:add_to_queue:<pipeline0> adding 'cluttergstvideosink0' to
queue
0:00:12.836892116 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.836997673 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 0->1, linked to vaapidecode0
0:00:12.837094903 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
cluttergstvideosink0
0:00:12.837116402 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.837124055 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<cluttergstvideosink0> current
READY pending PAUSED, desired next READY
0:00:12.837148324 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
cluttergstvideosink0 to READY, base_time 154:37:05.095232820
0:00:12.837159066 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<cluttergstvideosink0>
set_state to READY
0:00:12.837166671 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<cluttergstvideosink0> setting
target state to READY
0:00:12.837174015 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<cluttergstvideosink0> current
READY, old_pending PAUSED, next PAUSED, old return ASYNC
0:00:12.837184132 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<cluttergstvideosink0> final:
setting state from PAUSED to READY
0:00:12.837193687 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2740:gst_element_pads_activate:<cluttergstvideosink0>
deactivate pads
0:00:12.837205257 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:966:gst_pad_set_active:<cluttergstvideosink0:sink> deactivating
pad from push mode
0:00:12.837215216 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:859:pre_activate:<cluttergstvideosink0:sink> setting PAD_MODE
NONE, set flushing
0:00:12.837232161 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:3973:gst_base_sink_set_flushing:<cluttergstvideosink0>
flushing out data thread, need preroll to TRUE
0:00:12.837240116 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:905:post_activate:<cluttergstvideosink0:sink> stopped streaming
0:00:12.837248801 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:1091:gst_pad_activate_mode:<cluttergstvideosink0:sink> deactivated
in push mode
0:00:12.837259966 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2759:gst_element_pads_activate:<cluttergstvideosink0> pad
deactivation successful
0:00:12.837276520 29253 0x9c8fe40 DEBUG basesink
gstbasesink.c:5008:gst_base_sink_change_state:<cluttergstvideosink0> PAUSED
to READY, posting async-done
0:00:12.837288242 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb1201548] posting on bus
state-changed message: 0xb1201548, time 99:99:99.999999999, seq-num 162,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PLAYING,
new-state=(GstState)GST_STATE_PAUSED,
pending-state=(GstState)GST_STATE_READY;
0:00:12.837309607 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xb1201548]
handling child cluttergstvideosink0 message of type state-changed
0:00:12.837326583 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb1201548] posting on bus
state-changed message: 0xb1201548, time 99:99:99.999999999, seq-num 162,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PLAYING,
new-state=(GstState)GST_STATE_PAUSED,
pending-state=(GstState)GST_STATE_READY;
0:00:12.837390434 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb3a25cc0] posting on bus async-done
message: 0xb3a25cc0, time 99:99:99.999999999, seq-num 163, element
'cluttergstvideosink0', GstMessageAsyncDone,
running-time=(guint64)18446744073709551615;
0:00:12.837407833 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xb3a25cc0]
handling child cluttergstvideosink0 message of type async-done
0:00:12.837417102 29253 0x9c8fe40 DEBUG bin
gstbin.c:3615:gst_bin_handle_message_func:<pipeline0> ASYNC_DONE message
0xb3a25cc0, cluttergstvideosink0
0:00:12.837442070 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<cluttergstvideosink0> element
changed state SUCCESS
0:00:12.837450349 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<cluttergstvideosink0>
completed state change to READY
0:00:12.837465924 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<cluttergstvideosink0>
notifying about state-changed READY to READY (VOID_PENDING pending)
0:00:12.837479015 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb3a25d60] posting on bus
state-changed message: 0xb3a25d60, time 99:99:99.999999999, seq-num 164,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.837499480 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xb3a25d60]
handling child cluttergstvideosink0 message of type state-changed
0:00:12.837516159 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb3a25d60] posting on bus
state-changed message: 0xb3a25d60, time 99:99:99.999999999, seq-num 164,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.837560454 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<cluttergstvideosink0>
returned SUCCESS
0:00:12.837568736 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child
'cluttergstvideosink0' changed state to 2(READY) successfully
0:00:12.837580234 29253 0x9c8fe40 DEBUG bin
gstbin.c:2079:gst_bin_sort_iterator_next:<pipeline0> queue empty, next
best: vaapidecode0
0:00:12.837589654 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
vaapidecode0
0:00:12.837613974 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 1->0, linked to vaapidecode0
0:00:12.837632994 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<vaapidecode0> current PAUSED
pending VOID_PENDING, desired next READY
0:00:12.837658376 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
vaapidecode0 to READY, base_time 154:37:05.095232820
0:00:12.837669850 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<vaapidecode0> set_state to
READY
0:00:12.837678314 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<vaapidecode0> setting target
state to READY
0:00:12.837686277 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<vaapidecode0> current PAUSED,
old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:12.837696483 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<vaapidecode0> final: setting
state from PAUSED to READY
0:00:12.837706846 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2740:gst_element_pads_activate:<vaapidecode0> deactivate pads
0:00:12.837718701 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:966:gst_pad_set_active:<vaapidecode0:src> deactivating pad from
push mode
0:00:12.837728008 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:859:pre_activate:<vaapidecode0:src> setting PAD_MODE NONE, set
flushing
0:00:12.837736158 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:905:post_activate:<vaapidecode0:src> stopped streaming
0:00:12.837745180 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:381:remove_events:<vaapidecode0:src> notify caps
0:00:12.837759567 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:1091:gst_pad_activate_mode:<vaapidecode0:src> deactivated in push
mode
0:00:12.837771809 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:966:gst_pad_set_active:<vaapidecode0:sink> deactivating pad from
push mode
0:00:12.837780869 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:859:pre_activate:<vaapidecode0:sink> setting PAD_MODE NONE, set
flushing
0:00:12.837789121 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:905:post_activate:<vaapidecode0:sink> stopped streaming
0:00:12.837797005 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:381:remove_events:<vaapidecode0:sink> notify caps
0:00:12.837807362 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:1091:gst_pad_activate_mode:<vaapidecode0:sink> deactivated in push
mode
0:00:12.837819121 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2759:gst_element_pads_activate:<vaapidecode0> pad deactivation
successful
0:00:12.837829258 29253 0x9c8fe40 DEBUG videodecoder
gstvideodecoder.c:1649:gst_video_decoder_reset:<vaapidecode0> reset full 1
0:00:12.837860841 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<vaapidecode0> element changed
state SUCCESS
0:00:12.837868128 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<vaapidecode0> completed state
change to READY
0:00:12.837876188 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<vaapidecode0> notifying
about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:12.837889262 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb3a1a680] posting on bus
state-changed message: 0xb3a1a680, time 99:99:99.999999999, seq-num 165,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.837908884 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xb3a1a680]
handling child vaapidecode0 message of type state-changed
0:00:12.837926396 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb3a1a680] posting on bus
state-changed message: 0xb3a1a680, time 99:99:99.999999999, seq-num 165,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_READY,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.837971921 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<vaapidecode0> returned SUCCESS
0:00:12.837980500 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'vaapidecode0'
changed state to 2(READY) successfully
0:00:12.840049683 29253 0x9c8fe40 DEBUG bin
gstbin.c:1893:add_to_queue:<pipeline0> adding 'cluttergstvideosink0' to
queue
0:00:12.840084351 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.840110922 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 0->1, linked to vaapidecode0
0:00:12.840182011 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
cluttergstvideosink0
0:00:12.840227514 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.840241397 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<cluttergstvideosink0> current
READY pending VOID_PENDING, desired next NULL
0:00:12.840277421 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
cluttergstvideosink0 to NULL, base_time 154:37:05.095232820
0:00:12.840297288 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<cluttergstvideosink0>
set_state to NULL
0:00:12.840306048 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<cluttergstvideosink0> setting
target state to NULL
0:00:12.840318719 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<cluttergstvideosink0> current
READY, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:12.840331263 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<cluttergstvideosink0> final:
setting state from READY to NULL
0:00:12.840341568 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2740:gst_element_pads_activate:<cluttergstvideosink0>
deactivate pads
0:00:12.840353286 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:962:gst_pad_set_active:<cluttergstvideosink0:sink> pad was inactive
0:00:12.840364231 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2759:gst_element_pads_activate:<cluttergstvideosink0> pad
deactivation successful
0:00:12.840375164 29253 0x9c8fe40 DEBUG cluttersink
./clutter-gst-video-sink.c:1606:clutter_gst_video_sink_stop:<cluttergstvideosink0>
Stopping our GSource
0:00:12.840399295 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<cluttergstvideosink0> element
changed state SUCCESS
0:00:12.840415043 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<cluttergstvideosink0>
completed state change to NULL
0:00:12.840427903 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<cluttergstvideosink0>
notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:12.840447061 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb3a1a770] posting on bus
state-changed message: 0xb3a1a770, time 99:99:99.999999999, seq-num 171,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_NULL,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.842736148 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xb3a1a770]
handling child cluttergstvideosink0 message of type state-changed
0:00:12.842773479 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb3a1a770] posting on bus
state-changed message: 0xb3a1a770, time 99:99:99.999999999, seq-num 171,
element 'cluttergstvideosink0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_NULL,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.842825418 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<cluttergstvideosink0>
returned SUCCESS
0:00:12.842836877 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child
'cluttergstvideosink0' changed state to 1(NULL) successfully
0:00:12.842849939 29253 0x9c8fe40 DEBUG bin
gstbin.c:2079:gst_bin_sort_iterator_next:<pipeline0> queue empty, next
best: vaapidecode0
0:00:12.842859219 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
vaapidecode0
0:00:12.842895614 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 1->0, linked to vaapidecode0
0:00:12.842916498 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<vaapidecode0> current READY
pending VOID_PENDING, desired next NULL
0:00:12.842954358 29253 0x9c8fe40 DEBUG bin
gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element
vaapidecode0 to NULL, base_time 154:37:05.095232820
0:00:12.842967792 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2479:gst_element_set_state_func:<vaapidecode0> set_state to
NULL
0:00:12.842984439 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2504:gst_element_set_state_func:<vaapidecode0> setting target
state to NULL
0:00:12.842994361 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2517:gst_element_set_state_func:<vaapidecode0> current READY,
old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
0:00:12.843006437 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2551:gst_element_set_state_func:<vaapidecode0> final: setting
state from READY to NULL
0:00:12.843018778 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2740:gst_element_pads_activate:<vaapidecode0> deactivate pads
0:00:12.843032075 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:962:gst_pad_set_active:<vaapidecode0:src> pad was inactive
0:00:12.843044517 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:962:gst_pad_set_active:<vaapidecode0:sink> pad was inactive
0:00:12.843055245 29253 0x9c8fe40 DEBUG GST_ELEMENT_PADS
gstelement.c:2759:gst_element_pads_activate:<vaapidecode0> pad deactivation
successful
0:00:12.843067500 29253 0x9c8fe40 DEBUG GST_PADS
gstpad.c:5460:gst_pad_stop_task:<vaapidecode0:src> stop task
0:00:12.843076362 29253 0x9c8fe40 DEBUG task
gsttask.c:662:gst_task_set_state:<vaapidecode0:src> Changing task
0xb1c05040 to state 1
0:00:12.843097062 29253 0xb080b030 INFO task
gsttask.c:302:gst_task_func:<vaapidecode0:src> Task resume from paused
0:00:12.843106827 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:5282:do_stream_status:<vaapidecode0:src> doing stream-status 2
0:00:12.843129308 29253 0xb080b030 DEBUG GST_PADS
gstpad.c:5311:do_stream_status:<vaapidecode0:src> posting stream-status 2
0:00:12.843140724 29253 0xb080b030 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xa1062a0] posting on bus
stream-status message: 0xa1062a0, time 99:99:99.999999999, seq-num 173,
element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_LEAVE,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ vaapidecode0:src";
0:00:12.843193411 29253 0xb080b030 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xa1062a0] posting on bus
stream-status message: 0xa1062a0, time 99:99:99.999999999, seq-num 173,
element 'src', GstMessageStreamStatus,
type=(GstStreamStatusType)GST_STREAM_STATUS_TYPE_LEAVE,
owner=(GstElement)"\(GstVaapiDecode\)\ vaapidecode0",
object=(GstTask)"\(GstTask\)\ vaapidecode0:src";
0:00:12.843244830 29253 0x9c8fe40 DEBUG task
gsttask.c:789:gst_task_join:<vaapidecode0:src> Joining task 0xb1c05040,
thread 0x9c8fe40
0:00:12.843290934 29253 0x9c8fe40 DEBUG task
gsttask.c:819:gst_task_join:<vaapidecode0:src> Joined task 0xb1c05040
0:00:12.843500227 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2636:gst_element_change_state:<vaapidecode0> element changed
state SUCCESS
0:00:12.843516331 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2328:gst_element_continue_state:<vaapidecode0> completed state
change to NULL
0:00:12.843527987 29253 0x9c8fe40 INFO GST_STATES
gstelement.c:2233:_priv_gst_element_state_changed:<vaapidecode0> notifying
about state-changed READY to NULL (VOID_PENDING pending)
0:00:12.843542733 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus0> [msg 0xb3a25cc0] posting on bus
state-changed message: 0xb3a25cc0, time 99:99:99.999999999, seq-num 175,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_NULL,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.843563832 29253 0x9c8fe40 DEBUG bin
gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0xb3a25cc0]
handling child vaapidecode0 message of type state-changed
0:00:12.843589586 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:312:gst_bus_post:<bus1> [msg 0xb3a25cc0] posting on bus
state-changed message: 0xb3a25cc0, time 99:99:99.999999999, seq-num 175,
element 'vaapidecode0', GstMessageStateChanged,
old-state=(GstState)GST_STATE_READY, new-state=(GstState)GST_STATE_NULL,
pending-state=(GstState)GST_STATE_VOID_PENDING;
0:00:12.843644799 29253 0x9c8fe40 DEBUG GST_STATES
gstelement.c:2563:gst_element_set_state_func:<vaapidecode0> returned SUCCESS
0:00:12.843654476 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'vaapidecode0'
changed state to 1(NULL) successfully
0:00:12.936063257 29253 0x9c8fe40 DEBUG bin
gstbin.c:1893:add_to_queue:<pipeline0> adding 'cluttergstvideosink0' to
queue
0:00:12.936089045 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.936113463 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 0->1, linked to vaapidecode0
0:00:12.936158190 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
cluttergstvideosink0
0:00:12.936181325 29253 0x9c8fe40 DEBUG bin
gstbin.c:2033:update_degree:<pipeline0> element cluttergstvideosink0 not
linked on any sinkpads
0:00:12.936189503 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<cluttergstvideosink0> current NULL
pending VOID_PENDING, desired next NULL
0:00:12.936199978 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2344:gst_bin_element_set_state:<cluttergstvideosink0> skipping
transition from NULL to NULL
0:00:12.936208848 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child
'cluttergstvideosink0' changed state to 1(NULL) successfully
0:00:12.936219889 29253 0x9c8fe40 DEBUG bin
gstbin.c:2079:gst_bin_sort_iterator_next:<pipeline0> queue empty, next
best: vaapidecode0
0:00:12.936228561 29253 0x9c8fe40 DEBUG bin
gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives
vaapidecode0
0:00:12.936251365 29253 0x9c8fe40 DEBUG bin
gstbin.c:2010:update_degree:<pipeline0> change element rtph264depay0,
degree 1->0, linked to vaapidecode0
0:00:12.936269813 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2227:gst_bin_element_set_state:<vaapidecode0> current NULL pending
VOID_PENDING, desired next NULL
0:00:12.936279916 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2344:gst_bin_element_set_state:<vaapidecode0> skipping transition
from NULL to NULL
0:00:12.936288522 29253 0x9c8fe40 INFO GST_STATES
gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'vaapidecode0'
changed state to 1(NULL) successfully
0:00:12.937909299 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xb0803c08,
state-changed from vaapidecode0, type mask is 4294967295
0:00:12.937983682 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xb1201548,
state-changed from cluttergstvideosink0, type mask is 4294967295
0:00:12.937995772 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xb3a25d60,
state-changed from cluttergstvideosink0, type mask is 4294967295
0:00:12.938007482 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xb3a1a680,
state-changed from vaapidecode0, type mask is 4294967295
0:00:12.938077304 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xb3a1a770,
state-changed from cluttergstvideosink0, type mask is 4294967295
0:00:12.938136188 29253 0x9c8fe40 DEBUG GST_BUS
gstbus.c:506:gst_bus_timed_pop_filtered:<bus1> got message 0xb3a25cc0,
state-changed from vaapidecode0, type mask is 4294967295
Erwan JEZEQUEL
Service Informatique
079 946 02 91
2014-04-04 9:14 GMT+02:00 Sebastian Dröge <sebastian at centricular.com>:
> On Do, 2014-04-03 at 14:59 +0200, Jezequel, Erwan wrote:
> > so I check GStreamer debug logs and in all the output I get, I found
> things
> > like this:
> > gst_element_get_compatible_pad:<vaapidecode0> Could not find a compatible
> > pad to link to cluttergstvideosink0:sink
> > gst_element_link_pads_full: no link possible from vaapidecode0 to
> > vaapidecode0
> >
> > So it seems that the link between vaapidecode and vaapidecode doesn't
> work.
> >
> > Is there something to fix it or a workaround?
>
> Which versions of clutter-gst and gstreamer-vaapi are you using? I think
> the latest versions (and probably git master of clutter-gst) are
> supposed to work fine together.
>
> Your debug log is missing some important information, the vaapidecode
> bits of why the two pads can't be linked.
>
> --
> Sebastian Dröge, Centricular Ltd - http://www.centricular.com
> Expertise, Straight from the Source
>
> _______________________________________________
> gstreamer-devel mailing list
> gstreamer-devel at lists.freedesktop.org
> http://lists.freedesktop.org/mailman/listinfo/gstreamer-devel
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freedesktop.org/archives/gstreamer-devel/attachments/20140404/218e63da/attachment-0001.html>
More information about the gstreamer-devel
mailing list