0:00:00.000083357  5968   01D94000 INFO                GST_INIT gst.c:502:init_pre: Initializing GStreamer Core Library version 1.1.3.1
0:00:00.000378896  5968   01D94000 INFO                GST_INIT gst.c:503:init_pre: Using library installed in /c/Users/bmonkey/cerbero/dist/windows_x86/lib
0:00:00.001474663  5968   01D94000 INFO                GST_INIT gstmessage.c:121:_priv_gst_message_initialize: init messages
0:00:00.001785736  5968   01D94000 INFO                GST_INIT gstcontext.c:76:_priv_gst_context_initialize: init contexts
0:00:00.008423612  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:317:_priv_gst_plugin_initialize: registering 0 static plugins
0:00:00.008767649  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:225:gst_plugin_register_static: registered static plugin "staticelements"
0:00:00.009033255  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:227:gst_plugin_register_static: added static plugin "staticelements", result: 1
0:00:00.018081287  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1680:ensure_current_registry: reading registry cache: C:\Users\bmonkey\AppData\Local\Microsoft\Windows\Temporary Internet Files\gstreamer-1.0\registry.i686.bin
0:00:00.032634296  5968   01D94000 INFO            GST_REGISTRY gstregistrybinary.c:617:priv_gst_registry_binary_read_cache: loaded C:\Users\bmonkey\AppData\Local\Microsoft\Windows\Temporary Internet Files\gstreamer-1.0\registry.i686.bin in 0.014467 seconds
0:00:00.032763499  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1539:scan_and_update_registry: Validating plugins from registry cache: C:\Users\bmonkey\AppData\Local\Microsoft\Windows\Temporary Internet Files\gstreamer-1.0\registry.i686.bin
0:00:00.034510967  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgnl.dll is stale
0:00:00.035436230  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgnl.dll" loaded
0:00:00.035645002  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaccurip.dll is stale
0:00:00.036100814  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaccurip.dll" loaded
0:00:00.036309964  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstadder.dll is stale
0:00:00.036783584  5968   01D94000 INFO                   adder gstadder.c:1609:gst_adder_child_proxy_init: intializing child proxy interface
0:00:00.036888538  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstadder.dll" loaded
0:00:00.037089732  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstadpcmdec.dll is stale
0:00:00.037554258  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstadpcmdec.dll" loaded
0:00:00.037769092  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstadpcmenc.dll is stale
0:00:00.038224904  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstadpcmenc.dll" loaded
0:00:00.038434054  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaiff.dll is stale
0:00:00.040253512  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaiff.dll" loaded
0:00:00.040460389  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstalaw.dll is stale
0:00:00.040966594  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstalaw.dll" loaded
0:00:00.041197341  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstalpha.dll is stale
0:00:00.041743330  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstalpha.dll" loaded
0:00:00.041972941  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstalphacolor.dll is stale
0:00:00.042412460  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstalphacolor.dll" loaded
0:00:00.042615927  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstamrnb.dll is stale
0:00:00.043243757  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstamrnb.dll" loaded
0:00:00.043490419  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstamrwbdec.dll is stale
0:00:00.044015947  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstamrwbdec.dll" loaded
0:00:00.044219793  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstapetag.dll is stale
0:00:00.044636200  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstapetag.dll" loaded
0:00:00.044836635  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstapp.dll is stale
0:00:00.045534183  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstapp.dll" loaded
0:00:00.045743712  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstasf.dll is stale
0:00:00.047351367  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstasf.dll" loaded
0:00:00.047553697  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstasfmux.dll is stale
0:00:00.048289134  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstasfmux.dll" loaded
0:00:00.048519124  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstassrender.dll is stale
0:00:00.049758871  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstassrender.dll" loaded
0:00:00.049964611  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudioconvert.dll is stale
0:00:00.050500749  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudioconvert.dll" loaded
0:00:00.050704974  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiofx.dll is stale
0:00:00.052117497  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiofx.dll" loaded
0:00:00.052319070  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiofxbad.dll is stale
0:00:00.052745328  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiofxbad.dll" loaded
0:00:00.052953341  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudioparsers.dll is stale
0:00:00.053993789  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudioparsers.dll" loaded
0:00:00.054246134  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiorate.dll is stale
0:00:00.054725058  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiorate.dll" loaded
0:00:00.054926631  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudioresample.dll is stale
0:00:00.055314241  5968   01D94000 WARN           audioresample gstaudioresample.c:1535:plugin_init: Orc disabled, can't benchmark int vs. float resampler
0:00:00.055382442  5968   01D94000 WARN         GST_PERFORMANCE gstaudioresample.c:1538:plugin_init: orc disabled, no benchmarking done
0:00:00.055537411  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudioresample.dll" loaded
0:00:00.055733679  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiotestsrc.dll is stale
0:00:00.056166378  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiotestsrc.dll" loaded
0:00:00.056365298  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiovisualizers.dll is stale
0:00:00.057085200  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstaudiovisualizers.dll" loaded
0:00:00.057288667  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstauparse.dll is stale
0:00:00.057756982  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstauparse.dll" loaded
0:00:00.057957039  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstautoconvert.dll is stale
0:00:00.058415124  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstautoconvert.dll" loaded
0:00:00.058612529  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstautodetect.dll is stale
0:00:00.059130480  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstautodetect.dll" loaded
0:00:00.059329779  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstavi.dll is stale
0:00:00.071582133  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstavi.dll" loaded
0:00:00.071789389  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstavscale.dll is stale
0:00:00.073181073  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstavscale.dll" loaded
0:00:00.073382267  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstbayer.dll is stale
0:00:00.073948337  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstbayer.dll" loaded
0:00:00.074196893  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcamerabin2.dll is stale
0:00:00.075234309  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcamerabin2.dll" loaded
0:00:00.075446491  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcoloreffects.dll is stale
0:00:00.076002331  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcoloreffects.dll" loaded
0:00:00.076209208  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcoreelements.dll is stale
0:00:00.078320416  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcoreelements.dll" loaded
0:00:00.078523504  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcutter.dll is stale
0:00:00.079009627  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstcutter.dll" loaded
0:00:00.079211579  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstd3dvideosink.dll is stale
0:00:00.080812035  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstd3dvideosink.dll" loaded
0:00:00.081017775  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdashdemux.dll is stale
0:00:00.081818003  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/dash+xml
0:00:00.081899844  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdashdemux.dll" loaded
0:00:00.082096112  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdataurisrc.dll is stale
0:00:00.082496226  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdataurisrc.dll" loaded
0:00:00.082701209  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdebug.dll is stale
0:00:00.083466200  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdebug.dll" loaded
0:00:00.083670046  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdebugutilsbad.dll is stale
0:00:00.084362288  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdebugutilsbad.dll" loaded
0:00:00.084573333  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdeinterlace.dll is stale
0:00:00.085161758  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdeinterlace.dll" loaded
0:00:00.085408420  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdirectsoundsink.dll is stale
0:00:00.086463644  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdirectsoundsink.dll" loaded
0:00:00.086667111  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdirectsoundsrc.dll is stale
0:00:00.087148688  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdirectsoundsrc.dll" loaded
0:00:00.087350639  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdtmf.dll is stale
0:00:00.087933381  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdtmf.dll" loaded
0:00:00.088134196  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdtsdec.dll is stale
0:00:00.088715422  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdtsdec.dll" loaded
0:00:00.088919268  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvbsuboverlay.dll is stale
0:00:00.089476245  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvbsuboverlay.dll" loaded
0:00:00.089678575  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdlpcmdec.dll is stale
0:00:00.090159394  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdlpcmdec.dll" loaded
0:00:00.090362861  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdread.dll is stale
0:00:00.091130883  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdread.dll" loaded
0:00:00.091343822  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdspu.dll is stale
0:00:00.091800771  5968   01D94000 INFO                  gstspu gstdvdspu.c:1255:gst_dvd_spu_plugin_init: debug flags : 0x00
0:00:00.091971274  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdspu.dll" loaded
0:00:00.092176256  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdsub.dll is stale
0:00:00.092671473  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstdvdsub.dll" loaded
0:00:00.092880624  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsteffectv.dll is stale
0:00:00.094288979  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsteffectv.dll" loaded
0:00:00.094535262  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstencodebin.dll is stale
0:00:00.095075188  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstencodebin.dll" loaded
0:00:00.095276382  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstequalizer.dll is stale
0:00:00.095825023  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstequalizer.dll" loaded
0:00:00.096032658  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfaad.dll is stale
0:00:00.096736267  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfaad.dll" loaded
0:00:00.096938977  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfieldanalysis.dll is stale
0:00:00.097448213  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfieldanalysis.dll" loaded
0:00:00.097650922  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstflac.dll is stale
0:00:00.098480325  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstflac.dll" loaded
0:00:00.098682655  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstflv.dll is stale
0:00:00.099637852  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstflv.dll" loaded
0:00:00.099838287  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstflxdec.dll is stale
0:00:00.100269092  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstflxdec.dll" loaded
0:00:00.100471801  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfreeverb.dll is stale
0:00:00.100938222  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfreeverb.dll" loaded
0:00:00.101144341  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfrei0r.dll is stale
0:00:00.102447364  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstfrei0r.dll" loaded
0:00:00.102645905  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgaudieffects.dll is stale
0:00:00.103551845  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgaudieffects.dll" loaded
0:00:00.103797370  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgdkpixbuf.dll is stale
0:00:00.105463753  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgdkpixbuf.dll" loaded
0:00:00.105665705  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgdp.dll is stale
0:00:00.106195401  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgdp.dll" loaded
0:00:00.106398868  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgeometrictransform.dll is stale
0:00:00.107862164  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgeometrictransform.dll" loaded
0:00:00.108069799  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgio.dll is stale
0:00:00.111226380  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgio.dll" loaded
0:00:00.111432499  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgoom.dll is stale
0:00:00.111966742  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgoom.dll" loaded
0:00:00.112171725  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgoom2k1.dll is stale
0:00:00.112627915  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstgoom2k1.dll" loaded
0:00:00.112831004  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsticydemux.dll is stale
0:00:00.113283026  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsticydemux.dll" loaded
0:00:00.113483083  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstid3demux.dll is stale
0:00:00.113885471  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstid3demux.dll" loaded
0:00:00.114090453  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstid3tag.dll is stale
0:00:00.114582260  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstid3tag.dll" loaded
0:00:00.114784211  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstimagefreeze.dll is stale
0:00:00.115215395  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstimagefreeze.dll" loaded
0:00:00.115466603  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstinterlace.dll is stale
0:00:00.115979249  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstinterlace.dll" loaded
0:00:00.116217574  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstinterleave.dll is stale
0:00:00.116863971  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstinterleave.dll" loaded
0:00:00.117065543  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstisomp4.dll is stale
0:00:00.121821064  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstisomp4.dll" loaded
0:00:00.122043097  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstivtc.dll is stale
0:00:00.122572794  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstivtc.dll" loaded
0:00:00.122773987  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstjpeg.dll is stale
0:00:00.123440844  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstjpeg.dll" loaded
0:00:00.123642038  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstjpegformat.dll is stale
0:00:00.124179312  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstjpegformat.dll" loaded
0:00:00.124379748  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstkate.dll is stale
0:00:00.125265985  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstkate.dll" loaded
0:00:00.125467179  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstlevel.dll is stale
0:00:00.125921475  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstlevel.dll" loaded
0:00:00.126123805  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstlibav.dll is stale
0:00:00.171429892  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_avs
0:00:00.171582966  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_daud
0:00:00.171706865  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_ea
0:00:00.171826217  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_ffm
0:00:00.171950116  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_4xm
0:00:00.172067574  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_gxf
0:00:00.172187684  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_idcin
0:00:00.172309309  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_ipmovie
0:00:00.172438513  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_mm
0:00:00.172567716  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_mmf
0:00:00.172796570  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_nsv
0:00:00.172925394  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_nut
0:00:00.173111053  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_film_cpk
0:00:00.173232679  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_smk
0:00:00.173352031  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_sol
0:00:00.173473277  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_psxstr
0:00:00.173646054  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_vmd
0:00:00.173808979  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_wc3movie
0:00:00.173926058  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_wsaud
0:00:00.174046547  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_wsvqa
0:00:00.174174992  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for avtype_yuv4mpegpipe
0:00:00.181233064  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstlibav.dll" loaded
0:00:00.181454718  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstliveadder.dll is stale
0:00:00.181975699  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstliveadder.dll" loaded
0:00:00.182220087  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmad.dll is stale
0:00:00.182737280  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmad.dll" loaded
0:00:00.182940368  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmatroska.dll is stale
0:00:00.184937907  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmatroska.dll" loaded
0:00:00.185136069  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmidi.dll is stale
0:00:00.185585440  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmidi.dll" loaded
0:00:00.185781708  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmms.dll is stale
0:00:00.186716823  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmms.dll" loaded
0:00:00.186915743  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpeg2dec.dll is stale
0:00:00.187527660  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpeg2dec.dll" loaded
0:00:00.187726201  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegpsdemux.dll is stale
0:00:00.188370703  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegpsdemux.dll" loaded
0:00:00.188567350  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegpsmux.dll is stale
0:00:00.189079238  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegpsmux.dll" loaded
0:00:00.189275506  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegtsdemux.dll is stale
0:00:00.190287158  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegtsdemux.dll" loaded
0:00:00.190485320  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegtsmux.dll is stale
0:00:00.191059726  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmpegtsmux.dll" loaded
0:00:00.191257510  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmulaw.dll is stale
0:00:00.191736055  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmulaw.dll" loaded
0:00:00.191941038  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmultifile.dll is stale
0:00:00.192536662  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmultifile.dll" loaded
0:00:00.192777640  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmultipart.dll is stale
0:00:00.193279298  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmultipart.dll" loaded
0:00:00.193475187  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmxf.dll is stale
0:00:00.195605339  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstmxf.dll" loaded
0:00:00.195806154  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstnavigationtest.dll is stale
0:00:00.196235822  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstnavigationtest.dll" loaded
0:00:00.196430953  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstogg.dll is stale
0:00:00.199018433  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstogg.dll" loaded
0:00:00.199215837  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstopus.dll is stale
0:00:00.200359345  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstopus.dll" loaded
0:00:00.200556371  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpango.dll is stale
0:00:00.207709924  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpango.dll" loaded
0:00:00.207926273  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpcapparse.dll is stale
0:00:00.208411639  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpcapparse.dll" loaded
0:00:00.208608286  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstplayback.dll is stale
0:00:00.211190460  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstplayback.dll" loaded
0:00:00.211392033  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpng.dll is stale
0:00:00.211939159  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpng.dll" loaded
0:00:00.212133911  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpnm.dll is stale
0:00:00.212644663  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstpnm.dll" loaded
0:00:00.212896249  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrawparse.dll is stale
0:00:00.213488842  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrawparse.dll" loaded
0:00:00.213684353  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstremovesilence.dll is stale
0:00:00.214121220  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstremovesilence.dll" loaded
0:00:00.214318245  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstreplaygain.dll is stale
0:00:00.215021097  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstreplaygain.dll" loaded
0:00:00.215216986  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstresindvd.dll is stale
0:00:00.216364283  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstresindvd.dll" loaded
0:00:00.216560930  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrfbsrc.dll is stale
0:00:00.217166784  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrfbsrc.dll" loaded
0:00:00.217362294  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrmdemux.dll is stale
0:00:00.218365610  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrmdemux.dll" loaded
0:00:00.218562636  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrtp.dll is stale
0:00:00.224137709  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrtp.dll" loaded
0:00:00.224337008  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrtpmanager.dll is stale
0:00:00.226246264  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrtpmanager.dll" loaded
0:00:00.226445185  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrtsp.dll is stale
0:00:00.229139513  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstrtsp.dll" loaded
0:00:00.229337675  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstschro.dll is stale
0:00:00.264976615  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstschro.dll" loaded
0:00:00.265230475  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsdpelem.dll is stale
0:00:00.265723418  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsdpelem.dll" loaded
0:00:00.265923475  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsegmentclip.dll is stale
0:00:00.266473632  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsegmentclip.dll" loaded
0:00:00.266669900  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstshapewipe.dll is stale
0:00:00.267206795  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstshapewipe.dll" loaded
0:00:00.267401927  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsiren.dll is stale
0:00:00.267899417  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsiren.dll" loaded
0:00:00.268094927  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsmooth.dll is stale
0:00:00.268549602  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsmooth.dll" loaded
0:00:00.268745491  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsmoothstreaming.dll is stale
0:00:00.270266000  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsmoothstreaming.dll" loaded
0:00:00.270464542  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsmpte.dll is stale
0:00:00.271238626  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsmpte.dll" loaded
0:00:00.271434894  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstspectrum.dll is stale
0:00:00.271899799  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstspectrum.dll" loaded
0:00:00.272094930  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstspeed.dll is stale
0:00:00.272558320  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstspeed.dll" loaded
0:00:00.272753451  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstspeex.dll is stale
0:00:00.273629079  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstspeex.dll" loaded
0:00:00.273873088  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsubenc.dll is stale
0:00:00.274339509  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsubenc.dll" loaded
0:00:00.274534261  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsubparse.dll is stale
0:00:00.275012807  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for subparse_typefind
0:00:00.275186720  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstsubparse.dll" loaded
0:00:00.275379957  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttaglib.dll is stale
0:00:00.277574143  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttaglib.dll" loaded
0:00:00.277775715  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttcp.dll is stale
0:00:00.278596782  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttcp.dll" loaded
0:00:00.278793050  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttheora.dll is stale
0:00:00.279724755  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttheora.dll" loaded
0:00:00.279925191  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttypefindfunctions.dll is stale
0:00:00.280555295  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-ms-asf
0:00:00.280634484  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-musepack
0:00:00.280700791  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-au
0:00:00.280764445  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-msvideo
0:00:00.280828479  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/qcelp
0:00:00.280892891  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-cdxa
0:00:00.280956545  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-vcd
0:00:00.281019821  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-imelody
0:00:00.281084612  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/midi
0:00:00.281149024  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/riff-midi
0:00:00.281213437  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/mobile-xmf
0:00:00.281279365  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-fli
0:00:00.281346429  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-id3v2
0:00:00.281410463  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-id3v1
0:00:00.281475633  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-apetag
0:00:00.281540803  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-ttafile
0:00:00.281605973  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-mod
0:00:00.281675690  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/mpeg
0:00:00.281741617  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-ac3
0:00:00.281806788  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-dts
0:00:00.281876125  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-gsm
0:00:00.281943948  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/mpeg-sys
0:00:00.282011770  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/mpegts
0:00:00.282078077  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/ogg
0:00:00.282144384  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/mpeg-elementary
0:00:00.282209554  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/mpeg4
0:00:00.282275482  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-h263
0:00:00.282344062  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-h264
0:00:00.282409611  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-nuv
0:00:00.282473644  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-m4a
0:00:00.282538056  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-3gp
0:00:00.282603984  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/quicktime
0:00:00.282669154  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-quicktime
0:00:00.282733946  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/jp2
0:00:00.282797979  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/mj2
0:00:00.282861633  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for text/html
0:00:00.282935518  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/vnd.rn-realmedia
0:00:00.283001825  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-pn-realaudio
0:00:00.283110189  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-shockwave-flash
0:00:00.283176496  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/vnd.ms-sstr+xml
0:00:00.283240150  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-flv
0:00:00.283304184  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for text/plain
0:00:00.283368217  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for text/utf-16
0:00:00.283431872  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for text/utf-32
0:00:00.283495526  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for text/uri-list
0:00:00.283559181  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-hls
0:00:00.283623593  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/sdp
0:00:00.283688005  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/smil
0:00:00.283751660  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/xml
0:00:00.283814935  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-wav
0:00:00.283879727  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-aiff
0:00:00.283944139  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-svx
0:00:00.284008172  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-paris
0:00:00.284071827  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-nist
0:00:00.284135102  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-voc
0:00:00.284198757  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-sds
0:00:00.284262411  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-ircam
0:00:00.284325308  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-w64
0:00:00.284389341  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-shorten
0:00:00.284453754  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ape
0:00:00.284517787  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/jpeg
0:00:00.284581442  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/gif
0:00:00.284645096  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/png
0:00:00.284708751  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/bmp
0:00:00.284777331  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/tiff
0:00:00.284843637  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/webp
0:00:00.284910323  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-portable-pixmap
0:00:00.284975114  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-matroska
0:00:00.285039905  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/mxf
0:00:00.285103939  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-mve
0:00:00.285168351  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-dv
0:00:00.285233900  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-amr-nb-sh
0:00:00.285297934  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-amr-wb-sh
0:00:00.285362346  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/iLBC-sh
0:00:00.285428274  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-sbc
0:00:00.285492686  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-sid
0:00:00.285555962  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-xcf
0:00:00.285619237  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-mng
0:00:00.285682134  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-jng
0:00:00.285745409  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-xpixmap
0:00:00.285809443  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-sun-raster
0:00:00.285874613  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-bzip
0:00:00.285938646  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-gzip
0:00:00.286002680  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/zip
0:00:00.286066334  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-compress
0:00:00.286129231  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for subtitle/x-kate
0:00:00.286192885  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-flac
0:00:00.286257677  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-vorbis
0:00:00.286321331  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-theora
0:00:00.286384986  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ogm-video
0:00:00.286448640  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ogm-audio
0:00:00.286515326  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ogm-text
0:00:00.286579738  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-speex
0:00:00.286643771  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-celt
0:00:00.286709320  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ogg-skeleton
0:00:00.286773733  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for text/x-cmml
0:00:00.286837008  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-executable
0:00:00.286904831  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/aac
0:00:00.286971137  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-spc
0:00:00.287037444  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-wavpack
0:00:00.287103751  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-wavpack-correction
0:00:00.287168921  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/postscript
0:00:00.287233712  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/svg+xml
0:00:00.287297367  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-rar
0:00:00.287361779  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-tar
0:00:00.287426191  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ar
0:00:00.287490604  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ms-dos-executable
0:00:00.287556153  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-dirac
0:00:00.287620186  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for multipart/x-mixed-replace
0:00:00.287684219  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-mmsh
0:00:00.287748253  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/vivo
0:00:00.287811907  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-nsf
0:00:00.287876319  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-gym
0:00:00.287939974  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-ay
0:00:00.288003250  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-gbs
0:00:00.288066904  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-vgm
0:00:00.288130559  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-sap
0:00:00.288197244  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for video/x-ivf
0:00:00.288260899  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for audio/x-kss
0:00:00.288324553  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/pdf
0:00:00.288388587  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/msword
0:00:00.288452241  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/octet-stream
0:00:00.288517032  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/vnd.adobe.photoshop
0:00:00.288581066  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/vnd.wap.wbmp
0:00:00.288643205  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-yuv4mpeg
0:00:00.288705344  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-icon
0:00:00.288767482  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for image/x-degas
0:00:00.288829621  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/octet-stream
0:00:00.288895928  5968   01D94000 INFO            GST_TYPEFIND gsttypefind.c:73:gst_type_find_register: registering typefind function for application/x-ssa
0:00:00.288959583  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsttypefindfunctions.dll" loaded
0:00:00.289148273  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstudp.dll is stale
0:00:00.289940544  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstudp.dll" loaded
0:00:00.290136433  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideobox.dll is stale
0:00:00.290688484  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideobox.dll" loaded
0:00:00.290887783  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideoconvert.dll is stale
0:00:00.291545925  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideoconvert.dll" loaded
0:00:00.291744088  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideocrop.dll is stale
0:00:00.292360172  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideocrop.dll" loaded
0:00:00.292599256  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideofilter.dll is stale
0:00:00.293431690  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideofilter.dll" loaded
0:00:00.293631747  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideofiltersbad.dll is stale
0:00:00.294272460  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideofiltersbad.dll" loaded
0:00:00.294469864  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideomixer.dll is stale
0:00:00.295017748  5968   01D94000 INFO              videomixer videomixer2.c:2038:gst_videomixer2_child_proxy_init: intializing child proxy interface
0:00:00.295164001  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideomixer.dll" loaded
0:00:00.295357617  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideoparsersbad.dll is stale
0:00:00.296401854  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideoparsersbad.dll" loaded
0:00:00.296601532  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideorate.dll is stale
0:00:00.297075531  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideorate.dll" loaded
0:00:00.297271799  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideoscale.dll is stale
0:00:00.297963663  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideoscale.dll" loaded
0:00:00.298161825  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideotestsrc.dll is stale
0:00:00.298714634  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvideotestsrc.dll" loaded
0:00:00.298912039  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvolume.dll is stale
0:00:00.299406877  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvolume.dll" loaded
0:00:00.299602387  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvorbis.dll is stale
0:00:00.300840618  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvorbis.dll" loaded
0:00:00.301042570  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvpx.dll is stale
0:00:00.302280801  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstvpx.dll" loaded
0:00:00.302523674  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwasapi.dll is stale
0:00:00.303009797  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwasapi.dll" loaded
0:00:00.303205307  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwaveformsink.dll is stale
0:00:00.303666802  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwaveformsink.dll" loaded
0:00:00.303861934  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwavenc.dll is stale
0:00:00.304465136  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwavenc.dll" loaded
0:00:00.304661783  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwavpack.dll is stale
0:00:00.305496490  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwavpack.dll" loaded
0:00:00.305693137  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwavparse.dll is stale
0:00:00.306442214  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwavparse.dll" loaded
0:00:00.306639619  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwinscreencap.dll is stale
0:00:00.307161358  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstwinscreencap.dll" loaded
0:00:00.307357626  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstx264.dll is stale
0:00:00.308510606  5968   01D94000 INFO                 x264enc gstx264enc.c:2334:plugin_init: x264 build: 125
0:00:00.308830015  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstx264.dll" loaded
0:00:00.309028178  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstxingmux.dll is stale
0:00:00.309492325  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstxingmux.dll" loaded
0:00:00.309686320  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsty4mdec.dll is stale
0:00:00.310152362  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsty4mdec.dll" loaded
0:00:00.310349009  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsty4menc.dll is stale
0:00:00.310818082  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgsty4menc.dll" loaded
0:00:00.311040494  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1289:gst_registry_scan_path_level:<registry0> cached info for c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstyadif.dll is stale
0:00:00.311503883  5968   01D94000 INFO      GST_PLUGIN_LOADING gstplugin.c:830:gst_plugin_load_file: plugin "c:\Users\bmonkey\cerbero\dist\windows_x86\lib\gstreamer-1.0\libgstyadif.dll" loaded
0:00:00.311674386  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1647:scan_and_update_registry: Registry cache changed. Writing new registry cache
0:00:00.311733873  5968   01D94000 INFO            GST_REGISTRY gstregistrybinary.c:367:priv_gst_registry_binary_write_cache: Building binary registry cache image
0:00:00.318371748  5968   01D94000 INFO            GST_REGISTRY gstregistrybinary.c:399:priv_gst_registry_binary_write_cache: Writing binary registry cache
0:00:00.327190548  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1656:scan_and_update_registry: Registry cache written successfully
0:00:00.327274663  5968   01D94000 INFO            GST_REGISTRY gstregistry.c:1715:ensure_current_registry: registry reading and updating done, result = 1
0:00:00.327330361  5968   01D94000 INFO                GST_INIT gst.c:707:init_post: GLib runtime version: 2.36.1
0:00:00.327383406  5968   01D94000 INFO                GST_INIT gst.c:709:init_post: GLib headers version: 2.36.1
0:00:00.327441377  5968   01D94000 INFO                GST_INIT gst.c:350:gst_init_check: initialized GStreamer successfully
0:00:00.329270307  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "gnlcomposition"
0:00:00.329426791  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "adder" named "smart-adder-adder"
0:00:00.329518105  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstAdder@0732D910> adding pad 'src'
0:00:00.329604872  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad smart-adder-adder:src
0:00:00.329702628  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link smart-adder-adder:src and src:proxypad0
0:00:00.329763251  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked smart-adder-adder:src and src:proxypad0, successful
0:00:00.329817054  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.329873510  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<smart-adder-adder:src> Received event on flushing pad. Discarding
0:00:00.329937922  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GESSmartAdder@0752C018> adding pad 'src'
0:00:00.330007260  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "gnloperation" named "mixing-operation"
0:00:00.330114866  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link gessmartadder0:src and src:proxypad1
0:00:00.330175868  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked gessmartadder0:src and src:proxypad1, successful
0:00:00.330229293  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.330287643  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<smart-adder-adder:src> Received event on flushing pad. Discarding
0:00:00.330353571  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<mixing-operation> adding pad 'src'
0:00:00.330431244  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:2852:gnl_composition_add_object:<mixing-operation> Used as expandable, commiting now
0:00:00.330489215  5968   01D94000 INFO               gnlobject gnlobject.c:463:gnl_object_commit_func:<mixing-operation> Commiting object changed
0:00:00.330543776  5968   01D94000 INFO               gnlobject gnlobject.c:473:gnl_object_commit_func:<mixing-operation> Done commiting
0:00:00.330627512  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "gnlcomposition"
0:00:00.330788164  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "videomixer" named "smart-mixer-mixer"
0:00:00.330888950  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstVideoMixer2@0731BE00> adding pad 'src'
0:00:00.330977233  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad smart-mixer-mixer:src
0:00:00.331066274  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link smart-mixer-mixer:src and src:proxypad2
0:00:00.331130686  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked smart-mixer-mixer:src and src:proxypad2, successful
0:00:00.331188657  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.331247007  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<smart-mixer-mixer:src> Received event on flushing pad. Discarding
0:00:00.331313693  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GESSmartMixer@0752C148> adding pad 'src'
0:00:00.331381515  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "gnloperation" named "mixing-operation"
0:00:00.331487227  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link gessmartmixer0:src and src:proxypad3
0:00:00.331553155  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked gessmartmixer0:src and src:proxypad3, successful
0:00:00.331610747  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.331671370  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<smart-mixer-mixer:src> Received event on flushing pad. Discarding
0:00:00.331737677  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<mixing-operation> adding pad 'src'
0:00:00.331818003  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:2852:gnl_composition_add_object:<mixing-operation> Used as expandable, commiting now
0:00:00.331879005  5968   01D94000 INFO               gnlobject gnlobject.c:463:gnl_object_commit_func:<mixing-operation> Commiting object changed
0:00:00.331937734  5968   01D94000 INFO               gnlobject gnlobject.c:473:gnl_object_commit_func:<mixing-operation> Done commiting
0:00:00.332015408  5968   01D94000 INFO             gestimeline ges-timeline.c:2583:ges_timeline_add_track:<gestimeline0> Getting dynamic lock from 01D94000
0:00:00.332082851  5968   01D94000 INFO             gestimeline ges-timeline.c:2583:ges_timeline_add_track:<gestimeline0> Got Dynamic lock from 01D94000
0:00:00.332143853  5968   01D94000 INFO             gestimeline ges-timeline.c:2586:ges_timeline_add_track:<gestimeline0> Unlocking dynamic lock from 01D94000
0:00:00.332204477  5968   01D94000 INFO             gestimeline ges-timeline.c:2586:ges_timeline_add_track:<gestimeline0> Unlocked Dynamic lock from 01D94000
0:00:00.332287076  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition1> current NULL pending VOID_PENDING, desired next NULL
0:00:00.332359824  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'mixing-operation' changed state to 1(NULL) successfully
0:00:00.332424615  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition1> completed state change to NULL
0:00:00.332484481  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesvideotrack0> child 'gnlcomposition1' changed state to 1(NULL) successfully
0:00:00.332546620  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesvideotrack0> completed state change to NULL
0:00:00.332621641  5968   01D94000 INFO             gestimeline ges-timeline.c:2583:ges_timeline_add_track:<gestimeline0> Getting dynamic lock from 01D94000
0:00:00.332685674  5968   01D94000 INFO             gestimeline ges-timeline.c:2583:ges_timeline_add_track:<gestimeline0> Got Dynamic lock from 01D94000
0:00:00.332746298  5968   01D94000 INFO             gestimeline ges-timeline.c:2586:ges_timeline_add_track:<gestimeline0> Unlocking dynamic lock from 01D94000
0:00:00.332806921  5968   01D94000 INFO             gestimeline ges-timeline.c:2586:ges_timeline_add_track:<gestimeline0> Unlocked Dynamic lock from 01D94000
0:00:00.332886110  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.332953175  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 1(NULL) successfully
0:00:00.333016829  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition0> completed state change to NULL
0:00:00.333075937  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesaudiotrack0> child 'gnlcomposition0' changed state to 1(NULL) successfully
0:00:00.333137697  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesaudiotrack0> completed state change to NULL
0:00:00.333436646  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "gnlsource"
0:00:00.333533264  5968   01D94000 INFO            GST_PIPELINE gstparse.c:322:gst_parse_launch_full: parsing pipeline description 'bin.( videotestsrc pattern=0 name=testsrc ! capsfilter caps=video/x-raw )'
0:00:00.333609043  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "videotestsrc"
0:00:00.333687475  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseSrc@02996B58> adding pad 'src'
0:00:00.333774621  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "capsfilter"
0:00:00.333854947  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@0731BBD8> adding pad 'sink'
0:00:00.333931105  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@0731BBD8> adding pad 'src'
0:00:00.334006126  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.334071296  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "bin"
0:00:00.334156927  5968   01D94000 INFO            GST_PIPELINE grammar.y:578:gst_parse_perform_link: linking testsrc:(any) to capsfilter0:(any) (0/0) with caps "(NULL)"
0:00:00.334226265  5968   01D94000 INFO        GST_ELEMENT_PADS gstutils.c:1543:gst_element_link_pads_full: trying to link element testsrc:(any) to element capsfilter0:(any)
0:00:00.334289161  5968   01D94000 INFO                GST_PADS gstutils.c:936:gst_pad_check_link: trying to link testsrc:src and capsfilter0:sink
0:00:00.334367972  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<capsfilter0:src> pad has no peer
0:00:00.334434278  5968   01D94000 INFO                GST_PADS gstutils.c:1443:prepare_link_maybe_ghosting: testsrc and capsfilter0 in same bin, no need for ghost pads
0:00:00.334498312  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link testsrc:src and capsfilter0:sink
0:00:00.334565376  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<capsfilter0:src> pad has no peer
0:00:00.334626757  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked testsrc:src and capsfilter0:sink, successful
0:00:00.334685865  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.334743836  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<testsrc:src> Received event on flushing pad. Discarding
0:00:00.334835150  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link capsfilter0:src and src:proxypad4
0:00:00.334899941  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked capsfilter0:src and src:proxypad4, successful
0:00:00.334958291  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.335016641  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<capsfilter0:src> Received event on flushing pad. Discarding
0:00:00.335079538  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<bin0> adding pad 'src'
0:00:00.335250420  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "gnlsource"
0:00:00.335338703  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "audiotestsrc"
0:00:00.335419408  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseSrc@07538D28> adding pad 'src'
0:00:00.335544443  5968   01D94000 INFO               gnlobject gnlobject.c:463:gnl_object_commit_func:<gnlsource0> Commiting object changed
0:00:00.335611129  5968   01D94000 INFO               gnlobject gnlobject.c:473:gnl_object_commit_func:<gnlsource0> Done commiting
0:00:00.335670237  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:2007:update_start_stop_duration:<gnlcomposition1> RE-setting all expandables duration and commit
0:00:00.335736543  5968   01D94000 INFO               gnlobject gnlobject.c:463:gnl_object_commit_func:<mixing-operation> Commiting object changed
0:00:00.335796788  5968   01D94000 INFO               gnlobject gnlobject.c:473:gnl_object_commit_func:<mixing-operation> Done commiting
0:00:00.335869536  5968   01D94000 INFO            gnloperation gnloperation.c:797:gnl_operation_update_base_time:<mixing-operation> Setting next_basetime to 0:00:00.000000000
0:00:00.335967670  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<smart-mixer-mixer> adding pad 'sink_0'
0:00:00.336037008  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "bin"
0:00:00.336112408  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "videoconvert"
0:00:00.336191976  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@074A7D10> adding pad 'sink'
0:00:00.336268134  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@074A7D10> adding pad 'src'
0:00:00.336342777  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad videoconvert0:sink
0:00:00.336427270  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link ghostpad0:proxypad5 and videoconvert0:sink
0:00:00.336493577  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked ghostpad0:proxypad5 and videoconvert0:sink, successful
0:00:00.336551548  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.336615582  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<bin1> adding pad 'ghostpad0'
0:00:00.336703485  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link ghostpad1:proxypad6 and bin1:ghostpad0
0:00:00.336767898  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked ghostpad1:proxypad6 and bin1:ghostpad0, successful
0:00:00.336826248  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.336889144  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<gessmartmixer0> adding pad 'ghostpad1'
0:00:00.336949389  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad videoconvert0:src
0:00:00.337033504  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link videoconvert0:src and ghostpad2:proxypad7
0:00:00.337097158  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked videoconvert0:src and ghostpad2:proxypad7, successful
0:00:00.337155508  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.337213858  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<videoconvert0:src> Received event on flushing pad. Discarding
0:00:00.337279028  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<bin1> adding pad 'ghostpad2'
0:00:00.337343062  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link bin1:ghostpad2 and smart-mixer-mixer:sink_0
0:00:00.337413157  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<gessmartmixer0:ghostpad1> pad has no peer
0:00:00.338203913  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked bin1:ghostpad2 and smart-mixer-mixer:sink_0, successful
0:00:00.338268704  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.338330085  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<videoconvert0:src> Received event on flushing pad. Discarding
0:00:00.338420262  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link ghostpad1:proxypad8 and gessmartmixer0:ghostpad1
0:00:00.338485432  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked ghostpad1:proxypad8 and gessmartmixer0:ghostpad1, successful
0:00:00.338543403  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.338606300  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<mixing-operation> adding pad 'ghostpad1'
0:00:00.338673744  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:467:wait_no_more_pads:<gnlsource0> no existing pad, connecting to 'no-more-pads'
0:00:00.338736640  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition1> the number of waiting pads is now 1
0:00:00.338803326  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartmixer0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.338870391  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-mixer-mixer> current NULL pending VOID_PENDING, desired next NULL
0:00:00.338932529  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-mixer-mixer> skipping transition from NULL to  NULL
0:00:00.338993153  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'smart-mixer-mixer' changed state to 1(NULL) successfully
0:00:00.339054913  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin1> current NULL pending VOID_PENDING, desired next NULL
0:00:00.339118946  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<videoconvert0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.339179570  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<videoconvert0> skipping transition from NULL to  NULL
0:00:00.339237919  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin1> child 'videoconvert0' changed state to 1(NULL) successfully
0:00:00.339299301  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin1> completed state change to NULL
0:00:00.339358408  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'bin1' changed state to 1(NULL) successfully
0:00:00.339420168  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartmixer0> completed state change to NULL
0:00:00.339479655  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartmixer0' changed state to 1(NULL) successfully
0:00:00.339541415  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to NULL
0:00:00.339603554  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.339667966  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.339728968  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<capsfilter0> skipping transition from NULL to  NULL
0:00:00.339787318  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'capsfilter0' changed state to 1(NULL) successfully
0:00:00.339847942  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<testsrc> current NULL pending VOID_PENDING, desired next NULL
0:00:00.339908944  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<testsrc> skipping transition from NULL to  NULL
0:00:00.339966915  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'testsrc' changed state to 1(NULL) successfully
0:00:00.340027917  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin0> completed state change to NULL
0:00:00.340086646  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource0> child 'bin0' changed state to 1(NULL) successfully
0:00:00.340148785  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource0> completed state change to NULL
0:00:00.340208651  5968   01D94000 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.340288598  5968   01D94000 INFO               gnlobject gnlobject.c:463:gnl_object_commit_func:<gnlsource1> Commiting object changed
0:00:00.340350736  5968   01D94000 INFO               gnlobject gnlobject.c:473:gnl_object_commit_func:<gnlsource1> Done commiting
0:00:00.340409086  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:2007:update_start_stop_duration:<gnlcomposition0> RE-setting all expandables duration and commit
0:00:00.340477667  5968   01D94000 INFO               gnlobject gnlobject.c:463:gnl_object_commit_func:<mixing-operation> Commiting object changed
0:00:00.340537532  5968   01D94000 INFO               gnlobject gnlobject.c:473:gnl_object_commit_func:<mixing-operation> Done commiting
0:00:00.340613311  5968   01D94000 INFO            gnloperation gnloperation.c:797:gnl_operation_update_base_time:<mixing-operation> Setting next_basetime to 0:00:00.000000000
0:00:00.340710687  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<smart-adder-adder> adding pad 'sink_0'
0:00:00.340778889  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "bin"
0:00:00.340855805  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "audioconvert"
0:00:00.340935752  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@074A8030> adding pad 'sink'
0:00:00.341010773  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@074A8030> adding pad 'src'
0:00:00.341080111  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "audioresample"
0:00:00.341157027  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@074A84F0> adding pad 'sink'
0:00:00.341232048  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstBaseTransform@074A84F0> adding pad 'src'
0:00:00.341309343  5968   01D94000 INFO        GST_ELEMENT_PADS gstutils.c:1543:gst_element_link_pads_full: trying to link element audioconvert0:(any) to element audioresample0:(any)
0:00:00.341374134  5968   01D94000 INFO                GST_PADS gstutils.c:936:gst_pad_check_link: trying to link audioconvert0:src and audioresample0:sink
0:00:00.341438925  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<audioconvert0:sink> pad has no peer
0:00:00.341510158  5968   01D94000 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ], layout=(string)interleaved;
0:00:00.341609807  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<audioresample0:src> pad has no peer
0:00:00.341704910  5968   01D94000 INFO                GST_PADS gstutils.c:1443:prepare_link_maybe_ghosting: audioconvert0 and audioresample0 in same bin, no need for ghost pads
0:00:00.341770459  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link audioconvert0:src and audioresample0:sink
0:00:00.341834871  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<audioconvert0:sink> pad has no peer
0:00:00.341909135  5968   01D94000 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ], layout=(string)interleaved;
0:00:00.342003859  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<audioresample0:src> pad has no peer
0:00:00.342094415  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked audioconvert0:src and audioresample0:sink, successful
0:00:00.342156554  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.342214525  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<audioconvert0:src> Received event on flushing pad. Discarding
0:00:00.342277043  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad audioconvert0:sink
0:00:00.342363052  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link ghostpad3:proxypad9 and audioconvert0:sink
0:00:00.342428980  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked ghostpad3:proxypad9 and audioconvert0:sink, successful
0:00:00.342486951  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.342549469  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<bin2> adding pad 'ghostpad3'
0:00:00.342639646  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link ghostpad4:proxypad10 and bin2:ghostpad3
0:00:00.342704058  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked ghostpad4:proxypad10 and bin2:ghostpad3, successful
0:00:00.342761650  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.342824547  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<gessmartadder0> adding pad 'ghostpad4'
0:00:00.342894264  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad audioresample0:src
0:00:00.342978758  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link audioresample0:src and ghostpad5:proxypad11
0:00:00.343042033  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked audioresample0:src and ghostpad5:proxypad11, successful
0:00:00.343100004  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.343157597  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<audioresample0:src> Received event on flushing pad. Discarding
0:00:00.343222009  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<bin2> adding pad 'ghostpad5'
0:00:00.343285663  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link bin2:ghostpad5 and smart-adder-adder:sink_0
0:00:00.343361821  5968   01D94000 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<mixing-operation:src> pad has no peer
0:00:00.343430780  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked bin2:ghostpad5 and smart-adder-adder:sink_0, successful
0:00:00.343491025  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.343551648  5968   01D94000 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<audioresample0:src> Received event on flushing pad. Discarding
0:00:00.343639931  5968   01D94000 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link ghostpad4:proxypad12 and gessmartadder0:ghostpad4
0:00:00.343704722  5968   01D94000 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked ghostpad4:proxypad12 and gessmartadder0:ghostpad4, successful
0:00:00.343763451  5968   01D94000 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.343826348  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<mixing-operation> adding pad 'ghostpad4'
0:00:00.343894928  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:467:wait_no_more_pads:<gnlsource1> no existing pad, connecting to 'no-more-pads'
0:00:00.343957446  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition0> the number of waiting pads is now 1
0:00:00.344022237  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.344088165  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current NULL pending VOID_PENDING, desired next NULL
0:00:00.344149167  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-adder-adder> skipping transition from NULL to  NULL
0:00:00.344210927  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 1(NULL) successfully
0:00:00.344272687  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current NULL pending VOID_PENDING, desired next NULL
0:00:00.344337099  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.344398480  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioresample0> skipping transition from NULL to  NULL
0:00:00.344457588  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 1(NULL) successfully
0:00:00.344518969  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.344579214  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioconvert0> skipping transition from NULL to  NULL
0:00:00.344637943  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 1(NULL) successfully
0:00:00.344699703  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to NULL
0:00:00.344759189  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 1(NULL) successfully
0:00:00.344820570  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to NULL
0:00:00.344881573  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 1(NULL) successfully
0:00:00.344943333  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to NULL
0:00:00.345006229  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.345067231  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audiotestsrc0> skipping transition from NULL to  NULL
0:00:00.345126339  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 1(NULL) successfully
0:00:00.345187720  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to NULL
0:00:00.345245691  5968   01D94000 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.345428698  5968   01D94000 INFO                     ges ges-pipeline.c:296:ges_pipeline_init:<GESPipeline@0A1DD048> Creating new 'playsink'
0:00:00.345494247  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "playsink" named "internal-sinks"
0:00:00.345584045  5968   01D94000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "encodebin" named "internal-encodebin"
0:00:00.346222485  5968   01D94000 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstEncodeBin@0A1DC1A0> adding pad 'src'
0:00:00.346306600  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<GESPipeline@0A1DD048> completed state change to NULL
0:00:00.346407386  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesaudiotrack0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.346477861  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.346543410  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource1> current NULL pending VOID_PENDING, desired next NULL
0:00:00.346607064  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.346667308  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audiotestsrc0> skipping transition from NULL to  NULL
0:00:00.346726037  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 1(NULL) successfully
0:00:00.346788176  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to NULL
0:00:00.346847663  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'gnlsource1' changed state to 1(NULL) successfully
0:00:00.346909423  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current NULL pending VOID_PENDING, desired next NULL
0:00:00.346974214  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.347039763  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current NULL pending VOID_PENDING, desired next NULL
0:00:00.347100765  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-adder-adder> skipping transition from NULL to  NULL
0:00:00.347159494  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 1(NULL) successfully
0:00:00.347220875  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current NULL pending VOID_PENDING, desired next NULL
0:00:00.347286424  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.347347426  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioresample0> skipping transition from NULL to  NULL
0:00:00.347406155  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 1(NULL) successfully
0:00:00.347467915  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.347527781  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioconvert0> skipping transition from NULL to  NULL
0:00:00.347586510  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 1(NULL) successfully
0:00:00.347648270  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to NULL
0:00:00.347707756  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 1(NULL) successfully
0:00:00.347769895  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to NULL
0:00:00.347829003  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 1(NULL) successfully
0:00:00.347891142  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to NULL
0:00:00.347990413  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 1(NULL) successfully
0:00:00.348054825  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition0> completed state change to NULL
0:00:00.348113933  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesaudiotrack0> child 'gnlcomposition0' changed state to 1(NULL) successfully
0:00:00.348175693  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesaudiotrack0> completed state change to NULL
0:00:00.348234800  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesaudiotrack0' changed state to 1(NULL) successfully
0:00:00.348296182  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesvideotrack0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.348359457  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition1> current NULL pending VOID_PENDING, desired next NULL
0:00:00.348423491  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.348486387  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.348551178  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.348611044  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<capsfilter0> skipping transition from NULL to  NULL
0:00:00.348669015  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'capsfilter0' changed state to 1(NULL) successfully
0:00:00.348729638  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<testsrc> current NULL pending VOID_PENDING, desired next NULL
0:00:00.348788746  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<testsrc> skipping transition from NULL to  NULL
0:00:00.348846338  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'testsrc' changed state to 1(NULL) successfully
0:00:00.348909614  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin0> completed state change to NULL
0:00:00.348967964  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource0> child 'bin0' changed state to 1(NULL) successfully
0:00:00.349028966  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource0> completed state change to NULL
0:00:00.349087695  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'gnlsource0' changed state to 1(NULL) successfully
0:00:00.349149455  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current NULL pending VOID_PENDING, desired next NULL
0:00:00.349213867  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartmixer0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.349279416  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-mixer-mixer> current NULL pending VOID_PENDING, desired next NULL
0:00:00.349340039  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-mixer-mixer> skipping transition from NULL to  NULL
0:00:00.349398011  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'smart-mixer-mixer' changed state to 1(NULL) successfully
0:00:00.349460907  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin1> current NULL pending VOID_PENDING, desired next NULL
0:00:00.349525320  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<videoconvert0> current NULL pending VOID_PENDING, desired next NULL
0:00:00.349585185  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<videoconvert0> skipping transition from NULL to  NULL
0:00:00.349643535  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin1> child 'videoconvert0' changed state to 1(NULL) successfully
0:00:00.349704537  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin1> completed state change to NULL
0:00:00.349763266  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'bin1' changed state to 1(NULL) successfully
0:00:00.349823889  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartmixer0> completed state change to NULL
0:00:00.349882997  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartmixer0' changed state to 1(NULL) successfully
0:00:00.349944378  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to NULL
0:00:00.350002728  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'mixing-operation' changed state to 1(NULL) successfully
0:00:00.350064109  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition1> completed state change to NULL
0:00:00.350123217  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesvideotrack0> child 'gnlcomposition1' changed state to 1(NULL) successfully
0:00:00.350184219  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesvideotrack0> completed state change to NULL
0:00:00.350242948  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesvideotrack0' changed state to 1(NULL) successfully
0:00:00.350303950  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gestimeline0> completed state change to NULL
0:00:00.350367226  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<internal-sinks> current NULL pending VOID_PENDING, desired next READY
0:00:00.350432017  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<streamsynchronizer0> current NULL pending VOID_PENDING, desired next READY
0:00:00.350493777  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<streamsynchronizer0> completed state change to READY
0:00:00.350552127  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<streamsynchronizer0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.350621465  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<internal-sinks> child 'streamsynchronizer0' changed state to 2(READY) successfully
0:00:00.350684741  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<internal-sinks> completed state change to READY
0:00:00.350743470  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<internal-sinks> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.350805608  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gespipeline0> child 'internal-sinks' changed state to 2(READY) successfully
0:00:00.350867368  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gestimeline0> current NULL pending VOID_PENDING, desired next READY
0:00:00.350935191  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesaudiotrack0> current NULL pending VOID_PENDING, desired next READY
0:00:00.351000361  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition0> current NULL pending VOID_PENDING, desired next READY
0:00:00.351133732  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource1> current NULL pending VOID_PENDING, desired next READY
0:00:00.351203070  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current NULL pending VOID_PENDING, desired next READY
0:00:00.351265209  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<audiotestsrc0> completed state change to READY
0:00:00.351323559  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audiotestsrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.351388729  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 2(READY) successfully
0:00:00.351452762  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to READY
0:00:00.351511491  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlsource1> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.351534225  5968   07422CB0 INFO          gnlcomposition gnlcomposition.c:1760:update_pipeline_func:<gnlcomposition0> waiting for EOS from thread 07422CB0
0:00:00.351576661  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'gnlsource1' changed state to 2(READY) successfully
0:00:00.351706623  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current NULL pending VOID_PENDING, desired next READY
0:00:00.351771035  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current NULL pending VOID_PENDING, desired next READY
0:00:00.351836205  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current NULL pending VOID_PENDING, desired next READY
0:00:00.351899860  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<smart-adder-adder> completed state change to READY
0:00:00.351958588  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<smart-adder-adder> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.352022622  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 2(READY) successfully
0:00:00.352085518  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current NULL pending VOID_PENDING, desired next READY
0:00:00.352150310  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current NULL pending VOID_PENDING, desired next READY
0:00:00.352211312  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<audioresample0> completed state change to READY
0:00:00.352269283  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audioresample0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.352333316  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 2(READY) successfully
0:00:00.352396213  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current NULL pending VOID_PENDING, desired next READY
0:00:00.352459489  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<audioconvert0> completed state change to READY
0:00:00.352518596  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audioconvert0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.352582630  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 2(READY) successfully
0:00:00.352645148  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to READY
0:00:00.352703119  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<bin2> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.352766773  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 2(READY) successfully
0:00:00.352829291  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to READY
0:00:00.352896734  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gessmartadder0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.352961147  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 2(READY) successfully
0:00:00.353024422  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to READY
0:00:00.353083530  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<mixing-operation> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.353146806  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 2(READY) successfully
0:00:00.353209702  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition0> completed state change to READY
0:00:00.353268431  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlcomposition0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.353332086  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesaudiotrack0> child 'gnlcomposition0' changed state to 2(READY) successfully
0:00:00.353394225  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesaudiotrack0> completed state change to READY
0:00:00.353452575  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gesaudiotrack0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.353515092  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesaudiotrack0' changed state to 2(READY) successfully
0:00:00.353577989  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesvideotrack0> current NULL pending VOID_PENDING, desired next READY
0:00:00.353642780  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition1> current NULL pending VOID_PENDING, desired next READY
0:00:00.353750766  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource0> current NULL pending VOID_PENDING, desired next READY
0:00:00.353823135  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin0> current NULL pending VOID_PENDING, desired next READY
0:00:00.353912175  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next READY
0:00:00.353971662  5968   07422D78 INFO          gnlcomposition gnlcomposition.c:1760:update_pipeline_func:<gnlcomposition1> waiting for EOS from thread 07422D78
0:00:00.353974693  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<capsfilter0> completed state change to READY
0:00:00.354099350  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.354160731  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'capsfilter0' changed state to 2(READY) successfully
0:00:00.354219460  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<testsrc> current NULL pending VOID_PENDING, desired next READY
0:00:00.354276294  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<testsrc> completed state change to READY
0:00:00.354330855  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<testsrc> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.354391099  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'testsrc' changed state to 2(READY) successfully
0:00:00.354449071  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin0> completed state change to READY
0:00:00.354503253  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<bin0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.354562739  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource0> child 'bin0' changed state to 2(READY) successfully
0:00:00.354621089  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource0> completed state change to READY
0:00:00.354675271  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlsource0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.354735137  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'gnlsource0' changed state to 2(READY) successfully
0:00:00.354793108  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current NULL pending VOID_PENDING, desired next READY
0:00:00.354854110  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartmixer0> current NULL pending VOID_PENDING, desired next READY
0:00:00.354918144  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-mixer-mixer> current NULL pending VOID_PENDING, desired next READY
0:00:00.354975357  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<smart-mixer-mixer> completed state change to READY
0:00:00.355029160  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<smart-mixer-mixer> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.355088647  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'smart-mixer-mixer' changed state to 2(READY) successfully
0:00:00.355146618  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin1> current NULL pending VOID_PENDING, desired next READY
0:00:00.355206483  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<videoconvert0> current NULL pending VOID_PENDING, desired next READY
0:00:00.355262939  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<videoconvert0> completed state change to READY
0:00:00.355316363  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<videoconvert0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.355379260  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin1> child 'videoconvert0' changed state to 2(READY) successfully
0:00:00.355437231  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin1> completed state change to READY
0:00:00.355491034  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<bin1> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.355550521  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'bin1' changed state to 2(READY) successfully
0:00:00.355608492  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartmixer0> completed state change to READY
0:00:00.355662295  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gessmartmixer0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.355721024  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartmixer0' changed state to 2(READY) successfully
0:00:00.355779374  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to READY
0:00:00.355833177  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<mixing-operation> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.355894179  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'mixing-operation' changed state to 2(READY) successfully
0:00:00.355953287  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition1> completed state change to READY
0:00:00.356007469  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlcomposition1> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.356066198  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesvideotrack0> child 'gnlcomposition1' changed state to 2(READY) successfully
0:00:00.356124548  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesvideotrack0> completed state change to READY
0:00:00.356178351  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gesvideotrack0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.356236322  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesvideotrack0' changed state to 2(READY) successfully
0:00:00.356293914  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gestimeline0> completed state change to READY
0:00:00.356348096  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gestimeline0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.356406067  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gespipeline0> child 'gestimeline0' changed state to 2(READY) successfully
0:00:00.356463660  5968   01D94000 INFO              GST_STATES gstelement.c:2306:gst_element_continue_state:<gespipeline0> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:00.356519357  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gespipeline0> notifying about state-changed NULL to READY (PLAYING pending)
0:00:00.356576570  5968   01D94000 INFO              GST_STATES gstelement.c:2313:gst_element_continue_state:<gespipeline0> continue state change READY to PAUSED, final PLAYING
0:00:00.356639467  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<internal-sinks> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.356697817  5968   01D94000 INFO                playsink gstplaysink.c:1279:do_async_start:<internal-sinks> Sending async_start message
0:00:00.356759198  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<streamsynchronizer0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.356818685  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<streamsynchronizer0> completed state change to PAUSED
0:00:00.356874004  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<streamsynchronizer0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.356933111  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<internal-sinks> child 'streamsynchronizer0' changed state to 3(PAUSED) successfully
0:00:00.356992598  5968   01D94000 INFO              GST_STATES gstbin.c:2636:gst_bin_change_state_func:<gespipeline0> child 'internal-sinks' is changing state asynchronously to PAUSED
0:00:00.357050190  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gestimeline0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.357110056  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesaudiotrack0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.357169542  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.357230166  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:473:wait_no_more_pads:<gnlsource1> disconnecting from 'no-more-pads'
0:00:00.357286242  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition0> the number of waiting pads is now 0
0:00:00.357350276  5968   01D94000 INFO            gnloperation gnloperation.c:797:gnl_operation_update_base_time:<mixing-operation> Setting next_basetime to 0:00:00.000000000
0:00:00.357417719  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:467:wait_no_more_pads:<gnlsource1> no existing pad, connecting to 'no-more-pads'
0:00:00.357475690  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition0> the number of waiting pads is now 1
0:00:00.357529872  5968   01D94000 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.357599589  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource1> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.357662865  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.357726140  5968   01D94000 INFO                 basesrc gstbasesrc.c:1293:gst_base_src_do_seek:<audiotestsrc0> seeking: 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.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.357817833  5968   01D94000 INFO                    task gsttask.c:431:gst_task_set_lock: setting stream lock 0752D6CC on task 0A1DF008
0:00:00.357877699  5968   01D94000 INFO                GST_PADS gstpad.c:5365:gst_pad_start_task:<audiotestsrc0:src> created task 0A1DF008
0:00:00.357988715  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<audiotestsrc0> completed state change to PAUSED
0:00:00.358050475  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audiotestsrc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.358113751  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 3(PAUSED) successfully
0:00:00.358174753  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to PAUSED
0:00:00.358233103  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlsource1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.358238407  5968   07422BC0 INFO        GST_ELEMENT_PADS gstelement.c:897:gst_element_get_static_pad: no such pad 'sink' in element "audiotestsrc0"
0:00:00.358294863  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'gnlsource1' changed state to 3(PAUSED) successfully
0:00:00.358369884  5968   07422BC0 FIXME                default gstutils.c:3649:gst_pad_create_stream_id_printf_valist:<audiotestsrc0:src> Creating random stream-id, consider implementing a deterministic way of creating a stream-id
0:00:00.358424445  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.358547586  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.358613135  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.358675653  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<smart-adder-adder> completed state change to PAUSED
0:00:00.358731351  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<smart-adder-adder> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.358791974  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 3(PAUSED) successfully
0:00:00.358800689  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link audiotestsrc0:src and src:proxypad14
0:00:00.358851840  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.358919283  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked audiotestsrc0:src and src:proxypad14, successful
0:00:00.359037499  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.358982938  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.359105700  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<gnlsource1> adding pad 'src'
0:00:00.359159124  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<audioresample0> completed state change to PAUSED
0:00:00.359225052  5968   0A1E2008 INFO          gnlcomposition gnlcomposition.c:473:wait_no_more_pads:<gnlsource1> disconnecting from 'no-more-pads'
0:00:00.359273172  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audioresample0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.359334174  5968   0A1E2008 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition0> the number of waiting pads is now 0
0:00:00.359394797  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 3(PAUSED) successfully
0:00:00.359454663  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link gnlsource1:src and mixing-operation:ghostpad4
0:00:00.359509603  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.359572879  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked gnlsource1:src and mixing-operation:ghostpad4, successful
0:00:00.359690336  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.359634639  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<audioconvert0> completed state change to PAUSED
0:00:00.359762326  5968   0A1E2008 INFO          gnlcomposition gnlcomposition.c:2115:no_more_pads_object_cb:<gnlcomposition0> Sending pending seek on mixing-operation:src
0:00:00.359805142  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audioconvert0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.359819540  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2 ];
0:00:00.359869554  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.359932451  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 3(PAUSED) successfully
0:00:00.360080599  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<mixing-operation:src> pad has no peer
0:00:00.360143874  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to PAUSED
0:00:00.360256407  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)[ 1, 2147483647 ], channels=(int)[ 1, 2147483647 ];
0:00:00.360216622  5968   0A1E2008 INFO                 default gstsegment.c:370:gst_segment_do_seek: segment updated: time segment start=0:00:00.000000000, stop=0:00:01.000000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.360258680  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<bin2> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.360417437  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.360423121  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.360476166  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 3(PAUSED) successfully
0:00:00.360546641  5968   07422BC0 INFO               GST_EVENT gstevent.c:629:gst_event_new_caps: creating caps event audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1
0:00:00.360625072  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.360695168  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to PAUSED
0:00:00.360786103  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.360848242  5968   0A1E2008 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<smart-adder-adder:sink_0> Received event on flushing pad. Discarding
0:00:00.360900908  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gessmartadder0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.361057013  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<mixing-operation:src> pad has no peer
0:00:00.361109301  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 3(PAUSED) successfully
0:00:00.361229411  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.361242293  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ];
0:00:00.361290413  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<mixing-operation> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.361393094  5968   07422BC0 WARN                GST_PADS gstpad.c:3620:gst_pad_peer_query:<audiotestsrc0:src> could not send sticky events
0:00:00.361426058  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.361492365  5968   07422BC0 INFO                    task gsttask.c:300:gst_task_func:<audiotestsrc0:src> Task going to paused
0:00:00.361492744  5968   0A1E2008 INFO                 default gstsegment.c:370:gst_segment_do_seek: segment updated: time segment start=0:00:00.000000000, stop=0:00:01.000000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.361546926  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.361681055  5968   0A1E2008 INFO                 basesrc gstbasesrc.c:1293:gst_base_src_do_seek:<audiotestsrc0> seeking: time segment start=0:00:00.000000000, stop=0:00:01.000000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.361747740  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.361820867  5968   0A1E2008 INFO               GST_EVENT gstevent.c:497:gst_event_new_flush_stop: creating flush stop 1
0:00:00.361892479  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.361976594  5968   07422BC0 INFO                    task gsttask.c:302:gst_task_func:<audiotestsrc0:src> Task resume from paused
0:00:00.362008042  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link mixing-operation:src and src:proxypad15
0:00:00.362008800  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-adder-adder> skipping transition from PAUSED to  PAUSED
0:00:00.362142929  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked mixing-operation:src and src:proxypad15, successful
0:00:00.362263797  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.362203173  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 3(PAUSED) successfully
0:00:00.362151264  5968   07422BC0 INFO               GST_EVENT gstevent.c:710:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, stop=0:00:01.000000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.362347533  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<gnlcomposition0> adding pad 'src'
0:00:00.362385043  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.362491134  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.362560472  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link gnlcomposition0:src and src:proxypad16
0:00:00.362595330  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.362730975  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked gnlcomposition0:src and src:proxypad16, successful
0:00:00.362850706  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.362791219  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioresample0> skipping transition from PAUSED to  PAUSED
0:00:00.362754845  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<'':src> pad has no peer
0:00:00.362971953  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 3(PAUSED) successfully
0:00:00.363043943  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<gesaudiotrack0> adding pad 'src'
0:00:00.363096610  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.363122753  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ];
0:00:00.363161022  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2226:pad_added_cb:<gestimeline0> Getting dynamic lock from 0A1E2008
0:00:00.363214825  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioconvert0> skipping transition from PAUSED to  PAUSED
0:00:00.363320916  5968   07422BC0 INFO               GST_EVENT gstevent.c:710:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, stop=0:00:01.000000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.363352364  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2226:pad_added_cb:<gestimeline0> Got Dynamic lock from 0A1E2008
0:00:00.363407683  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 3(PAUSED) successfully
0:00:00.363510743  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.363578944  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link gesaudiotrack0:src and track_07529068_src:proxypad17
0:00:00.363611150  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to PAUSED
0:00:00.363749826  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked gesaudiotrack0:src and track_07529068_src:proxypad17, successful
0:00:00.363869178  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.363808176  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 3(PAUSED) successfully
0:00:00.363768392  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<'':track_07529068_src> pad has no peer
0:00:00.363988530  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to PAUSED
0:00:00.364057110  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<gestimeline0> adding pad 'track_07529068_src'
0:00:00.364106367  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 3(PAUSED) successfully
0:00:00.364133647  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ];
0:00:00.364211700  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2727:ges_timeline_get_track_for_pad:<gestimeline0> Getting dynamic lock from 0A1E2008
0:00:00.364229887  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.364368942  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2727:ges_timeline_get_track_for_pad:<gestimeline0> Got Dynamic lock from 0A1E2008
0:00:00.364425018  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.364442826  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.364486020  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2731:ges_timeline_get_track_for_pad:<gestimeline0> Unlocking dynamic lock from 0A1E2008
0:00:00.364545886  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.364676226  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2731:ges_timeline_get_track_for_pad:<gestimeline0> Unlocked Dynamic lock from 0A1E2008
0:00:00.364700097  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<gestimeline0:track_07529068_src> pad has no peer
0:00:00.364739881  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.364796336  5968   0A1E2008 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:365:gst_element_factory_create: creating element "tee"
0:00:00.364922130  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.364942590  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ];
0:00:00.365007760  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstTee@0A1E4078> adding pad 'sink'
0:00:00.365034662  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-adder-adder> skipping transition from PAUSED to  PAUSED
0:00:00.365147951  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.365192661  5968   0A1E2008 INFO              GST_STATES gstelement.c:2306:gst_element_continue_state:<tee0> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:00.365232066  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 3(PAUSED) successfully
0:00:00.365372637  5968   0A1E2008 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<tee0> notifying about state-changed NULL to READY (PLAYING pending)
0:00:00.365391960  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<gestimeline0:track_07529068_src> pad has no peer
0:00:00.365432881  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.365495020  5968   0A1E2008 INFO              GST_STATES gstelement.c:2313:gst_element_continue_state:<tee0> continue state change READY to PAUSED, final PLAYING
0:00:00.365617403  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.365637485  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ];
0:00:00.365678406  5968   0A1E2008 INFO              GST_STATES gstelement.c:2306:gst_element_continue_state:<tee0> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:00.365731830  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioresample0> skipping transition from PAUSED to  PAUSED
0:00:00.365847393  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.365874674  5968   0A1E2008 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<tee0> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:00.365932266  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 3(PAUSED) successfully
0:00:00.366075488  5968   0A1E2008 INFO              GST_STATES gstelement.c:2313:gst_element_continue_state:<tee0> continue state change PAUSED to PLAYING, final PLAYING
0:00:00.366095570  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<gestimeline0:track_07529068_src> pad has no peer
0:00:00.366129670  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.366189915  5968   0A1E2008 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<tee0> completed state change to PLAYING
0:00:00.366308888  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioconvert0> skipping transition from PAUSED to  PAUSED
0:00:00.366334274  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ];
0:00:00.366369890  5968   0A1E2008 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<tee0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.366425209  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 3(PAUSED) successfully
0:00:00.366521449  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.366564643  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad tee0:sink
0:00:00.366622235  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to PAUSED
0:00:00.366757501  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link gestimeline0:track_07529068_src and tee0:sink
0:00:00.366778340  5968   07422BC0 INFO                GST_PADS gstpad.c:3626:gst_pad_peer_query:<gestimeline0:track_07529068_src> pad has no peer
0:00:00.366812441  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 3(PAUSED) successfully
0:00:00.366940507  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked gestimeline0:track_07529068_src and tee0:sink, successful
0:00:00.367056071  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.366997342  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to PAUSED
0:00:00.367115936  5968   07422BC0 INFO           basetransform gstbasetransform.c:1315:gst_base_transform_setcaps:<audioconvert0> reuse caps
0:00:00.367137912  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:897:gst_element_get_static_pad: no such pad 'audio_sink' in element "internal-sinks"
0:00:00.367172013  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 3(PAUSED) successfully
0:00:00.367239456  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.367304247  5968   0A1E2008 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "tee" named "audiotee"
0:00:00.367361461  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.367432693  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.367522113  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<GstTee@0A1E4160> adding pad 'sink'
0:00:00.367549772  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.367620247  5968   07422BC0 INFO            audioconvert audioconvert.c:620:audio_convert_prepare_context: depth in 32, out 32
0:00:00.367800980  5968   07422BC0 INFO            audioconvert audioconvert.c:634:audio_convert_prepare_context: using no dither and noise shaping
0:00:00.367742251  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource1> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.367691100  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:900:gst_element_get_static_pad: found pad audiotee:sink
0:00:00.367869560  5968   07422BC0 INFO            audioconvert audioconvert.c:650:audio_convert_prepare_context: func index in 13, out 13
0:00:00.368044989  5968   07422BC0 INFO            audioconvert audioconvert.c:655:audio_convert_prepare_context: use int mixing
0:00:00.368102202  5968   07422BC0 INFO            audioconvert audioconvert.c:661:audio_convert_prepare_context: unitsizes: 4 -> 4
0:00:00.368162446  5968   07422BC0 INFO            audioconvert audioconvert.c:671:audio_convert_prepare_context: in default 1, mix passthrough 1, out default 1
0:00:00.368223828  5968   07422BC0 INFO            audioconvert audioconvert.c:678:audio_convert_prepare_context: scale in 0, out 0
0:00:00.368283314  5968   07422BC0 INFO               GST_EVENT gstevent.c:629:gst_event_new_caps: creating caps event audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1
0:00:00.367991564  5968   0A1E2008 INFO              GST_STATES gstelement.c:2306:gst_element_continue_state:<audiotee> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.368417443  5968   0A1E2008 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audiotee> notifying about state-changed NULL to READY (PAUSED pending)
0:00:00.368485266  5968   0A1E2008 INFO              GST_STATES gstelement.c:2313:gst_element_continue_state:<audiotee> continue state change READY to PAUSED, final PAUSED
0:00:00.368550815  5968   0A1E2008 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<audiotee> completed state change to PAUSED
0:00:00.368534901  5968   07422BC0 INFO           basetransform gstbasetransform.c:1315:gst_base_transform_setcaps:<audioresample0> reuse caps
0:00:00.368680397  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.368612196  5968   0A1E2008 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<audiotee> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.368841807  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link audio_sink:proxypad18 and audiotee:sink
0:00:00.368751629  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.368980482  5968   07422BC0 INFO               GST_EVENT gstevent.c:629:gst_event_new_caps: creating caps event audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1
0:00:00.368908113  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked audio_sink:proxypad18 and audiotee:sink, successful
0:00:00.369108928  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.369105518  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.369177508  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<internal-sinks> adding pad 'audio_sink'
0:00:00.369327930  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<tee0> adding pad 'src_0'
0:00:00.369245331  5968   07422BC0 INFO                   adder gstadder.c:350:gst_adder_setcaps:<smart-adder-adder:sink_0> setting caps to audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1
0:00:00.369395752  5968   0A1E2008 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link tee0:src_0 and internal-sinks:audio_sink
0:00:00.369523819  5968   0A1E2008 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked tee0:src_0 and internal-sinks:audio_sink, successful
0:00:00.369583306  5968   0A1E2008 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.369461301  5968   07422BC0 INFO                   adder gstadder.c:357:gst_adder_setcaps:<smart-adder-adder:sink_0> handle caps change to audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1
0:00:00.369739032  5968   07422BC0 INFO             gnlghostpad gnlghostpad.c:287:translate_incoming_segment:<mixing-operation> Using operation base time 0:00:00.000000000
0:00:00.369804960  5968   07422BC0 INFO               GST_EVENT gstevent.c:710:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, stop=0:00:01.000000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.369911429  5968   07422BC0 INFO                 basesrc gstbasesrc.c:2764:gst_base_src_loop:<audiotestsrc0> marking pending DISCONT
0:00:00.369674999  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2258:pad_added_cb:<gestimeline0> Unlocking dynamic lock from 0A1E2008
0:00:00.370040633  5968   0A1E2008 INFO             gestimeline ges-timeline.c:2258:pad_added_cb:<gestimeline0> Unlocked Dynamic lock from 0A1E2008
0:00:00.369980767  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.367925258  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.370277822  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audiotestsrc0> skipping transition from PAUSED to  PAUSED
0:00:00.370332762  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 3(PAUSED) successfully
0:00:00.370394901  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to PAUSED
0:00:00.370414603  5968   07422BC0 INFO           basetransform gstbasetransform.c:1315:gst_base_transform_setcaps:<audioconvert0> reuse caps
0:00:00.370454766  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'gnlsource1' changed state to 3(PAUSED) successfully
0:00:00.370521073  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.370579802  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition0> completed state change to PAUSED
0:00:00.370646487  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.370707868  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlcomposition0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.370775312  5968   07422BC0 INFO            audioconvert audioconvert.c:620:audio_convert_prepare_context: depth in 32, out 32
0:00:00.370896937  5968   07422BC0 INFO            audioconvert audioconvert.c:634:audio_convert_prepare_context: using no dither and noise shaping
0:00:00.370840861  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesaudiotrack0> child 'gnlcomposition0' changed state to 3(PAUSED) successfully
0:00:00.370961729  5968   07422BC0 INFO            audioconvert audioconvert.c:650:audio_convert_prepare_context: func index in 13, out 13
0:00:00.371075397  5968   07422BC0 INFO            audioconvert audioconvert.c:655:audio_convert_prepare_context: use int mixing
0:00:00.371131095  5968   07422BC0 INFO            audioconvert audioconvert.c:661:audio_convert_prepare_context: unitsizes: 4 -> 4
0:00:00.371188687  5968   07422BC0 INFO            audioconvert audioconvert.c:671:audio_convert_prepare_context: in default 1, mix passthrough 1, out default 1
0:00:00.371275076  5968   07422BC0 INFO            audioconvert audioconvert.c:678:audio_convert_prepare_context: scale in 0, out 0
0:00:00.371335320  5968   07422BC0 INFO               GST_EVENT gstevent.c:629:gst_event_new_caps: creating caps event audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1
0:00:00.371018184  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.371479300  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.371539924  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.371570614  5968   07422BC0 INFO           basetransform gstbasetransform.c:1315:gst_base_transform_setcaps:<audioresample0> reuse caps
0:00:00.371603957  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.371666854  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.371722173  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-adder-adder> skipping transition from PAUSED to  PAUSED
0:00:00.371794163  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.371850618  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 3(PAUSED) successfully
0:00:00.371926018  5968   07422BC0 INFO               GST_EVENT gstevent.c:629:gst_event_new_caps: creating caps event audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1
0:00:00.371988536  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.372116603  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.372120392  5968   07422BC0 INFO               structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)S32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1;
0:00:00.372175711  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioresample0> skipping transition from PAUSED to  PAUSED
0:00:00.372270435  5968   07422BC0 INFO                   adder gstadder.c:1165:gst_adder_collected:<smart-adder-adder:src> send pending stream start event
0:00:00.372306809  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 3(PAUSED) successfully
0:00:00.372381830  5968   07422BC0 INFO             gestimeline ges-timeline.c:2194:_pad_probe_cb:<gestimeline0> Getting dynamic lock from 07422BC0
0:00:00.372428813  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.372488679  5968   07422BC0 INFO             gestimeline ges-timeline.c:2194:_pad_probe_cb:<gestimeline0> Got Dynamic lock from 07422BC0
0:00:00.372545513  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioconvert0> skipping transition from PAUSED to  PAUSED
0:00:00.372609168  5968   07422BC0 INFO             gestimeline ges-timeline.c:2203:_pad_probe_cb:<gestimeline0> Unlocking dynamic lock from 07422BC0
0:00:00.372663350  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 3(PAUSED) successfully
0:00:00.372726246  5968   07422BC0 INFO             gestimeline ges-timeline.c:2203:_pad_probe_cb:<gestimeline0> Unlocked Dynamic lock from 07422BC0
0:00:00.372785733  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to PAUSED
0:00:00.372906601  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 3(PAUSED) successfully
0:00:00.372963435  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to PAUSED
0:00:00.373017996  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 3(PAUSED) successfully
0:00:00.373074831  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.373129392  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.373186226  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource1> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.373245713  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.373301410  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audiotestsrc0> skipping transition from PAUSED to  PAUSED
0:00:00.373355971  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 3(PAUSED) successfully
0:00:00.373412806  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to PAUSED
0:00:00.373466988  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'gnlsource1' changed state to 3(PAUSED) successfully
0:00:00.373524201  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition0> completed state change to PAUSED
0:00:00.373579141  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesaudiotrack0> child 'gnlcomposition0' changed state to 3(PAUSED) successfully
0:00:00.373638249  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesaudiotrack0> completed state change to PAUSED
0:00:00.373692810  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gesaudiotrack0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.373751917  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesaudiotrack0' changed state to 3(PAUSED) successfully
0:00:00.373811025  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesaudiotrack0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.373870891  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.373931514  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.373991758  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.374053897  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.374111111  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-adder-adder> skipping transition from PAUSED to  PAUSED
0:00:00.374165672  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 3(PAUSED) successfully
0:00:00.374222885  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.374282750  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.374338827  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioresample0> skipping transition from PAUSED to  PAUSED
0:00:00.374392251  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 3(PAUSED) successfully
0:00:00.374449465  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.374504404  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioconvert0> skipping transition from PAUSED to  PAUSED
0:00:00.374558587  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 3(PAUSED) successfully
0:00:00.374615421  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to PAUSED
0:00:00.374669982  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 3(PAUSED) successfully
0:00:00.374729090  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to PAUSED
0:00:00.374788955  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 3(PAUSED) successfully
0:00:00.374851094  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.374910960  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.374972341  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource1> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.375036374  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.375096998  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audiotestsrc0> skipping transition from PAUSED to  PAUSED
0:00:00.375155726  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 3(PAUSED) successfully
0:00:00.375217486  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to PAUSED
0:00:00.375276594  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'gnlsource1' changed state to 3(PAUSED) successfully
0:00:00.375338733  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition0> completed state change to PAUSED
0:00:00.375398220  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesaudiotrack0> child 'gnlcomposition0' changed state to 3(PAUSED) successfully
0:00:00.375462632  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesaudiotrack0> completed state change to PAUSED
0:00:00.375521740  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesaudiotrack0' changed state to 3(PAUSED) successfully
0:00:00.375583121  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesvideotrack0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.375646775  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition1> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.375713082  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:473:wait_no_more_pads:<gnlsource0> disconnecting from 'no-more-pads'
0:00:00.375773705  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition1> the number of waiting pads is now 0
0:00:00.375841528  5968   01D94000 INFO            gnloperation gnloperation.c:797:gnl_operation_update_base_time:<mixing-operation> Setting next_basetime to 0:00:00.000000000
0:00:00.375929810  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:467:wait_no_more_pads:<gnlsource0> no existing pad, connecting to 'no-more-pads'
0:00:00.375993465  5968   01D94000 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition1> the number of waiting pads is now 1
0:00:00.376052952  5968   01D94000 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.376127594  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.376195795  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.376263997  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.376331061  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
0:00:00.376390169  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.376455339  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:00.376517857  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<testsrc> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.376583406  5968   01D94000 INFO                 basesrc gstbasesrc.c:1293:gst_base_src_do_seek:<testsrc> seeking: 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.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.376670173  5968   01D94000 INFO                    task gsttask.c:431:gst_task_set_lock: setting stream lock 0752D2F4 on task 0A1DF0B0
0:00:00.376733070  5968   01D94000 INFO                GST_PADS gstpad.c:5365:gst_pad_start_task:<testsrc:src> created task 0A1DF0B0
0:00:00.376842192  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<testsrc> completed state change to PAUSED
0:00:00.376911151  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<testsrc> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.376977078  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'testsrc' changed state to 3(PAUSED) successfully
0:00:00.377046038  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin0> completed state change to PAUSED
0:00:00.377109692  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<bin0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.377114997  5968   0A1E2008 INFO        GST_ELEMENT_PADS gstelement.c:897:gst_element_get_static_pad: no such pad 'sink' in element "testsrc"
0:00:00.377176757  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource0> child 'bin0' changed state to 3(PAUSED) successfully
0:00:00.377244200  5968   0A1E2008 FIXME                default gstutils.c:3649:gst_pad_create_stream_id_printf_valist:<testsrc:src> Creating random stream-id, consider implementing a deterministic way of creating a stream-id
0:00:00.377305960  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource0> completed state change to PAUSED
0:00:00.377438952  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlsource0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.377506396  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'gnlsource0' changed state to 3(PAUSED) successfully
0:00:00.377571187  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.377638252  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartmixer0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.377658712  5968   0A1E2530 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link bin0:src and src:proxypad19
0:00:00.377709484  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-mixer-mixer> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.377770865  5968   0A1E2530 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked bin0:src and src:proxypad19, successful
0:00:00.377893627  5968   0A1E2530 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.377840582  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<smart-mixer-mixer> completed state change to PAUSED
0:00:00.377966754  5968   0A1E2530 INFO        GST_ELEMENT_PADS gstelement.c:649:gst_element_add_pad:<gnlsource0> adding pad 'src'
0:00:00.378015632  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<smart-mixer-mixer> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.378086107  5968   0A1E2530 INFO          gnlcomposition gnlcomposition.c:473:wait_no_more_pads:<gnlsource0> disconnecting from 'no-more-pads'
0:00:00.378143699  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'smart-mixer-mixer' changed state to 3(PAUSED) successfully
0:00:00.378199396  5968   0A1E2530 INFO          gnlcomposition gnlcomposition.c:480:wait_no_more_pads:<gnlcomposition1> the number of waiting pads is now 0
0:00:00.378263051  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin1> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.378325569  5968   0A1E2530 INFO                GST_PADS gstpad.c:2083:gst_pad_link_prepare: trying to link gnlsource0:src and mixing-operation:ghostpad1
0:00:00.378388086  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<videoconvert0> current READY pending VOID_PENDING, desired next PAUSED
0:00:00.378444542  5968   0A1E2530 INFO                GST_PADS gstpad.c:2285:gst_pad_link_full: linked gnlsource0:src and mixing-operation:ghostpad1, successful
0:00:00.378568062  5968   0A1E2530 INFO               GST_EVENT gstevent.c:1314:gst_event_new_reconfigure: creating reconfigure event
0:00:00.378511607  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<videoconvert0> completed state change to PAUSED
0:00:00.378643083  5968   0A1E2530 INFO          gnlcomposition gnlcomposition.c:2115:no_more_pads_object_cb:<gnlcomposition1> Sending pending seek on mixing-operation:src
0:00:00.378689688  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<videoconvert0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.378751448  5968   0A1E2530 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.378818512  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin1> child 'videoconvert0' changed state to 3(PAUSED) successfully
0:00:00.378896944  5968   0A1E2530 INFO                 default gstsegment.c:370:gst_segment_do_seek: segment updated: time segment start=0:00:00.000000000, stop=0:00:01.000000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:00.378951126  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin1> completed state change to PAUSED
0:00:00.379034104  5968   0A1E2530 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.379087528  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<bin1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.379162171  5968   0A1E2530 INFO               GST_EVENT gstevent.c:1071:gst_event_new_seek: creating seek rate 1.000000, format TIME, flags 3, start_type 1, start 0:00:00.000000000, stop_type 1, stop 0:00:01.000000000
0:00:00.379223552  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'bin1' changed state to 3(PAUSED) successfully
0:00:00.379308045  5968   0A1E2530 INFO               GST_EVENT gstpad.c:5033:gst_pad_send_event_unchecked:<src:proxypad2> Received event on flushing pad. Discarding
0:00:00.379351619  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartmixer0> completed state change to PAUSED
0:00:00.379470213  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gessmartmixer0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.379534625  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartmixer0' changed state to 3(PAUSED) successfully
0:00:00.379600174  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.379659661  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<mixing-operation> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.379724073  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.379788864  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.379854792  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartmixer0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.379921478  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-mixer-mixer> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.379985890  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-mixer-mixer> skipping transition from PAUSED to  PAUSED
0:00:00.380044998  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'smart-mixer-mixer' changed state to 3(PAUSED) successfully
0:00:00.380106379  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin1> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.380171170  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<videoconvert0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.380232172  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<videoconvert0> skipping transition from PAUSED to  PAUSED
0:00:00.380291280  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin1> child 'videoconvert0' changed state to 3(PAUSED) successfully
0:00:00.380352661  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin1> completed state change to PAUSED
0:00:00.380412906  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'bin1' changed state to 3(PAUSED) successfully
0:00:00.380474666  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartmixer0> completed state change to PAUSED
0:00:00.380533773  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartmixer0' changed state to 3(PAUSED) successfully
0:00:00.380595912  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.380656157  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.380724358  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.380779298  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.380844468  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<capsfilter0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.380903197  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<capsfilter0> skipping transition from PAUSED to  PAUSED
0:00:00.380961547  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:00.381021412  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<testsrc> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.381081278  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<testsrc> skipping transition from PAUSED to  PAUSED
0:00:00.381140007  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'testsrc' changed state to 3(PAUSED) successfully
0:00:00.381201388  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin0> completed state change to PAUSED
0:00:00.381259359  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource0> child 'bin0' changed state to 3(PAUSED) successfully
0:00:00.381320740  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource0> completed state change to PAUSED
0:00:00.381379090  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'gnlsource0' changed state to 3(PAUSED) successfully
0:00:00.381445397  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition1> completed state change to PAUSED
0:00:00.381504883  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gnlcomposition1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.381569296  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesvideotrack0> child 'gnlcomposition1' changed state to 3(PAUSED) successfully
0:00:00.381633708  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesvideotrack0> completed state change to PAUSED
0:00:00.381693195  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gesvideotrack0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.381755712  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesvideotrack0' changed state to 3(PAUSED) successfully
0:00:00.381820125  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gestimeline0> completed state change to PAUSED
0:00:00.381879990  5968   01D94000 INFO              GST_STATES gstelement.c:2236:_priv_gst_element_state_changed:<gestimeline0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.381942508  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gespipeline0> child 'gestimeline0' changed state to 3(PAUSED) successfully
0:00:00.382007299  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<internal-sinks> current READY pending PAUSED, desired next PAUSED
0:00:00.382067923  5968   01D94000 INFO              GST_STATES gstbin.c:2636:gst_bin_change_state_func:<gespipeline0> child 'internal-sinks' is changing state asynchronously to PAUSED
0:00:00.382129304  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<tee0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.382189169  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<tee0> skipping transition from PLAYING to  PAUSED
0:00:00.382247140  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gespipeline0> child 'tee0' changed state to 3(PAUSED) successfully
0:00:00.382308521  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gestimeline0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382372176  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesaudiotrack0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382436209  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382500622  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382565792  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartadder0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382630204  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-adder-adder> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382691206  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-adder-adder> skipping transition from PAUSED to  PAUSED
0:00:00.382749935  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'smart-adder-adder' changed state to 3(PAUSED) successfully
0:00:00.382811695  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin2> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382884443  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioresample0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.382946582  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioresample0> skipping transition from PAUSED to  PAUSED
0:00:00.383004932  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioresample0' changed state to 3(PAUSED) successfully
0:00:00.383066313  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audioconvert0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.383125800  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audioconvert0> skipping transition from PAUSED to  PAUSED
0:00:00.383184150  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin2> child 'audioconvert0' changed state to 3(PAUSED) successfully
0:00:00.383246667  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin2> completed state change to PAUSED
0:00:00.383306154  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartadder0> child 'bin2' changed state to 3(PAUSED) successfully
0:00:00.383366777  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartadder0> completed state change to PAUSED
0:00:00.383425885  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartadder0' changed state to 3(PAUSED) successfully
0:00:00.383488024  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.383547511  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.383610786  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource1> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.383674441  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<audiotestsrc0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.383735064  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<audiotestsrc0> skipping transition from PAUSED to  PAUSED
0:00:00.383760829  5968   0A1E2008 INFO               GST_EVENT gstevent.c:629:gst_event_new_caps: creating caps event video/x-raw, format=(string)I420, width=(int)320, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
0:00:00.383796445  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource1> child 'audiotestsrc0' changed state to 3(PAUSED) successfully
0:00:00.383943836  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource1> completed state change to PAUSED
0:00:00.384002943  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition0> child 'gnlsource1' changed state to 3(PAUSED) successfully
0:00:00.384066598  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition0> completed state change to PAUSED
0:00:00.384125327  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesaudiotrack0> child 'gnlcomposition0' changed state to 3(PAUSED) successfully
0:00:00.384187466  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesaudiotrack0> completed state change to PAUSED
0:00:00.384246195  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesaudiotrack0' changed state to 3(PAUSED) successfully
0:00:00.384309470  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gesvideotrack0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.384373504  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlcomposition1> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.384439431  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<mixing-operation> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.384504223  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gessmartmixer0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.384569772  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<smart-mixer-mixer> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.384630016  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<smart-mixer-mixer> skipping transition from PAUSED to  PAUSED
0:00:00.384689124  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'smart-mixer-mixer' changed state to 3(PAUSED) successfully
0:00:00.384749747  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin1> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.384814159  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<videoconvert0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.384875162  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<videoconvert0> skipping transition from PAUSED to  PAUSED
0:00:00.384933890  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin1> child 'videoconvert0' changed state to 3(PAUSED) successfully
0:00:00.384994135  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin1> completed state change to PAUSED
0:00:00.385053622  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gessmartmixer0> child 'bin1' changed state to 3(PAUSED) successfully
0:00:00.385114624  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gessmartmixer0> completed state change to PAUSED
0:00:00.385174489  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<mixing-operation> child 'gessmartmixer0' changed state to 3(PAUSED) successfully
0:00:00.385236628  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<mixing-operation> completed state change to PAUSED
0:00:00.385298388  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'mixing-operation' changed state to 3(PAUSED) successfully
0:00:00.385359769  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<gnlsource0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.385423424  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<bin0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.385488594  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<capsfilter0> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.385549975  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<capsfilter0> skipping transition from PAUSED to  PAUSED
0:00:00.385609083  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:00.385685999  5968   01D94000 INFO              GST_STATES gstbin.c:2222:gst_bin_element_set_state:<testsrc> current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.385748516  5968   01D94000 INFO              GST_STATES gstbin.c:2339:gst_bin_element_set_state:<testsrc> skipping transition from PAUSED to  PAUSED
0:00:00.385812171  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<bin0> child 'testsrc' changed state to 3(PAUSED) successfully
0:00:00.385877720  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<bin0> completed state change to PAUSED
0:00:00.385963350  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlsource0> child 'bin0' changed state to 3(PAUSED) successfully
0:00:00.386028899  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlsource0> completed state change to PAUSED
0:00:00.386089523  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gnlcomposition1> child 'gnlsource0' changed state to 3(PAUSED) successfully
0:00:00.386152798  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gnlcomposition1> completed state change to PAUSED
0:00:00.386213043  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gesvideotrack0> child 'gnlcomposition1' changed state to 3(PAUSED) successfully
0:00:00.386275560  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gesvideotrack0> completed state change to PAUSED
0:00:00.386335426  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gestimeline0> child 'gesvideotrack0' changed state to 3(PAUSED) successfully
0:00:00.386397186  5968   01D94000 INFO              GST_STATES gstelement.c:2331:gst_element_continue_state:<gestimeline0> completed state change to PAUSED
0:00:00.386456294  5968   01D94000 INFO              GST_STATES gstbin.c:2630:gst_bin_change_state_func:<gespipeline0> child 'gestimeline0' changed state to 3(PAUSED) successfully
