# GST_DEBUG=*:4 /opt/xxx/bin/gst-launch-1.0 videotestsrc pattern=ball is-live=true ! "video/x-raw,width=1280,height=720,framerate=15/1" ! vaapih264enc aud=true ! mpegtsmux ! hlssink target-duration=1
0:00:00.000093452    37      0x16d4a00 INFO                GST_INIT gst.c:507:init_pre: Initializing GStreamer Core Library version 1.12.0
0:00:00.000194165    37      0x16d4a00 INFO                GST_INIT gst.c:508:init_pre: Using library installed in /opt/fuse/lib
0:00:00.000227264    37      0x16d4a00 INFO                GST_INIT gst.c:528:init_pre: Linux 5ec51baeed51 4.4.0-78-generic #99-Ubuntu SMP Thu Apr 27 15:29:09 UTC 2017 x86_64
0:00:00.000779071    37      0x16d4a00 INFO                GST_INIT gstmessage.c:127:_priv_gst_message_initialize: init messages
0:00:00.001746220    37      0x16d4a00 INFO                GST_INIT gstcontext.c:84:_priv_gst_context_initialize: init contexts
0:00:00.002109682    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:317:_priv_gst_plugin_initialize: registering 0 static plugins
0:00:00.002299373    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:225:gst_plugin_register_static: registered static plugin "staticelements"
0:00:00.002326039    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:227:gst_plugin_register_static: added static plugin "staticelements", result: 1
0:00:00.002370440    37      0x16d4a00 INFO            GST_REGISTRY gstregistry.c:1721:ensure_current_registry: reading registry cache: /root/.cache/gstreamer-1.0/registry.x86_64.bin
0:00:00.010065902    37      0x16d4a00 INFO            GST_REGISTRY gstregistrybinary.c:621:priv_gst_registry_binary_read_cache: loaded /root/.cache/gstreamer-1.0/registry.x86_64.bin in 0.007632 seconds
0:00:00.010089579    37      0x16d4a00 INFO            GST_REGISTRY gstregistry.c:1577:scan_and_update_registry: Validating plugins from registry cache: /root/.cache/gstreamer-1.0/registry.x86_64.bin
0:00:00.011267560    37      0x16d4a00 INFO            GST_REGISTRY gstregistry.c:1679:scan_and_update_registry: Registry cache has not changed
0:00:00.011273724    37      0x16d4a00 INFO            GST_REGISTRY gstregistry.c:1756:ensure_current_registry: registry reading and updating done, result = 1
0:00:00.011277256    37      0x16d4a00 INFO                GST_INIT gst.c:727:init_post: GLib runtime version: 2.48.2
0:00:00.011280869    37      0x16d4a00 INFO                GST_INIT gst.c:729:init_post: GLib headers version: 2.48.2
0:00:00.011283523    37      0x16d4a00 INFO                GST_INIT gst.c:730:init_post: initialized GStreamer successfully
0:00:00.011297711    37      0x16d4a00 INFO            GST_PIPELINE gstparse.c:326:gst_parse_launch_full: parsing pipeline description 'videotestsrc pattern=ball is-live=true ! video/x-raw,width=1280,height=720,framerate=15/1 ! vaapih264enc aud=true ! mpegtsmux ! hlssink target-duration=1 '
0:00:00.011635895    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "/opt/fuse/lib/gstreamer-1.0/libgstvideotestsrc.so" loaded
0:00:00.011644966    37      0x16d4a00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create: creating element "videotestsrc"
0:00:00.011755506    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSrc@0x18a99b0> adding pad 'src'
error: XDG_RUNTIME_DIR not set in the environment.
0:00:00.013757232    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: VA-API version 0.40.0
0:00:00.013767664    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_getDriverName() returns 0
0:00:00.013772049    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Trying to open /opt/fuse/lib/dri/i965_drv_video.so
0:00:00.013920840    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Found init function __vaDriverInit_0_40
0:00:00.014154552    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_openDriver() returns 0
0:00:00.014160017    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:77:vaapi_initialize: VA-API version 0.40
0:00:00.014327101    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: VA-API version 0.40.0
0:00:00.014335123    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_getDriverName() returns 0
0:00:00.014339440    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Trying to open /opt/fuse/lib/dri/i965_drv_video.so
0:00:00.014347273    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Found init function __vaDriverInit_0_40
0:00:00.014536544    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_openDriver() returns 0
0:00:00.014541286    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:77:vaapi_initialize: VA-API version 0.40
0:00:00.014546562    37      0x16d4a00 INFO            vaapidisplay gstvaapidisplay.c:948:gst_vaapi_display_create_unlocked:<vaapidisplaydrm0> new display addr=0x18be0b0
0:00:00.014696714    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "/opt/fuse/lib/gstreamer-1.0/libgstvaapi.so" loaded
0:00:00.014704731    37      0x16d4a00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create: creating element "vaapih264enc"
0:00:00.014802848    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstVideoEncoder@0x18c48f0> adding pad 'sink'
0:00:00.014812674    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstVideoEncoder@0x18c48f0> adding pad 'src'
0:00:00.014819115    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad (null):sink
0:00:00.014825987    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad (null):src
0:00:00.015017309    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "/opt/fuse/lib/gstreamer-1.0/libgstmpegtsmux.so" loaded
0:00:00.015024473    37      0x16d4a00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create: creating element "mpegtsmux"
0:00:00.015079779    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<MpegTsMux@0x18ca030> adding pad 'src'
0:00:00.015529345    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "/opt/fuse/lib/gstreamer-1.0/libgsthls.so" loaded
0:00:00.015537016    37      0x16d4a00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create: creating element "hlssink"
0:00:00.015592360    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstHlsSink@0x18d8050> adding pad 'sink'
0:00:00.015607519    37      0x16d4a00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create: creating element "pipeline"
0:00:00.015643735    37      0x16d4a00 INFO            GST_PIPELINE grammar.y:652:gst_parse_perform_link: linking some pad of GstVideoTestSrc named videotestsrc0 to some pad of GstVaapiEncodeH264 named vaapiencodeh264-0 (0/0) with caps "video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)15/1"
0:00:00.015896040    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "/opt/fuse/lib/gstreamer-1.0/libgstcoreelements.so" loaded
0:00:00.015902910    37      0x16d4a00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create: creating element "capsfilter"
0:00:00.015943150    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform@0x18e6320> adding pad 'sink'
0:00:00.015951649    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform@0x18e6320> adding pad 'src'
0:00:00.015958414    37      0x16d4a00 INFO              GST_STATES gstbin.c:2080:gst_bin_get_state_func:<pipeline0> getting state
0:00:00.015968192    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0> completed state change to NULL
0:00:00.015975914    37      0x16d4a00 INFO               GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.015981073    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element videotestsrc0:(any) to element capsfilter0:sink
0:00:00.015986148    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad capsfilter0:sink
0:00:00.015990289    37      0x16d4a00 INFO                GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: videotestsrc0 and capsfilter0 in same bin, no need for ghost pads
0:00:00.015998416    37      0x16d4a00 INFO                GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link videotestsrc0:src and capsfilter0:sink
0:00:00.016008290    37      0x16d4a00 INFO                GST_PADS gstpad.c:4115:gst_pad_peer_query:<capsfilter0:src> pad has no peer
0:00:00.016015894    37      0x16d4a00 INFO                GST_PADS gstpad.c:2524:gst_pad_link_full: linked videotestsrc0:src and capsfilter0:sink, successful
0:00:00.016020557    37      0x16d4a00 INFO               GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.016024740    37      0x16d4a00 INFO               GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<videotestsrc0:src> Received event on flushing pad. Discarding
0:00:00.016031587    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element capsfilter0:src to element vaapiencodeh264-0:(any)
0:00:00.016036747    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad capsfilter0:src
0:00:00.016042696    37      0x16d4a00 INFO                GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link capsfilter0:src and vaapiencodeh264-0:sink
0:00:00.016062801    37      0x16d4a00 INFO                GST_PADS gstpad.c:4115:gst_pad_peer_query:<vaapiencodeh264-0:src> pad has no peer
0:00:00.016093666    37      0x16d4a00 INFO                GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: capsfilter0 and vaapiencodeh264-0 in same bin, no need for ghost pads
0:00:00.016100483    37      0x16d4a00 INFO                GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link capsfilter0:src and vaapiencodeh264-0:sink
0:00:00.016116125    37      0x16d4a00 INFO                GST_PADS gstpad.c:4115:gst_pad_peer_query:<vaapiencodeh264-0:src> pad has no peer
0:00:00.016140315    37      0x16d4a00 INFO                GST_PADS gstpad.c:2524:gst_pad_link_full: linked capsfilter0:src and vaapiencodeh264-0:sink, successful
0:00:00.016145625    37      0x16d4a00 INFO               GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.016149312    37      0x16d4a00 INFO               GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<capsfilter0:src> Received event on flushing pad. Discarding
0:00:00.016155555    37      0x16d4a00 INFO            GST_PIPELINE grammar.y:652:gst_parse_perform_link: linking some pad of GstVaapiEncodeH264 named vaapiencodeh264-0 to some pad of MpegTsMux named mpegtsmux0 (0/0) with caps "(NULL)"
0:00:00.016163486    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element vaapiencodeh264-0:(any) to element mpegtsmux0:(any)
0:00:00.016181190    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<mpegtsmux0> adding pad 'sink_65'
0:00:00.016186666    37      0x16d4a00 INFO                GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: vaapiencodeh264-0 and mpegtsmux0 in same bin, no need for ghost pads
0:00:00.016192171    37      0x16d4a00 INFO                GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link vaapiencodeh264-0:src and mpegtsmux0:sink_65
0:00:00.016198786    37      0x16d4a00 INFO                GST_PADS gstpad.c:2524:gst_pad_link_full: linked vaapiencodeh264-0:src and mpegtsmux0:sink_65, successful
0:00:00.016202852    37      0x16d4a00 INFO               GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.016206339    37      0x16d4a00 INFO               GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<vaapiencodeh264-0:src> Received event on flushing pad. Discarding
0:00:00.016211502    37      0x16d4a00 INFO            GST_PIPELINE grammar.y:652:gst_parse_perform_link: linking some pad of MpegTsMux named mpegtsmux0 to some pad of GstHlsSink named hlssink0 (0/0) with caps "(NULL)"
0:00:00.016218398    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full: trying to link element mpegtsmux0:(any) to element hlssink0:(any)
0:00:00.016223464    37      0x16d4a00 INFO                GST_PADS gstutils.c:1009:gst_pad_check_link: trying to link mpegtsmux0:src and hlssink0:sink
0:00:00.016231750    37      0x16d4a00 INFO                GST_PADS gstpad.c:4115:gst_pad_peer_query:<sink:proxypad0> pad has no peer
0:00:00.016236162    37      0x16d4a00 INFO                GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting: mpegtsmux0 and hlssink0 in same bin, no need for ghost pads
0:00:00.016241058    37      0x16d4a00 INFO                GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link mpegtsmux0:src and hlssink0:sink
0:00:00.016246875    37      0x16d4a00 INFO                GST_PADS gstpad.c:4115:gst_pad_peer_query:<sink:proxypad0> pad has no peer
0:00:00.016250797    37      0x16d4a00 INFO                GST_PADS gstpad.c:2524:gst_pad_link_full: linked mpegtsmux0:src and hlssink0:sink, successful
0:00:00.016254764    37      0x16d4a00 INFO               GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.016258169    37      0x16d4a00 INFO               GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<mpegtsmux0:src> Received event on flushing pad. Discarding
Setting pipeline to PAUSED ...
0:00:00.016284911    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<hlssink0> current NULL pending VOID_PENDING, desired next READY
0:00:00.016725321    37      0x16d4a00 INFO      GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry: plugin "/opt/fuse/lib/gstreamer-1.0/libgstmultifile.so" loaded
0:00:00.016732429    37      0x16d4a00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create: creating element "multifilesink"
0:00:00.016788338    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSink@0x18ecae0> adding pad 'sink'
0:00:00.016803876    37      0x16d4a00 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad multifilesink0:sink
0:00:00.016809138    37      0x16d4a00 INFO                GST_PADS gstpad.c:2316:gst_pad_link_prepare: trying to link sink:proxypad0 and multifilesink0:sink
0:00:00.016815326    37      0x16d4a00 INFO                GST_PADS gstpad.c:2524:gst_pad_link_full: linked sink:proxypad0 and multifilesink0:sink, successful
0:00:00.016820381    37      0x16d4a00 INFO               GST_EVENT gstevent.c:1512:gst_event_new_reconfigure: creating reconfigure event
0:00:00.016830277    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<multifilesink0> current NULL pending VOID_PENDING, desired next READY
0:00:00.016836313    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<multifilesink0> completed state change to READY
0:00:00.016840250    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<multifilesink0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.016849618    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<hlssink0> child 'multifilesink0' changed state to 2(READY) successfully
0:00:00.016855643    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<hlssink0> completed state change to READY
0:00:00.016859369    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<hlssink0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.016864753    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'hlssink0' changed state to 2(READY) successfully
0:00:00.016871558    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<mpegtsmux0> current NULL pending VOID_PENDING, desired next READY
0:00:00.016877263    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<mpegtsmux0> completed state change to READY
0:00:00.016882324    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<mpegtsmux0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.016888121    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'mpegtsmux0' changed state to 2(READY) successfully
0:00:00.016893719    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<vaapiencodeh264-0> current NULL pending VOID_PENDING, desired next READY
0:00:00.016905035    37      0x16d4a00 INFO             GST_CONTEXT gstvaapivideocontext.c:101:context_pad_query:<vaapiencodeh264-0:src> context pad peer query failed
0:00:00.016909788    37      0x16d4a00 INFO             GST_CONTEXT gstvaapivideocontext.c:101:context_pad_query:<vaapiencodeh264-0:sink> context pad peer query failed
0:00:00.016913663    37      0x16d4a00 INFO             GST_CONTEXT gstvaapivideocontext.c:175:_gst_context_query:<vaapiencodeh264-0> posting `need-context' message
error: XDG_RUNTIME_DIR not set in the environment.
0:00:00.017090772    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: VA-API version 0.40.0
0:00:00.017099440    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_getDriverName() returns 0
0:00:00.017104029    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Trying to open /opt/fuse/lib/dri/i965_drv_video.so
0:00:00.017112740    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Found init function __vaDriverInit_0_40
0:00:00.017312327    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_openDriver() returns 0
0:00:00.017317231    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:77:vaapi_initialize: VA-API version 0.40
0:00:00.017407252    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: VA-API version 0.40.0
0:00:00.017414703    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_getDriverName() returns 0
0:00:00.017418678    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Trying to open /opt/fuse/lib/dri/i965_drv_video.so
0:00:00.017426896    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: Found init function __vaDriverInit_0_40
0:00:00.017614570    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:58:gst_vaapi_log: va_openDriver() returns 0
0:00:00.017619683    37      0x16d4a00 INFO                   vaapi gstvaapiutils.c:77:vaapi_initialize: VA-API version 0.40
0:00:00.017624467    37      0x16d4a00 INFO            vaapidisplay gstvaapidisplay.c:948:gst_vaapi_display_create_unlocked:<vaapidisplaydrm1> new display addr=0x18be410
0:00:00.017631602    37      0x16d4a00 INFO             vaapiencode gstvaapipluginbase.c:54:plugin_set_display:<vaapiencodeh264-0> set display <vaapidisplaydrm1>
0:00:00.017641459    37      0x16d4a00 INFO             GST_CONTEXT gstvaapivideocontext.c:228:gst_vaapi_video_context_propagate:<vaapiencodeh264-0> posting `have-context' (0x18d2460) message with display (0x18be410)
0:00:00.017650250    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<vaapiencodeh264-0> completed state change to READY
0:00:00.017654409    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<vaapiencodeh264-0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.017660434    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'vaapiencodeh264-0' changed state to 2(READY) successfully
0:00:00.017666715    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next READY
0:00:00.017671217    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0> completed state change to READY
0:00:00.017674689    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.017679635    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 2(READY) successfully
0:00:00.017684009    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<videotestsrc0> current NULL pending VOID_PENDING, desired next READY
0:00:00.017689220    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<videotestsrc0> completed state change to READY
0:00:00.017692789    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<videotestsrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.017697627    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 2(READY) successfully
0:00:00.017702628    37      0x16d4a00 INFO              GST_STATES gstelement.c:2442:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.017707198    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed NULL to READY (PAUSED pending)
0:00:00.017721482    37      0x16d4a00 INFO              GST_STATES gstelement.c:2449:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PAUSED
0:00:00.017730013    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<hlssink0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.017735840    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<multifilesink0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.017743169    37      0x16d4a00 INFO              GST_STATES gstbin.c:2945:gst_bin_change_state_func:<hlssink0> child 'multifilesink0' is changing state asynchronously to PAUSED
0:00:00.017749088    37      0x16d4a00 INFO              GST_STATES gstbin.c:2945:gst_bin_change_state_func:<pipeline0> child 'hlssink0' is changing state asynchronously to PAUSED
0:00:00.017753592    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<mpegtsmux0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.017760557    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<mpegtsmux0> completed state change to PAUSED
0:00:00.017766724    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<mpegtsmux0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.017773234    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'mpegtsmux0' changed state to 3(PAUSED) successfully
0:00:00.017777943    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<vaapiencodeh264-0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.017803031    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<vaapiencodeh264-0> completed state change to PAUSED
0:00:00.017808209    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<vaapiencodeh264-0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.017813816    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'vaapiencodeh264-0' changed state to 3(PAUSED) successfully
0:00:00.017819056    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.017824834    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
0:00:00.017828408    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.017833196    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:00.017837472    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<videotestsrc0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.017843565    37      0x16d4a00 INFO                 basesrc gstbasesrc.c:1331:gst_base_src_do_seek:<videotestsrc0> seeking: time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.017857615    37      0x16d4a00 INFO                    task gsttask.c:457:gst_task_set_lock: setting stream lock 0x18aa0b0 on task 0x18be4d0
0:00:00.017862795    37      0x16d4a00 INFO                GST_PADS gstpad.c:6001:gst_pad_start_task:<videotestsrc0:src> created task 0x18be4d0
0:00:00.017892972    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<videotestsrc0> completed state change to PAUSED
0:00:00.017898147    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<videotestsrc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.017903962    37      0x16d4a00 INFO              GST_STATES gstbin.c:2982:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 3(PAUSED) successfully without preroll
0:00:00.017909518    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0> completed state change to PAUSED
0:00:00.017913100    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
Pipeline is live and does not need PREROLL ...
0:00:00.017935023    37      0x18c9320 INFO        GST_ELEMENT_PADS gstelement.c:915:gst_element_get_static_pad: no such pad 'sink' in element "videotestsrc0"
0:00:00.017957615    37      0x18c9320 FIXME                default gstutils.c:3902:gst_pad_create_stream_id_internal:<videotestsrc0:src> Creating random stream-id, consider implementing a deterministic way of creating a stream-id
Got context from element 'vaapiencodeh264-0': gst.vaapi.Display=context, gst.vaapi.Display=(GstVaapiDisplay)"\(GstVaapiDisplayDRM\)\ vaapidisplaydrm1";
0:00:00.018050190    37      0x18c9320 INFO             vaapiencode gstvaapiencode.c:389:ensure_allowed_sinkpad_caps:<vaapiencodeh264-0> Allowed sink caps video/x-raw(memory:VASurface), format=(string){ ENCODED, NV12, I420, YV12, P010_10LE }, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ]; video/x-raw, format=(string){ NV12, I420, YV12 }, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ], pixel-aspect-ratio=(fraction)[ 0/1, 2147483647/1 ]
Setting pipeline to PLAYING ...
0:00:00.018095523    37      0x16d4a00 INFO               GST_EVENT gstevent.c:1383:gst_event_new_latency: creating latency event 0:00:00.000000000
0:00:00.018107964    37      0x16d4a00 INFO                     bin gstbin.c:2768:gst_bin_do_latency_func:<pipeline0> configured latency of 0:00:00.000000000
0:00:00.018117192    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<hlssink0> current READY pending PAUSED, desired next PLAYING
0:00:00.018122148    37      0x16d4a00 INFO              GST_STATES gstbin.c:2945:gst_bin_change_state_func:<pipeline0> child 'hlssink0' is changing state asynchronously to PLAYING
0:00:00.018126871    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<mpegtsmux0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:00.018131777    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<mpegtsmux0> completed state change to PLAYING
0:00:00.018135503    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<mpegtsmux0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.018141235    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'mpegtsmux0' changed state to 4(PLAYING) successfully
0:00:00.018146325    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<vaapiencodeh264-0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:00.018151386    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<vaapiencodeh264-0> completed state change to PLAYING
0:00:00.018150077    37      0x18c9320 INFO               GST_EVENT gstevent.c:809:gst_event_new_caps: creating caps event video/x-raw, format=(string)I420, width=(int)1280, height=(int)720, framerate=(fraction)15/1, multiview-mode=(string)mono, pixel-aspect-ratio=(fraction)1/1, interlace-mode=(string)progressive
0:00:00.018155107    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<vaapiencodeh264-0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.018169766    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'vaapiencodeh264-0' changed state to 4(PLAYING) successfully
0:00:00.018175749    37      0x16d4a00 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:00.018183469    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0> completed state change to PLAYING
0:00:00.018187825    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.018193204    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 4(PLAYING) successfully
0:00:00.018198865    37      0x16d4a00 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<videotestsrc0> completed state change to PLAYING
0:00:00.018204730    37      0x16d4a00 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<videotestsrc0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.018198903    37      0x18c9320 INFO           basetransform gstbasetransform.c:1299:gst_base_transform_setcaps:<capsfilter0> reuse caps
0:00:00.018210668    37      0x16d4a00 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 4(PLAYING) successfully
0:00:00.018221800    37      0x18c9320 INFO               GST_EVENT gstevent.c:809:gst_event_new_caps: creating caps event video/x-raw, format=(string)I420, width=(int)1280, height=(int)720, framerate=(fraction)15/1, multiview-mode=(string)mono, pixel-aspect-ratio=(fraction)1/1, interlace-mode=(string)progressive
New clock: GstSystemClock
0:00:00.018277488    37      0x18c9320 INFO            vaapih264enc gstvaapiencode_h264.c:225:gst_vaapiencode_h264_set_config: using stereo-high profile as target decoder constraints
0:00:00.018290267    37      0x18c9320 INFO                   vaapi gstvaapiencoder.c:542:get_packed_headers: supported packed headers: 0x0000001f
0:00:00.018511359    37      0x18c9320 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad capsfilter0:sink
0:00:00.018520417    37      0x18c9320 INFO             vaapiencode gstvaapipluginbase.c:522:ensure_sinkpad_allocator:<vaapiencodeh264-0> enabling direct upload in sink allocator
0:00:00.018563264    37      0x18c9320 INFO        vaapivideomemory gstvaapivideomemory.c:791:allocator_configure_surface_info:<vaapivideoallocator0> has direct-uploading for I420 surfaces
0:00:00.018629720    37      0x18c9320 INFO                    task gsttask.c:457:gst_task_set_lock: setting stream lock 0x18aa530 on task 0x18be5f0
0:00:00.018636265    37      0x18c9320 INFO                GST_PADS gstpad.c:6001:gst_pad_start_task:<vaapiencodeh264-0:src> created task 0x18be5f0
0:00:00.024028188    37      0x18c9320 INFO               GST_EVENT gstevent.c:890:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.024045913    37      0x18c9320 INFO                 basesrc gstbasesrc.c:2836:gst_base_src_loop:<videotestsrc0> marking pending DISCONT
0:00:00.027086671    37 0x7f1430003320 INFO               GST_EVENT gstevent.c:809:gst_event_new_caps: creating caps event video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1280, height=(int)720, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)15/1, interlace-mode=(string)progressive, colorimetry=(string)bt709, chroma-site=(string)mpeg2, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono
0:00:00.027582170    37 0x7f1430003320 INFO               GST_EVENT gstevent.c:890:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.027635299    37 0x7f1430003320 FIXME               basesink gstbasesink.c:3144:gst_base_sink_default_event:<multifilesink0> stream-start event without group-id. Consider implementing group-id handling in the upstream elements
0:00:00.027651897    37 0x7f1430003320 INFO               GST_EVENT gstevent.c:890:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.027664891    37 0x7f1430003320 INFO               GST_EVENT gstevent.c:809:gst_event_new_caps: creating caps event video/mpegts, systemstream=(boolean)true, packetsize=(int)188
0:00:00.027711564    37 0x7f1430003320 INFO               GST_EVENT gstevent.c:809:gst_event_new_caps: creating caps event video/mpegts, systemstream=(boolean)true, packetsize=(int)188, streamheader=(buffer)< 47400030a600ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0000b00d0001c100000001e020a2c32941, 474020308b00ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff0002b0280001c10000e041f00c050448444d5688040ffffcfc1be041f00a050848444d56ff1b443f5a3175c0 >
0:00:00.027771969    37 0x7f1430003320 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad hlssink0:sink
0:00:00.027780114    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:498:schedule_next_key_unit:<hlssink0> sending upstream force-key-unit, index 1 now 0:00:00.072612625 target 0:00:01.072612625
0:00:00.027791876    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1005:mpegtsmux_src_event:<mpegtsmux0> received upstream force-key-unit event, seqnum 57 running_time 0:00:01.072612625 all_headers 1 count 1
0:00:00.027800575    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1026:mpegtsmux_src_event:<mpegtsmux0:src> forwarding
0:00:00.027806630    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1028:mpegtsmux_src_event:<mpegtsmux0> result 1
0:00:00.027825832    37 0x7f1430003320 INFO              GST_STATES gstbin.c:3409:bin_handle_async_done:<hlssink0> committing state from READY to PAUSED, old pending PAUSED
0:00:00.027834397    37 0x7f1430003320 INFO              GST_STATES gstbin.c:3429:bin_handle_async_done:<hlssink0> completed state change, pending VOID
0:00:00.027840271    37 0x7f1430003320 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<hlssink0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.027849230    37 0x7f1430003320 INFO              GST_STATES gstbin.c:3418:bin_handle_async_done:<pipeline0> setting state from PAUSED to PAUSED, pending PLAYING
0:00:00.027855263    37 0x7f1430003320 INFO              GST_STATES gstbin.c:3438:bin_handle_async_done:<pipeline0> continue state change, pending PLAYING
0:00:00.027923548    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:3235:gst_bin_continue_func:<pipeline0> continue state change PAUSED to PLAYING, final PLAYING
0:00:00.027962408    37 0x7f142c0020f0 INFO               GST_EVENT gstevent.c:1383:gst_event_new_latency: creating latency event 0:00:00.000000000
0:00:00.027979509    37 0x7f142c0020f0 INFO                     bin gstbin.c:2768:gst_bin_do_latency_func:<pipeline0> configured latency of 0:00:00.000000000
0:00:00.027993517    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<hlssink0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:00.028002573    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<multifilesink0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:00.028014599    37 0x7f142c0020f0 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<multifilesink0> completed state change to PLAYING
0:00:00.028021651    37 0x7f142c0020f0 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<multifilesink0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.028034849    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<hlssink0> child 'multifilesink0' changed state to 4(PLAYING) successfully
0:00:00.028043584    37 0x7f142c0020f0 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<hlssink0> completed state change to PLAYING
0:00:00.028049507    37 0x7f142c0020f0 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<hlssink0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.028057831    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'hlssink0' changed state to 4(PLAYING) successfully
0:00:00.028060749    37 0x7f1430003320 INFO           multifilesink gstmultifilesink.c:1118:gst_multi_file_sink_open_next_file:<multifilesink0> opening file segment00000.ts
0:00:00.028067710    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<mpegtsmux0> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.028078692    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2608:gst_bin_element_set_state:<mpegtsmux0> skipping transition from PLAYING to  PLAYING
0:00:00.028083424    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'mpegtsmux0' changed state to 4(PLAYING) successfully
0:00:00.028089259    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<vaapiencodeh264-0> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.028094140    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2608:gst_bin_element_set_state:<vaapiencodeh264-0> skipping transition from PLAYING to  PLAYING
0:00:00.028099274    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'vaapiencodeh264-0' changed state to 4(PLAYING) successfully
0:00:00.028105547    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.028111266    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2608:gst_bin_element_set_state:<capsfilter0> skipping transition from PLAYING to  PLAYING
0:00:00.028116959    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 4(PLAYING) successfully
0:00:00.028122775    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2491:gst_bin_element_set_state:<videotestsrc0> current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.028127831    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2608:gst_bin_element_set_state:<videotestsrc0> skipping transition from PLAYING to  PLAYING
0:00:00.028132290    37 0x7f142c0020f0 INFO              GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 4(PLAYING) successfully
0:00:00.028138099    37 0x7f142c0020f0 INFO              GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0> completed state change to PLAYING
0:00:00.028142565    37 0x7f142c0020f0 INFO              GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.164463086    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.205945958 wanted 0:00:01.072612625
0:00:00.171809768    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.139279291 wanted 0:00:01.072612625
0:00:00.297255632    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.339279291 wanted 0:00:01.072612625
0:00:00.301721143    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.272612625 wanted 0:00:01.072612625
0:00:00.428523124    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.472612625 wanted 0:00:01.072612625
0:00:00.432659212    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.405945958 wanted 0:00:01.072612625
0:00:00.562143672    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.605945958 wanted 0:00:01.072612625
0:00:00.566465214    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.539279291 wanted 0:00:01.072612625
0:00:00.694643890    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.739279291 wanted 0:00:01.072612625
0:00:00.698103160    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.672612625 wanted 0:00:01.072612625
0:00:00.827718929    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.872612625 wanted 0:00:01.072612625
0:00:00.831421704    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.805945958 wanted 0:00:01.072612625
0:00:00.961087293    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.005945958 wanted 0:00:01.072612625
0:00:00.964490378    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:00.939279291 wanted 0:00:01.072612625
0:00:01.094387518    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.072612625 wanted 0:00:01.072612625
0:00:01.094435618    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1083:check_pending_key_unit_event: pending force key unit, waiting for keyframe
0:00:01.097379668    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:908:mpegtsmux_sink_event:<mpegtsmux0:sink_65> have downstream force-key-unit event, seqnum 67, running-time 0:00:01.139279291 count 1
0:00:01.097421203    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:912:mpegtsmux_sink_event:<mpegtsmux0> skipping downstream force key unit event as an upstream force key unit is already queued
0:00:01.097458579    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.139279291 wanted 0:00:01.072612625
0:00:01.097493342    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1253:mpegtsmux_collected_buffer:<mpegtsmux0> pushing downstream force-key-unit event 57 0:00:01.139279291 count 1
0:00:01.097523654    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:472:gst_hls_sink_ghost_event_probe:<hlssink0> setting index 1
0:00:01.097631509    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:293:gst_hls_sink_handle_message:<hlssink0> COUNT 1
0:00:01.097883860    37 0x7f1430003320 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad hlssink0:sink
0:00:01.097914824    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:498:schedule_next_key_unit:<hlssink0> sending upstream force-key-unit, index 2 now 0:00:01.139279291 target 0:00:02.139279291
0:00:01.097962642    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1005:mpegtsmux_src_event:<mpegtsmux0> received upstream force-key-unit event, seqnum 70 running_time 0:00:02.139279291 all_headers 1 count 2
0:00:01.097990522    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1026:mpegtsmux_src_event:<mpegtsmux0:src> forwarding
0:00:01.098011664    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1028:mpegtsmux_src_event:<mpegtsmux0> result 1
0:00:01.098095525    37 0x7f1430003320 INFO           multifilesink gstmultifilesink.c:1118:gst_multi_file_sink_open_next_file:<multifilesink0> opening file segment00001.ts
0:00:01.227699210    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.272612625 wanted 0:00:02.139279291
0:00:01.231459724    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.205945958 wanted 0:00:02.139279291
0:00:01.360999152    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.405945958 wanted 0:00:02.139279291
0:00:01.364628026    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.339279291 wanted 0:00:02.139279291
0:00:01.494553918    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.539279291 wanted 0:00:02.139279291
0:00:01.498234064    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.472612625 wanted 0:00:02.139279291
0:00:01.627931526    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.672612625 wanted 0:00:02.139279291
0:00:01.631860602    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.605945958 wanted 0:00:02.139279291
0:00:01.761435632    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.805945958 wanted 0:00:02.139279291
0:00:01.765351631    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.739279291 wanted 0:00:02.139279291
0:00:01.894362697    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.939279291 wanted 0:00:02.139279291
0:00:01.897960313    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:01.872612625 wanted 0:00:02.139279291
0:00:02.027462654    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.005945958 wanted 0:00:02.139279291
0:00:02.030222148    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.072612625 wanted 0:00:02.139279291
0:00:02.161156978    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.139279291 wanted 0:00:02.139279291
0:00:02.161208677    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1083:check_pending_key_unit_event: pending force key unit, waiting for keyframe
0:00:02.164055218    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:908:mpegtsmux_sink_event:<mpegtsmux0:sink_65> have downstream force-key-unit event, seqnum 71, running-time 0:00:02.205945958 count 2
0:00:02.164097570    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:912:mpegtsmux_sink_event:<mpegtsmux0> skipping downstream force key unit event as an upstream force key unit is already queued
0:00:02.164132555    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.205945958 wanted 0:00:02.139279291
0:00:02.164177379    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1253:mpegtsmux_collected_buffer:<mpegtsmux0> pushing downstream force-key-unit event 70 0:00:02.205945958 count 2
0:00:02.164207054    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:472:gst_hls_sink_ghost_event_probe:<hlssink0> setting index 2
0:00:02.164306273    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:293:gst_hls_sink_handle_message:<hlssink0> COUNT 2
0:00:02.165198297    37 0x7f1430003320 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad hlssink0:sink
0:00:02.165244281    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:498:schedule_next_key_unit:<hlssink0> sending upstream force-key-unit, index 3 now 0:00:02.205945958 target 0:00:03.205945958
0:00:02.165309363    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1005:mpegtsmux_src_event:<mpegtsmux0> received upstream force-key-unit event, seqnum 74 running_time 0:00:03.205945958 all_headers 1 count 3
0:00:02.165345405    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1026:mpegtsmux_src_event:<mpegtsmux0:src> forwarding
0:00:02.165379624    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1028:mpegtsmux_src_event:<mpegtsmux0> result 1
0:00:02.165497612    37 0x7f1430003320 INFO           multifilesink gstmultifilesink.c:1118:gst_multi_file_sink_open_next_file:<multifilesink0> opening file segment00002.ts
0:00:02.294012868    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.339279291 wanted 0:00:03.205945958
0:00:02.297433142    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.272612625 wanted 0:00:03.205945958
0:00:02.427420597    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.472612625 wanted 0:00:03.205945958
0:00:02.430714119    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.405945958 wanted 0:00:03.205945958
0:00:02.560666574    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.605945958 wanted 0:00:03.205945958
0:00:02.563975587    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.539279291 wanted 0:00:03.205945958
0:00:02.694103930    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.739279291 wanted 0:00:03.205945958
0:00:02.697618176    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.672612625 wanted 0:00:03.205945958
0:00:02.827729497    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.872612625 wanted 0:00:03.205945958
0:00:02.831399199    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.805945958 wanted 0:00:03.205945958
0:00:02.960811882    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.005945958 wanted 0:00:03.205945958
0:00:02.964279733    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:02.939279291 wanted 0:00:03.205945958
0:00:03.094406007    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.139279291 wanted 0:00:03.205945958
0:00:03.098059001    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.072612625 wanted 0:00:03.205945958
0:00:03.227857430    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.205945958 wanted 0:00:03.205945958
0:00:03.227910390    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1083:check_pending_key_unit_event: pending force key unit, waiting for keyframe
0:00:03.230946449    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:908:mpegtsmux_sink_event:<mpegtsmux0:sink_65> have downstream force-key-unit event, seqnum 75, running-time 0:00:03.272612625 count 3
0:00:03.230986975    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:912:mpegtsmux_sink_event:<mpegtsmux0> skipping downstream force key unit event as an upstream force key unit is already queued
0:00:03.231033530    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.272612625 wanted 0:00:03.205945958
0:00:03.231075797    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1253:mpegtsmux_collected_buffer:<mpegtsmux0> pushing downstream force-key-unit event 74 0:00:03.272612625 count 3
0:00:03.231109876    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:472:gst_hls_sink_ghost_event_probe:<hlssink0> setting index 3
0:00:03.231218274    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:293:gst_hls_sink_handle_message:<hlssink0> COUNT 3
0:00:03.232085385    37 0x7f1430003320 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad hlssink0:sink
0:00:03.232137198    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:498:schedule_next_key_unit:<hlssink0> sending upstream force-key-unit, index 4 now 0:00:03.272612625 target 0:00:04.272612625
0:00:03.232194097    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1005:mpegtsmux_src_event:<mpegtsmux0> received upstream force-key-unit event, seqnum 78 running_time 0:00:04.272612625 all_headers 1 count 4
0:00:03.232234210    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1026:mpegtsmux_src_event:<mpegtsmux0:src> forwarding
0:00:03.232265500    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1028:mpegtsmux_src_event:<mpegtsmux0> result 1
0:00:03.232392024    37 0x7f1430003320 INFO           multifilesink gstmultifilesink.c:1118:gst_multi_file_sink_open_next_file:<multifilesink0> opening file segment00003.ts
0:00:03.360879519    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.405945958 wanted 0:00:04.272612625
0:00:03.364340870    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.339279291 wanted 0:00:04.272612625
0:00:03.494229926    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.539279291 wanted 0:00:04.272612625
0:00:03.497876566    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.472612625 wanted 0:00:04.272612625
0:00:03.627614683    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.672612625 wanted 0:00:04.272612625
0:00:03.631373268    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.605945958 wanted 0:00:04.272612625
0:00:03.761228226    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.805945958 wanted 0:00:04.272612625
0:00:03.765135106    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.739279291 wanted 0:00:04.272612625
0:00:03.894493466    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.939279291 wanted 0:00:04.272612625
0:00:03.897873128    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:03.872612625 wanted 0:00:04.272612625
0:00:04.027636399    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.005945958 wanted 0:00:04.272612625
0:00:04.030435984    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.072612625 wanted 0:00:04.272612625
0:00:04.161158858    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.205945958 wanted 0:00:04.272612625
0:00:04.164803162    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.139279291 wanted 0:00:04.272612625
0:00:04.294364041    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.272612625 wanted 0:00:04.272612625
0:00:04.294410345    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1083:check_pending_key_unit_event: pending force key unit, waiting for keyframe
0:00:04.297194433    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:908:mpegtsmux_sink_event:<mpegtsmux0:sink_65> have downstream force-key-unit event, seqnum 79, running-time 0:00:04.339279291 count 4
0:00:04.297237053    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:912:mpegtsmux_sink_event:<mpegtsmux0> skipping downstream force key unit event as an upstream force key unit is already queued
0:00:04.297271406    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.339279291 wanted 0:00:04.272612625
0:00:04.297301906    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1253:mpegtsmux_collected_buffer:<mpegtsmux0> pushing downstream force-key-unit event 78 0:00:04.339279291 count 4
0:00:04.297326042    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:472:gst_hls_sink_ghost_event_probe:<hlssink0> setting index 4
0:00:04.297409565    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:293:gst_hls_sink_handle_message:<hlssink0> COUNT 4
0:00:04.298250064    37 0x7f1430003320 INFO        GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad: found pad hlssink0:sink
0:00:04.298295554    37 0x7f1430003320 INFO                 hlssink gsthlssink.c:498:schedule_next_key_unit:<hlssink0> sending upstream force-key-unit, index 5 now 0:00:04.339279291 target 0:00:05.339279291
0:00:04.298343934    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1005:mpegtsmux_src_event:<mpegtsmux0> received upstream force-key-unit event, seqnum 82 running_time 0:00:05.339279291 all_headers 1 count 5
0:00:04.298372622    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1026:mpegtsmux_src_event:<mpegtsmux0:src> forwarding
0:00:04.298393141    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1028:mpegtsmux_src_event:<mpegtsmux0> result 1
0:00:04.298512689    37 0x7f1430003320 INFO           multifilesink gstmultifilesink.c:1118:gst_multi_file_sink_open_next_file:<multifilesink0> opening file segment00004.ts
0:00:04.427814792    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.472612625 wanted 0:00:05.339279291
0:00:04.431612910    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.405945958 wanted 0:00:05.339279291
0:00:04.561086548    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.605945958 wanted 0:00:05.339279291
0:00:04.564898020    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.539279291 wanted 0:00:05.339279291
0:00:04.694641988    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.739279291 wanted 0:00:05.339279291
0:00:04.698430002    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.672612625 wanted 0:00:05.339279291
0:00:04.828095717    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.872612625 wanted 0:00:05.339279291
0:00:04.832308290    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.805945958 wanted 0:00:05.339279291
0:00:04.960876909    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:05.005945958 wanted 0:00:05.339279291
0:00:04.964182299    37 0x7f1430003320 INFO               mpegtsmux mpegtsmux.c:1077:check_pending_key_unit_event: now 0:00:04.939279291 wanted 0:00:05.339279291