0:00:01.207108830 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/mpegts 0:00:01.207134257 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/ogg 0:00:01.207160842 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/mpeg-elementary 0:00:01.207182290 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/mpeg4 0:00:01.207210170 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-h263 0:00:01.207259930 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-h264 0:00:01.207292165 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-h265 0:00:01.207320550 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-nuv 0:00:01.207342559 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-m4a 0:00:01.207364385 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-3gp 0:00:01.207386170 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/quicktime 0:00:01.207411122 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-quicktime 0:00:01.207433667 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/jp2 0:00:01.207455527 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/mj2 0:00:01.207479942 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for text/html 0:00:01.207502090 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/vnd.rn-realmedia 0:00:01.207526433 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-pn-realaudio 0:00:01.207549993 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-shockwave-flash 0:00:01.207573104 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/dash+xml 0:00:01.207595724 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/vnd.ms-sstr+xml 0:00:01.207619141 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-flv 0:00:01.207643179 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for text/plain 0:00:01.207667221 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for text/utf-16 0:00:01.207689856 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for text/utf-32 0:00:01.207711576 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for text/uri-list 0:00:01.207733727 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-hls 0:00:01.207755901 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/sdp 0:00:01.207781569 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/smil 0:00:01.207806361 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/ttml+xml 0:00:01.207828587 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/xml 0:00:01.207851456 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-wav 0:00:01.207874741 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-aiff 0:00:01.207897498 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-svx 0:00:01.207919409 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-paris 0:00:01.207940473 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-nist 0:00:01.207963458 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-voc 0:00:01.207984846 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-sds 0:00:01.208007409 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-ircam 0:00:01.208029093 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-w64 0:00:01.208050446 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-rf64 0:00:01.208075283 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-shorten 0:00:01.208097849 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ape 0:00:01.208121795 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/jpeg 0:00:01.208144021 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/gif 0:00:01.208165429 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/png 0:00:01.208189529 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/bmp 0:00:01.208215135 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/tiff 0:00:01.208239892 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/webp 0:00:01.208265829 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-exr 0:00:01.208293238 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-portable-pixmap 0:00:01.208319423 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-matroska 0:00:01.208343252 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/mxf 0:00:01.208364306 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-mve 0:00:01.208388523 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-dv 0:00:01.208411775 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-amr-nb-sh 0:00:01.208434292 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-amr-wb-sh 0:00:01.208459520 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/iLBC-sh 0:00:01.208481715 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-sbc 0:00:01.208507417 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-sid 0:00:01.208528932 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-xcf 0:00:01.208553712 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-mng 0:00:01.208575314 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-jng 0:00:01.208597174 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-xpixmap 0:00:01.208622583 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-sun-raster 0:00:01.208645937 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-bzip 0:00:01.208667988 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-gzip 0:00:01.208689522 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/zip 0:00:01.208711757 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-compress 0:00:01.208732237 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for subtitle/x-kate 0:00:01.208755702 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-flac 0:00:01.208779028 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-vorbis 0:00:01.208800677 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-theora 0:00:01.208822271 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ogm-video 0:00:01.208845614 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ogm-audio 0:00:01.208867977 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ogm-text 0:00:01.208890908 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-speex 0:00:01.208912925 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-celt 0:00:01.208938225 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ogg-skeleton 0:00:01.208963505 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for text/x-cmml 0:00:01.208985447 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-executable 0:00:01.209012596 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/aac 0:00:01.209038702 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-spc 0:00:01.209063056 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-wavpack 0:00:01.209087574 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-wavpack-correction 0:00:01.209111599 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-caf 0:00:01.209135944 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/postscript 0:00:01.209158939 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/svg+xml 0:00:01.209180871 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-rar 0:00:01.209203462 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-tar 0:00:01.209225899 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ar 0:00:01.209248351 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ms-dos-executable 0:00:01.209274391 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-dirac 0:00:01.209296461 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for multipart/x-mixed-replace 0:00:01.209318331 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-mmsh 0:00:01.209342927 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/vivo 0:00:01.209365179 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-nsf 0:00:01.209387853 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-gym 0:00:01.209409913 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-ay 0:00:01.209433241 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-gbs 0:00:01.209455476 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-vgm 0:00:01.209477567 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-sap 0:00:01.209501196 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-ivf 0:00:01.209524001 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-kss 0:00:01.209545564 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/pdf 0:00:01.209567441 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/msword 0:00:01.209591701 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/octet-stream 0:00:01.209614553 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/vnd.adobe.photoshop 0:00:01.209636278 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/vnd.wap.wbmp 0:00:01.209656853 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-yuv4mpeg 0:00:01.209677455 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-icon 0:00:01.209697064 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for image/x-degas 0:00:01.209717826 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/octet-stream 0:00:01.209747846 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for application/x-ssa 0:00:01.209773746 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for video/x-pva 0:00:01.209795838 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/x-xi 0:00:01.209820423 10134 0x7efdb400d720 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for audio/audible 0:00:01.209844541 10134 0x7efdb400d720 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgsttypefindfunctions.so" loaded 0:00:01.209913150 10134 0x7efdb400d720 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/quicktime, variant=(string)iso 0:00:01.209950726 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad typefind:src 0:00:01.209966209 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad typefind:sink 0:00:01.210039418 10134 0x7efdb400d720 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link typefind:src and decodepad0:proxypad20 0:00:01.210057800 10134 0x7efdb400d720 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked typefind:src and decodepad0:proxypad20, successful 0:00:01.210076783 10134 0x7efdb400d720 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.212454194 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking typefind:src(0x7efdbc027900) and decodepad0:proxypad20(0x7efdbc01cef0) 0:00:01.212487351 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked typefind:src and decodepad0:proxypad20 0:00:01.212518048 10134 0x7efdb400d720 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link typefind:src and decodepad0:proxypad20 0:00:01.212539602 10134 0x7efdb400d720 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked typefind:src and decodepad0:proxypad20, successful 0:00:01.212557391 10134 0x7efdb400d720 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.212591716 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking typefind:src(0x7efdbc027900) and decodepad0:proxypad20(0x7efdbc01cef0) 0:00:01.212613436 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked typefind:src and decodepad0:proxypad20 0:00:01.221197145 10134 0x7efdb400d720 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstisomp4.so" loaded 0:00:01.221220074 10134 0x7efdb400d720 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "qtdemux" 0:00:01.221364314 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.221411221 10134 0x7efdb400d720 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link typefind:src and qtdemux0:sink 0:00:01.221429100 10134 0x7efdb400d720 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked typefind:src and qtdemux0:sink, successful 0:00:01.221447020 10134 0x7efdb400d720 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.221473992 10134 0x7efdb400d720 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.221486267 10134 0x7efdb400d720 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.221549608 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'video_%u' in element "qtdemux0" 0:00:01.221564743 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'audio_%u' in element "qtdemux0" 0:00:01.221563362 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.221584709 10134 0x7efdb400d720 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'subtitle_%u' in element "qtdemux0" 0:00:01.221663927 10134 0x7efdb400d720 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efd1405c0d0 on task 0x7efdbc031170 0:00:01.221679405 10134 0x7efdb400d720 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efdbc031170 0:00:01.221715487 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.221772902 10134 0x7efdb400d720 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.221788149 10134 0x7efdb400d720 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.221823127 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.221825074 10134 0x7efdb400d720 INFO typefind gsttypefindelement.c:180:gst_type_find_element_have_type: found caps video/quicktime, variant=(string)iso, probability=100 0:00:01.221867060 10134 0x7efdb400d720 INFO task gsttask.c:316:gst_task_func: Task going to paused 0:00:01.221932468 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.222063961 10134 0x7efd1405f540 WARN qtdemux qtdemux_types.c:222:qtdemux_type_get: unknown QuickTime node type sgpd 0:00:01.222093299 10134 0x7efd1405f540 WARN qtdemux qtdemux_types.c:222:qtdemux_type_get: unknown QuickTime node type sbgp 0:00:01.222119148 10134 0x7efd1405f540 INFO qtdemux qtdemux.c:12098:qtdemux_parse_tree: timescale: 1000 0:00:01.222134484 10134 0x7efd1405f540 INFO qtdemux qtdemux.c:12099:qtdemux_parse_tree: duration: 48067 0:00:01.222154499 10134 0x7efd1405f540 WARN qtdemux qtdemux.c:2651:qtdemux_parse_trex: failed to find fragment defaults for stream 1 0:00:01.222194142 10134 0x7efd1405f540 INFO qtdemux qtdemux.c:9803:qtdemux_parse_trak: type avc1 caps video/x-h264, stream-format=(string)avc, alignment=(string)au, level=(string)3.1, profile=(string)high, codec_data=(buffer)0164001fffe100196764001facd9405005ba10000003001000000303c0f183196001000568ebecb22c 0:00:01.222330110 10134 0x7efd1405f540 WARN qtdemux qtdemux.c:2651:qtdemux_parse_trex: failed to find fragment defaults for stream 2 0:00:01.222368355 10134 0x7efd1405f540 INFO qtdemux qtdemux.c:10421:qtdemux_parse_trak: type mp4a caps audio/mpeg, mpegversion=(int)4, framed=(boolean)true, stream-format=(string)raw, level=(string)2, base-profile=(string)lc, profile=(string)lc, codec_data=(buffer)119056e500 0:00:01.222487475 10134 0x7efd1405f540 WARN basesrc gstbasesrc.c:2396:gst_base_src_update_length: processing at or past EOS 0:00:01.222502601 10134 0x7efd1405f540 INFO GST_SCHEDULING gstpad.c:4757:gst_pad_get_range_unchecked: getrange failed, flow: eos 0:00:01.222521062 10134 0x7efd1405f540 INFO GST_SCHEDULING gstpad.c:4972:gst_pad_pull_range: pullrange failed, flow: eos 0:00:01.222538281 10134 0x7efd1405f540 INFO GST_SCHEDULING gstpad.c:4757:gst_pad_get_range_unchecked: getrange failed, flow: eos 0:00:01.222554736 10134 0x7efd1405f540 INFO GST_SCHEDULING gstpad.c:4972:gst_pad_pull_range: pullrange failed, flow: eos 0:00:01.222570936 10134 0x7efd1405f540 INFO GST_SCHEDULING gstpad.c:4757:gst_pad_get_range_unchecked: getrange failed, flow: eos 0:00:01.222586659 10134 0x7efd1405f540 INFO GST_SCHEDULING gstpad.c:4972:gst_pad_pull_range: pullrange failed, flow: eos 0:00:01.222651230 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad qtdemux0:sink 0:00:01.222704933 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-h264, stream-format=(string)avc, alignment=(string)au, level=(string)3.1, profile=(string)high, codec_data=(buffer)0164001fffe100196764001facd9405005ba10000003001000000303c0f183196001000568ebecb22c, max-input-size=(int)132678, width=(int)1280, height=(int)720, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1 0:00:01.222752904 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'video_0' 0:00:01.222792846 10134 0x7efd1405f540 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "multiqueue" 0:00:01.222894293 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad qtdemux0:sink 0:00:01.222984555 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PAUSED, next PAUSED 0:00:01.223002917 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PAUSED pending) 0:00:01.223030461 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PAUSED 0:00:01.223049549 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.223064357 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.223144501 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link qtdemux0:video_0 and decodepad1:proxypad21 0:00:01.223163943 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked qtdemux0:video_0 and decodepad1:proxypad21, successful 0:00:01.223182946 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.223388786 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking qtdemux0:video_0(0x7efd1405c960) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.223417231 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked qtdemux0:video_0 and decodepad1:proxypad21 0:00:01.223535645 10134 0x7efd1405f540 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efd1405ce50 on task 0x7efdbc031710 0:00:01.223553639 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:5980:gst_pad_start_task:<'':src_0> created task 0x7efdbc031710 0:00:01.223788239 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_0' 0:00:01.223819473 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink_0' 0:00:01.223844761 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link qtdemux0:video_0 and multiqueue0:sink_0 0:00:01.223861399 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked qtdemux0:video_0 and multiqueue0:sink_0, successful 0:00:01.223879996 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.223920948 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link multiqueue0:src_0 and decodepad1:proxypad21 0:00:01.223937870 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked multiqueue0:src_0 and decodepad1:proxypad21, successful 0:00:01.223955779 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.223986998 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking multiqueue0:src_0(0x7efd1405cde0) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.224008678 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked multiqueue0:src_0 and decodepad1:proxypad21 0:00:01.224035870 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link multiqueue0:src_0 and decodepad1:proxypad21 0:00:01.224051393 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked multiqueue0:src_0 and decodepad1:proxypad21, successful 0:00:01.224069102 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.224110905 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking multiqueue0:src_0(0x7efd1405cde0) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.224133921 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked multiqueue0:src_0 and decodepad1:proxypad21 0:00:01.224182438 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.236622143 10134 0x7efd1405f540 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstvideoparsersbad.so" loaded 0:00:01.236645579 10134 0x7efd1405f540 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "h264parse" 0:00:01.236760201 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.236786158 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.236806723 10134 0x7efd1405f540 INFO baseparse gstbaseparse.c:3942:gst_base_parse_set_pts_interpolation: PTS interpolation: no 0:00:01.236845720 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link multiqueue0:src_0 and h264parse0:sink 0:00:01.236863523 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked multiqueue0:src_0 and h264parse0:sink, successful 0:00:01.236877539 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.236907283 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.236918723 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.236958974 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.236966738 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad h264parse0:src 0:00:01.237011056 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link h264parse0:src and decodepad1:proxypad21 0:00:01.237026971 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked h264parse0:src and decodepad1:proxypad21, successful 0:00:01.237040116 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.237050553 10134 0x7efd1405f540 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.237243371 10134 0x7efd1405f540 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "capsfilter" 0:00:01.237272696 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.237292180 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.237311400 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.237329102 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PAUSED, next PAUSED 0:00:01.237342966 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PAUSED pending) 0:00:01.237358495 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PAUSED 0:00:01.237383209 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.237393762 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.237415542 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking h264parse0:src(0x7efd1405d260) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.237434673 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked h264parse0:src and decodepad1:proxypad21 0:00:01.237452630 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad capsfilter0:sink 0:00:01.237467168 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link h264parse0:src and capsfilter0:sink 0:00:01.237479959 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked h264parse0:src and capsfilter0:sink, successful 0:00:01.237491879 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.237501780 10134 0x7efd1405f540 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.237515359 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad capsfilter0:src 0:00:01.237528648 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter0:src and decodepad1:proxypad21 0:00:01.237541055 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter0:src and decodepad1:proxypad21, successful 0:00:01.237553235 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.237564017 10134 0x7efd1405f540 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.237710448 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.237724597 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.237755201 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.237789655 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad qtdemux0:sink 0:00:01.237831177 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event audio/mpeg, mpegversion=(int)4, framed=(boolean)true, stream-format=(string)raw, level=(string)2, base-profile=(string)lc, profile=(string)lc, codec_data=(buffer)119056e500, max-input-size=(int)531, rate=(int)48000, channels=(int)2 0:00:01.237865128 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'audio_0' 0:00:01.237917674 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link qtdemux0:audio_0 and decodepad2:proxypad22 0:00:01.237932328 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked qtdemux0:audio_0 and decodepad2:proxypad22, successful 0:00:01.237944836 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.238085118 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking qtdemux0:audio_0(0x7efd1405d920) and decodepad2:proxypad22(0x7efdbc01d830) 0:00:01.238106610 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked qtdemux0:audio_0 and decodepad2:proxypad22 0:00:01.238167381 10134 0x7efd1405f540 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efd1405de10 on task 0x7efdbc031830 0:00:01.238180814 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:5980:gst_pad_start_task:<'':src_1> created task 0x7efdbc031830 0:00:01.238235496 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_1' 0:00:01.238249916 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink_1' 0:00:01.238266349 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link qtdemux0:audio_0 and multiqueue0:sink_1 0:00:01.238279509 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked qtdemux0:audio_0 and multiqueue0:sink_1, successful 0:00:01.238292683 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.238318989 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link multiqueue0:src_1 and decodepad2:proxypad22 0:00:01.238332221 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked multiqueue0:src_1 and decodepad2:proxypad22, successful 0:00:01.238348698 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.238347178 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.238382711 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking multiqueue0:src_1(0x7efd1405dda0) and decodepad2:proxypad22(0x7efdbc01d830) 0:00:01.238408482 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked multiqueue0:src_1 and decodepad2:proxypad22 0:00:01.238426407 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link multiqueue0:src_1 and decodepad2:proxypad22 0:00:01.238438527 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked multiqueue0:src_1 and decodepad2:proxypad22, successful 0:00:01.238450242 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.238487687 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking multiqueue0:src_1(0x7efd1405dda0) and decodepad2:proxypad22(0x7efdbc01d830) 0:00:01.238505260 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked multiqueue0:src_1 and decodepad2:proxypad22 0:00:01.248805462 10134 0x7efd1405f540 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstaudioparsers.so" loaded 0:00:01.248828117 10134 0x7efd1405f540 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "aacparse" 0:00:01.248913041 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.248934631 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.248968811 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link multiqueue0:src_1 and aacparse0:sink 0:00:01.248984017 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked multiqueue0:src_1 and aacparse0:sink, successful 0:00:01.248997527 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.249026647 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.249037961 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.249069971 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.249078037 10134 0x7efd1405f540 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad aacparse0:src 0:00:01.249121891 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link aacparse0:src and decodepad2:proxypad22 0:00:01.249136701 10134 0x7efd1405f540 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked aacparse0:src and decodepad2:proxypad22, successful 0:00:01.249148249 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.249158231 10134 0x7efd1405f540 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.249210951 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.249223216 10134 0x7efd1405f540 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.249249893 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.249297209 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event time segment start=0:00:00.066666666, offset=0:00:00.000000000, stop=0:00:48.133666666, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.066666666, duration 99:99:99.999999999 0:00:01.249415311 10134 0x7efd1405f540 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event time segment start=0:00:00.021333333, offset=0:00:00.000000000, stop=0:00:47.999333333, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.021333333, duration 99:99:99.999999999 0:00:01.249484538 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad1> pad has no peer 0:00:01.249587394 10134 0x7efcfc0119e0 INFO baseparse gstbaseparse.c:4758:gst_base_parse_set_upstream_tags: upstream tags: taglist, video-codec=(string)"H.264\ /\ AVC", language-code=(string)en, bitrate=(uint)2454874; 0:00:01.249637053 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad2> pad has no peer 0:00:01.249673419 10134 0x7efcfc011c00 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event audio/mpeg, mpegversion=(int)4, framed=(boolean)true, stream-format=(string)raw, level=(string)2, base-profile=(string)lc, profile=(string)lc, codec_data=(buffer)119056e500, max-input-size=(int)531, rate=(int)48000, channels=(int)2 0:00:01.249725989 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking aacparse0:src(0x7efcfc07e2a0) and decodepad2:proxypad22(0x7efdbc01d830) 0:00:01.249739493 10134 0x7efcfc0119e0 INFO baseparse gstbaseparse.c:3985:gst_base_parse_set_latency: min/max latency 0:00:00.033333333, 0:00:00.033333333 0:00:01.249766719 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked aacparse0:src and decodepad2:proxypad22 0:00:01.249794969 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link aacparse0:src and decodepad2:proxypad22 0:00:01.249811996 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked aacparse0:src and decodepad2:proxypad22, successful 0:00:01.249842511 10134 0x7efcfc011c00 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.249819915 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad1> pad has no peer 0:00:01.249918539 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, level=(string)3.1, profile=(string)high, max-input-size=(int)132678, width=(int)1280, height=(int)720, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1, parsed=(boolean)true 0:00:01.250011077 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad1> pad has no peer 0:00:01.250033659 10134 0x7efcfc0119e0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.250050075 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, level=(string)3.1, profile=(string)high, max-input-size=(int)132678, width=(int)1280, height=(int)720, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1, parsed=(boolean)true 0:00:01.250062351 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking aacparse0:src(0x7efcfc07e2a0) and decodepad2:proxypad22(0x7efdbc01d830) 0:00:01.250088362 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked aacparse0:src and decodepad2:proxypad22 0:00:01.250085750 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter0:src(0x7efd1405d6e0) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.250112665 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link aacparse0:src and decodepad2:proxypad22 0:00:01.250136393 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter0:src and decodepad1:proxypad21 0:00:01.250141311 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked aacparse0:src and decodepad2:proxypad22, successful 0:00:01.250169390 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter0:src and decodepad1:proxypad21 0:00:01.250176073 10134 0x7efcfc011c00 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.250191508 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter0:src and decodepad1:proxypad21, successful 0:00:01.250219750 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.250230772 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking aacparse0:src(0x7efcfc07e2a0) and decodepad2:proxypad22(0x7efdbc01d830) 0:00:01.250253242 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked aacparse0:src and decodepad2:proxypad22 0:00:01.250274585 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link aacparse0:src and decodepad2:proxypad22 0:00:01.250289171 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked aacparse0:src and decodepad2:proxypad22, successful 0:00:01.250302908 10134 0x7efcfc011c00 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.250339054 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking aacparse0:src(0x7efcfc07e2a0) and decodepad2:proxypad22(0x7efdbc01d830) 0:00:01.250359457 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked aacparse0:src and decodepad2:proxypad22 0:00:01.250398759 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter0:src(0x7efd1405d6e0) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.250422468 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter0:src and decodepad1:proxypad21 0:00:01.250446732 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter0:src and decodepad1:proxypad21 0:00:01.250460281 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter0:src and decodepad1:proxypad21, successful 0:00:01.250476769 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.250510508 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter0:src(0x7efd1405d6e0) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.250529496 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter0:src and decodepad1:proxypad21 0:00:01.250554258 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter0:src and decodepad1:proxypad21 0:00:01.250567341 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter0:src and decodepad1:proxypad21, successful 0:00:01.250583421 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.250621574 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter0:src(0x7efd1405d6e0) and decodepad1:proxypad21(0x7efdbc01cef0) 0:00:01.250641156 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter0:src and decodepad1:proxypad21 0:00:01.352162543 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_avs 0:00:01.352275034 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_daud 0:00:01.352312799 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_ea 0:00:01.352339797 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_ffm 0:00:01.352369666 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_4xm 0:00:01.352402166 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_gxf 0:00:01.352429932 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_idcin 0:00:01.352460499 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_ipmovie 0:00:01.352504872 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_mm 0:00:01.352528530 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_mmf 0:00:01.352585519 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_nsv 0:00:01.352610386 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_nut 0:00:01.352682769 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_film_cpk 0:00:01.352710118 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_smk 0:00:01.352735949 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_sol 0:00:01.352763146 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_psxstr 0:00:01.352808366 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_vmd 0:00:01.352842411 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_wc3movie 0:00:01.352868436 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_wsaud 0:00:01.352891138 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_wsvqa 0:00:01.352923467 10134 0x7efcfc011c00 INFO GST_TYPEFIND gsttypefind.c:71:gst_type_find_register: registering typefind function for avtype_yuv4mpegpipe 0:00:01.353379217 10134 0x7efcfc011c00 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstlibav.so" loaded 0:00:01.353395899 10134 0x7efcfc011c00 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "avdec_aac" 0:00:01.353481168 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.353499175 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.353566754 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link aacparse0:src and avdec_aac0:sink 0:00:01.353582830 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked aacparse0:src and avdec_aac0:sink, successful 0:00:01.353594666 10134 0x7efcfc011c00 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.353626686 10134 0x7efcfc011c00 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.353636817 10134 0x7efcfc011c00 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.353677546 10134 0x7efcfc011c00 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad avdec_aac0:src 0:00:01.353697424 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link avdec_aac0:src and decodepad2:proxypad22 0:00:01.353700142 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.353709686 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked avdec_aac0:src and decodepad2:proxypad22, successful 0:00:01.353739137 10134 0x7efcfc011c00 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.353749577 10134 0x7efcfc011c00 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.353791546 10134 0x7efcfc011c00 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.353802504 10134 0x7efcfc011c00 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.353826120 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.356133444 10134 0x7efcfc011c00 INFO baseparse gstbaseparse.c:3923:gst_base_parse_set_passthrough: passthrough: yes 0:00:01.356169770 10134 0x7efcfc011c00 INFO baseparse gstbaseparse.c:4758:gst_base_parse_set_upstream_tags: upstream tags: taglist, audio-codec=(string)"MPEG-4\ AAC\ audio", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en; 0:00:01.356223686 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC\ audio", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en; 0:00:01.356269389 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en; 0:00:01.356348982 10134 0x7efcfc011c00 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)48000, channels=(int)2, channel-mask=(bitmask)0x0000000000000003 0:00:01.356391346 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad2> pad has no peer 0:00:01.373016340 10134 0x7efcfc0119e0 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libnvdsgst_videocodecs.so" loaded 0:00:01.373044530 10134 0x7efcfc0119e0 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "nvdec_h264" 0:00:01.373216736 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.373247066 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.373306182 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter0:src and nvcuvidh264dec0:sink 0:00:01.373326936 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter0:src and nvcuvidh264dec0:sink, successful 0:00:01.373344382 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.373384329 10134 0x7efcfc0119e0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.373399379 10134 0x7efcfc0119e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.373468885 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query: pad has no peer 0:00:01.373466729 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.373541669 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad nvcuvidh264dec0:src 0:00:01.373572499 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link nvcuvidh264dec0:src and decodepad1:proxypad21 0:00:01.373590619 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked nvcuvidh264dec0:src and decodepad1:proxypad21, successful 0:00:01.373606682 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.373619315 10134 0x7efcfc0119e0 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.373650115 10134 0x7efcfc0119e0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.373664709 10134 0x7efcfc0119e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.373694030 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.373733875 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad1> pad has no peer 0:00:01.396589139 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad1> pad has no peer 0:00:01.396878760 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ /\ AVC", language-code=(string)en, bitrate=(uint)2454874; 0:00:01.396893244 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.397014432 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874; 0:00:01.397148298 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad1> pad has no peer 0:00:01.397250669 10134 0x7efcfc0119e0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.401214608 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.420513260 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message [2019-06-12 14:36:06.499 0x127FC700 GST] CH(01) SRC_SDP_RECV 0:00:01.433480735 10134 0x7efdbc00ae30 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstudp.so" loaded 0:00:01.433501179 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "udpsrc" 0:00:01.433598813 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.433666273 10134 0x7efdbc00ae30 INFO udpsrc gstudpsrc.c:1367:gst_udpsrc_open: setting udp buffer of 524288 bytes 0:00:01.433678199 10134 0x7efdbc00ae30 INFO udpsrc gstudpsrc.c:1387:gst_udpsrc_open: have udp buffer of 425984 bytes 0:00:01.433697628 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.433706017 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.433740082 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to NULL 0:00:01.433748815 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to NULL (VOID_PENDING pending) 0:00:01.433759908 10134 0x7efdbc00ae30 INFO GST_REFCOUNTING gstelement.c:2947:gst_element_dispose: dispose 0:00:01.433767175 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:776:gst_element_remove_pad: removing pad 'src' 0:00:01.433778442 10134 0x7efdbc00ae30 INFO GST_REFCOUNTING gstelement.c:2992:gst_element_dispose: parent class dispose 0:00:01.433788018 10134 0x7efdbc00ae30 INFO GST_REFCOUNTING gstelement.c:3023:gst_element_finalize: finalize 0:00:01.433795149 10134 0x7efdbc00ae30 INFO GST_REFCOUNTING gstelement.c:3028:gst_element_finalize: finalize parent 0:00:01.433848091 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "udpsrc" 0:00:01.433867707 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.433910916 10134 0x7efdbc00ae30 INFO udpsrc gstudpsrc.c:1367:gst_udpsrc_open: setting udp buffer of 524288 bytes 0:00:01.433920815 10134 0x7efdbc00ae30 INFO udpsrc gstudpsrc.c:1387:gst_udpsrc_open: have udp buffer of 425984 bytes 0:00:01.433936276 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.433943685 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.433986360 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "udpsrc" 0:00:01.434003165 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.434043458 10134 0x7efdbc00ae30 INFO udpsrc gstudpsrc.c:1387:gst_udpsrc_open: have udp buffer of 212992 bytes 0:00:01.434058780 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.434066347 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.434138712 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.459227673 10134 0x7efdbc00ae30 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstrtpmanager.so" loaded 0:00:01.459247874 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:362:gst_element_factory_create: creating element "rtpbin" named "manager" 0:00:01.459477283 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PAUSED, next PAUSED 0:00:01.459491168 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PAUSED pending) 0:00:01.459512547 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PAUSED 0:00:01.459524701 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.459532219 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.459557858 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.459570288 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'recv_rtp_sink_0' in element "manager" 0:00:01.459604610 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "rtpsession" 0:00:01.459818261 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "rtpssrcdemux" 0:00:01.459876288 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.459891124 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'rtcp_sink' 0:00:01.459937799 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PAUSED, next PAUSED 0:00:01.459948388 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PAUSED pending) 0:00:01.459964991 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PAUSED 0:00:01.459976544 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.459983668 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.459995762 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PAUSED, next PAUSED 0:00:01.460004133 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PAUSED pending) 0:00:01.460014166 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PAUSED 0:00:01.460009254 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.460025917 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.460060895 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.460079502 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'recv_rtp_sink' in element "rtpsession0" 0:00:01.460085298 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.460101591 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'recv_rtp_sink' 0:00:01.460118866 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'recv_rtp_src' 0:00:01.460152873 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link recv_rtp_sink_0:proxypad23 and rtpsession0:recv_rtp_sink 0:00:01.460163826 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked recv_rtp_sink_0:proxypad23 and rtpsession0:recv_rtp_sink, successful 0:00:01.460173462 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.460186575 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'recv_rtp_sink_0' 0:00:01.460197916 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpsession0:recv_rtp_src 0:00:01.460207776 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpssrcdemux0:sink 0:00:01.460221616 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtpsession0:recv_rtp_src and rtpssrcdemux0:sink 0:00:01.460230795 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtpsession0:recv_rtp_src and rtpssrcdemux0:sink, successful 0:00:01.460239164 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.460256580 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'recv_rtcp_sink_0' in element "manager" 0:00:01.460278204 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'recv_rtcp_sink' in element "rtpsession0" 0:00:01.460295942 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'recv_rtcp_sink' 0:00:01.460311298 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sync_src' 0:00:01.460323524 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpsession0:sync_src 0:00:01.460331431 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpssrcdemux0:rtcp_sink 0:00:01.460340653 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtpsession0:sync_src and rtpssrcdemux0:rtcp_sink 0:00:01.460349476 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtpsession0:sync_src and rtpssrcdemux0:rtcp_sink, successful 0:00:01.460357574 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.460378218 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link recv_rtcp_sink_0:proxypad24 and rtpsession0:recv_rtcp_sink 0:00:01.460387393 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked recv_rtcp_sink_0:proxypad24 and rtpsession0:recv_rtcp_sink, successful 0:00:01.460395422 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.460404469 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'recv_rtcp_sink_0' 0:00:01.460418863 10134 0x7efdbc00ae30 INFO rtspsrc gstrtspsrc.c:3110:gst_rtspsrc_stream_configure_manager: configure bandwidth in session 0x7efdbc02d930 0:00:01.460448725 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad udpsrc1:src 0:00:01.460461329 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link udpsrc1:src and manager:recv_rtp_sink_0 0:00:01.460470656 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked udpsrc1:src and manager:recv_rtp_sink_0, successful 0:00:01.460479123 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.460485854 10134 0x7efdbc00ae30 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.460502309 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad udpsrc2:src 0:00:01.460511518 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link udpsrc2:src and manager:recv_rtcp_sink_0 0:00:01.460519949 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked udpsrc2:src and manager:recv_rtcp_sink_0, successful 0:00:01.460528029 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.460534565 10134 0x7efdbc00ae30 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.460614754 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "udpsink" 0:00:01.460715008 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.461006984 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "fakesrc" 0:00:01.461080977 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.461110171 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstutils.c:1573:gst_element_link_pads_full: trying to link element fakesrc0:src to element udpsink0:sink 0:00:01.461120746 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad fakesrc0:src 0:00:01.461128244 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad udpsink0:sink 0:00:01.461135426 10134 0x7efdbc00ae30 INFO GST_PADS gstutils.c:1446:prepare_link_maybe_ghosting: fakesrc0 and udpsink0 in same bin, no need for ghost pads 0:00:01.461146831 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link fakesrc0:src and udpsink0:sink 0:00:01.461155519 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked fakesrc0:src and udpsink0:sink, successful 0:00:01.461163402 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.461170386 10134 0x7efdbc00ae30 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.461213695 10134 0x7efdbc00ae30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "udpsink" 0:00:01.461230791 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.461398171 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PLAYING, next PAUSED 0:00:01.461410820 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PLAYING pending) 0:00:01.461421676 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PLAYING 0:00:01.461433140 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.461441951 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.461450974 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.461459058 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.461465947 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.461480189 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad udpsink1:sink 0:00:01.461496338 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'send_rtcp_src_0' in element "manager" 0:00:01.461508069 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'send_rtcp_src' in element "rtpsession0" 0:00:01.461529682 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'send_rtcp_src' 0:00:01.461558549 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtpsession0:send_rtcp_src and send_rtcp_src_0:proxypad25 0:00:01.461568052 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtpsession0:send_rtcp_src and send_rtcp_src_0:proxypad25, successful 0:00:01.461576307 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.461587761 10134 0x7efdbc00ae30 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'send_rtcp_src_0' 0:00:01.461599074 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link manager:send_rtcp_src_0 and udpsink1:sink 0:00:01.461608414 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked manager:send_rtcp_src_0 and udpsink1:sink, successful 0:00:01.461617081 10134 0x7efdbc00ae30 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.461645312 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to NULL 0:00:01.461655020 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to NULL 0:00:01.461667920 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PLAYING, next PAUSED 0:00:01.461676314 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PLAYING pending) 0:00:01.461686663 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PLAYING 0:00:01.461686799 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.461696816 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.461729101 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.461744629 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.461748798 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.461753167 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.461774539 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.461790747 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PLAYING, next PAUSED 0:00:01.461796128 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.461800474 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PLAYING pending) 0:00:01.461829297 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PLAYING 0:00:01.461835022 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.461844403 10134 0x7efdbc00ae30 INFO basesrc gstbasesrc.c:1344:gst_base_src_do_seek: seeking: bytes segment start=0, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1 0:00:01.461868756 10134 0x7efdbc00ae30 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efd0803cc10 on task 0x7efdbc031cb0 0:00:01.461877443 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efdbc031cb0 0:00:01.461898585 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.461936017 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.461947317 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.461961630 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.461968118 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.461969815 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.461996066 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.462017158 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.462022675 10134 0x7efd080368a0 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'sink' in element "fakesrc0" 0:00:01.462072218 10134 0x7efd080368a0 FIXME default gstutils.c:3766:gst_pad_create_stream_id_internal: Creating random stream-id, consider implementing a deterministic way of creating a stream-id 0:00:01.462146340 10134 0x7efd080368a0 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event bytes segment start=0, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1 0:00:01.462173399 10134 0x7efd080368a0 INFO basesrc gstbasesrc.c:2843:gst_base_src_loop: marking pending DISCONT 0:00:01.462284455 10134 0x7efd080368a0 INFO basesrc gstbasesrc.c:2739:gst_base_src_loop: pausing after gst_base_src_get_range() = eos 0:00:01.462304597 10134 0x7efd080368a0 INFO task gsttask.c:316:gst_task_func: Task going to paused 0:00:01.497492519 10134 0x7efdbc00ae30 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.497518361 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.497527639 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.497551490 10134 0x7efdbc00ae30 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'rtpssrcdemux0' changed state to 4(PLAYING) successfully 0:00:01.497557975 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.497563464 10134 0x7efdbc00ae30 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.497629593 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.497638597 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.497656011 10134 0x7efdbc00ae30 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'rtpsession0' changed state to 4(PLAYING) successfully 0:00:01.497658631 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.497669428 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.497690800 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.497709691 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.497723278 10134 0x7efdbc00ae30 INFO basesrc gstbasesrc.c:1344:gst_base_src_do_seek: seeking: time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:01.497752417 10134 0x7efdbc00ae30 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efcfc07f990 on task 0x7efdbc031dd0 0:00:01.497761338 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efdbc031dd0 0:00:01.497780477 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.497819686 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.497831749 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.497847511 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.497851144 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.497869296 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.497877480 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.497895054 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.497895574 10134 0x7efdbc00ae30 INFO basesrc gstbasesrc.c:1344:gst_base_src_do_seek: seeking: time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:01.497925856 10134 0x7efdbc00ae30 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efcfc07fbd0 on task 0x7efdbc031ef0 0:00:01.497915554 10134 0x7efd08036990 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'sink' in element "udpsrc1" 0:00:01.497934356 10134 0x7efdbc00ae30 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efdbc031ef0 0:00:01.497987397 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.498011692 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.498022902 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.498037049 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.498040911 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.498054618 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.498064825 10134 0x7efdbc00ae30 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.498120797 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.498121607 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'sink' in element "udpsrc2" 0:00:01.498087591 10134 0x7efd08036990 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)97, clock-rate=(int)90000, encoding-name=(string)H264, packetization-mode=(string)1, profile-level-id=(string)640029, sprop-parameter-sets=(string)"Z2QAKa0AzlAUAW7ARAAALuAACvyDgAAAC+vCAAAHc1lIvfjAAAAF9eEAAAMDuaykXvwbQRCJSw\=\=\,aP48sA\=\=", a-framesize=(string)1280-720, a-sdplang=(string)en, a-cliprect=(string)"0\,0\,720\,1280", a-framerate=(string)30.0, ssrc=(uint)408537352, clock-base=(uint)0, seqnum-base=(uint)1, npt-start=(guint64)0, npt-stop=(guint64)493062000000, play-speed=(double)1, play-scale=(double)1 0:00:01.498207494 10134 0x7efd080369e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event application/x-rtcp 0:00:01.552881389 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)NV12, width=(int)1280, height=(int)720, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, chroma-site=(string)mpeg2, colorimetry=(string)bt709, framerate=(fraction)30/1 0:00:01.552960040 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_0' 0:00:01.553044857 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link decodebin0:src_0 and src_0:proxypad26 0:00:01.553062582 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked decodebin0:src_0 and src_0:proxypad26, successful 0:00:01.553075240 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.553123289 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_0' 0:00:01.553159666 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad src_tee_1:sink 0:00:01.553181442 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link uridecodebin_1:src_0 and src_tee_1:sink 0:00:01.553408075 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked uridecodebin_1:src_0 and src_tee_1:sink, successful 0:00:01.553424504 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.553455006 10134 0x7efcfc0119e0 INFO decodebin gstdecodebin2.c:4664:gst_decode_bin_expose: added new decoded pad 0:00:01.553467075 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_1' 0:00:01.553508457 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link decodebin0:src_1 and src_1:proxypad27 0:00:01.553521649 10134 0x7efcfc0119e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked decodebin0:src_1 and src_1:proxypad27, successful 0:00:01.553533289 10134 0x7efcfc0119e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.553564457 10134 0x7efcfc0119e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_1' 0:00:01.553586790 10134 0x7efcfc0119e0 INFO decodebin gstdecodebin2.c:4664:gst_decode_bin_expose: added new decoded pad 0:00:01.553614244 10134 0x7efcfc0119e0 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PAUSED 0:00:01.553626828 10134 0x7efcfc0119e0 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:01.553636217 10134 0x7efcfc0119e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.553662435 10134 0x7efcfc0119e0 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PAUSED 0:00:01.553673941 10134 0x7efcfc0119e0 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:01.553678674 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query: pad has no peer 0:00:01.553682568 10134 0x7efcfc0119e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.553692828 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.553725770 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query: pad has no peer 0:00:01.553730164 10134 0x7efcfc0119e0 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PAUSED 0:00:01.553766126 10134 0x7efcfc0119e0 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:01.553774884 10134 0x7efcfc0119e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.553795605 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.553828959 10134 0x7efcfc011c00 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query: pad has no peer 0:00:01.553970061 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.554448893 10134 0x7efdb400d450 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1280, height=(int)720, framerate=(fraction)30/1 0:00:01.554562850 10134 0x7efdb400d450 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.554577487 10134 0x7efdb400d450 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1280, height=(int)720, framerate=(fraction)30/1 0:00:01.554815770 10134 0x7efdb400d450 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)30/1, format=(string)RGBA 0:00:01.554858564 10134 0x7efdb400d450 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.554871982 10134 0x7efdb400d450 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)30/1, format=(string)RGBA 0:00:01.554900122 10134 0x7efdb400d450 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)30/1, format=(string)RGBA 0:00:01.557824635 10134 0x7efcfc0119e0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.564937030 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.607000316 10134 0x7efd080369e0 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:01.607073785 10134 0x7efd080369e0 INFO basesrc gstbasesrc.c:2843:gst_base_src_loop: marking pending DISCONT 0:00:01.607205652 10134 0x7efd080369e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event application/x-rtcp, ssrc=(uint)408537352 0:00:01.607231928 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_408537352' 0:00:01.607247345 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'rtcp_src_408537352' 0:00:01.607270154 10134 0x7efd080369e0 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "rtpjitterbuffer" 0:00:01.607461155 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.607477493 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.607496441 10134 0x7efd080369e0 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "rtpptdemux" 0:00:01.607585228 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.607647035 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstutils.c:1573:gst_element_link_pads_full: trying to link element rtpjitterbuffer0:src to element rtpptdemux0:sink 0:00:01.607669871 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpjitterbuffer0:src 0:00:01.607682164 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpptdemux0:sink 0:00:01.607694413 10134 0x7efd080369e0 INFO GST_PADS gstutils.c:1446:prepare_link_maybe_ghosting: rtpjitterbuffer0 and rtpptdemux0 in same bin, no need for ghost pads 0:00:01.607712158 10134 0x7efd080369e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtpjitterbuffer0:src and rtpptdemux0:sink 0:00:01.607727262 10134 0x7efd080369e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtpjitterbuffer0:src and rtpptdemux0:sink, successful 0:00:01.607740689 10134 0x7efd080369e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.607754875 10134 0x7efd080369e0 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.607774853 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PLAYING, next PAUSED 0:00:01.607789675 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PLAYING pending) 0:00:01.607816142 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PLAYING 0:00:01.607824526 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.607833844 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.607858511 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.607879862 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.607883309 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.607895840 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.607926793 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.607953212 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.607952142 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PLAYING, next PAUSED 0:00:01.607982140 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PLAYING pending) 0:00:01.608003596 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PLAYING 0:00:01.608006918 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.608080172 10134 0x7efd080369e0 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efd0803d750 on task 0x7efd08047950 0:00:01.608097214 10134 0x7efd080369e0 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efd08047950 0:00:01.608132281 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.608159187 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.608175750 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.608196647 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.608202228 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.608215043 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.608246407 10134 0x7efd080369e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.608271958 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpssrcdemux0:src_408537352 0:00:01.608273731 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.608285887 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpjitterbuffer0:sink 0:00:01.608316643 10134 0x7efd080369e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtpssrcdemux0:src_408537352 and rtpjitterbuffer0:sink 0:00:01.608331503 10134 0x7efd080369e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtpssrcdemux0:src_408537352 and rtpjitterbuffer0:sink, successful 0:00:01.608345014 10134 0x7efd080369e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.608372485 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtpssrcdemux0:rtcp_src_408537352 0:00:01.608385883 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'sink_rtcp' in element "rtpjitterbuffer0" 0:00:01.608417741 10134 0x7efd080369e0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink_rtcp' 0:00:01.608434226 10134 0x7efd080369e0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtpssrcdemux0:rtcp_src_408537352 and rtpjitterbuffer0:sink_rtcp 0:00:01.608448383 10134 0x7efd080369e0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtpssrcdemux0:rtcp_src_408537352 and rtpjitterbuffer0:sink_rtcp, successful 0:00:01.608461101 10134 0x7efd080369e0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.614037599 10134 0x7efd08036990 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:01.614075446 10134 0x7efd08036990 INFO basesrc gstbasesrc.c:2843:gst_base_src_loop: marking pending DISCONT 0:00:01.614115763 10134 0x7efd08036990 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)97, clock-rate=(int)90000, encoding-name=(string)H264, packetization-mode=(string)1, profile-level-id=(string)640029, sprop-parameter-sets=(string)"Z2QAKa0AzlAUAW7ARAAALuAACvyDgAAAC+vCAAAHc1lIvfjAAAAF9eEAAAMDuaykXvwbQRCJSw\=\=\,aP48sA\=\=", a-framesize=(string)1280-720, a-sdplang=(string)en, a-cliprect=(string)"0\,0\,720\,1280", a-framerate=(string)30.0, ssrc=(uint)408537352, clock-base=(uint)0, seqnum-base=(uint)1, npt-start=(guint64)0, npt-stop=(guint64)493062000000, play-speed=(double)1, play-scale=(double)1 0:00:01.614189144 10134 0x7efd08036990 INFO rtpjitterbuffer rtpjitterbuffer.c:449:calculate_skew: resync to time 0:00:00.412134485, rtptime 0:00:00.000000000 0:00:01.614407741 10134 0x7efcb80030f0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)97, clock-rate=(int)90000, encoding-name=(string)H264, packetization-mode=(string)1, profile-level-id=(string)640029, sprop-parameter-sets=(string)"Z2QAKa0AzlAUAW7ARAAALuAACvyDgAAAC+vCAAAHc1lIvfjAAAAF9eEAAAMDuaykXvwbQRCJSw\=\=\,aP48sA\=\=", a-framesize=(string)1280-720, a-sdplang=(string)en, a-cliprect=(string)"0\,0\,720\,1280", a-framerate=(string)30.0, ssrc=(uint)408537352, clock-base=(uint)0, seqnum-base=(uint)1, npt-start=(guint64)0, npt-stop=(guint64)493062000000, play-speed=(double)1, play-scale=(double)1 0:00:01.614529858 10134 0x7efcb80030f0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_97' 0:00:01.614622278 10134 0x7efcb80030f0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtpptdemux0:src_97 and recv_rtp_src_0_408537352_97:proxypad28 0:00:01.614660095 10134 0x7efcb80030f0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtpptdemux0:src_97 and recv_rtp_src_0_408537352_97:proxypad28, successful 0:00:01.614684004 10134 0x7efcb80030f0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.614742058 10134 0x7efcb80030f0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'recv_rtp_src_0_408537352_97' 0:00:01.614850621 10134 0x7efcb80030f0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link manager:recv_rtp_src_0_408537352_97 and recv_rtp_src_0_408537352_97:proxypad29 0:00:01.614882517 10134 0x7efcb80030f0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked manager:recv_rtp_src_0_408537352_97 and recv_rtp_src_0_408537352_97:proxypad29, successful 0:00:01.614930777 10134 0x7efcb80030f0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.614990034 10134 0x7efcb80030f0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'recv_rtp_src_0_408537352_97' 0:00:01.615070554 10134 0x7efcb80030f0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad queue1_0:sink 0:00:01.615103660 10134 0x7efcb80030f0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtspsrc_0:recv_rtp_src_0_408537352_97 and queue1_0:sink 0:00:01.615180250 10134 0x7efcb80030f0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtspsrc_0:recv_rtp_src_0_408537352_97 and queue1_0:sink, successful 0:00:01.615209784 10134 0x7efcb80030f0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.615426402 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)97, clock-rate=(int)90000, encoding-name=(string)H264, packetization-mode=(string)1, profile-level-id=(string)640029, sprop-parameter-sets=(string)"Z2QAKa0AzlAUAW7ARAAALuAACvyDgAAAC+vCAAAHc1lIvfjAAAAF9eEAAAMDuaykXvwbQRCJSw\=\=\,aP48sA\=\=", a-framesize=(string)1280-720, a-sdplang=(string)en, a-cliprect=(string)"0\,0\,720\,1280", a-framerate=(string)30.0, ssrc=(uint)408537352, clock-base=(uint)0, seqnum-base=(uint)1, npt-start=(guint64)0, npt-stop=(guint64)493062000000, play-speed=(double)1, play-scale=(double)1 0:00:01.615503737 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad typefind:src 0:00:01.615518528 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad typefind:sink 0:00:01.615604930 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link typefind:src and decodepad3:proxypad30 0:00:01.615620265 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked typefind:src and decodepad3:proxypad30, successful 0:00:01.615631274 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.616685926 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking typefind:src(0x7efdb4020b80) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.616710501 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked typefind:src and decodepad3:proxypad30 0:00:01.616726355 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link typefind:src and decodepad3:proxypad30 0:00:01.616739449 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked typefind:src and decodepad3:proxypad30, successful 0:00:01.616751264 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.616770144 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking typefind:src(0x7efdb4020b80) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.616785406 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked typefind:src and decodepad3:proxypad30 0:00:01.617839492 10134 0x7efdbc00aed0 INFO GST_PLUGIN_LOADING gstplugin.c:842:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstrtp.so" loaded 0:00:01.617859236 10134 0x7efdbc00aed0 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "rtph264depay" 0:00:01.617947802 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.617967913 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.618032749 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link typefind:src and rtph264depay0:sink 0:00:01.618048433 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked typefind:src and rtph264depay0:sink, successful 0:00:01.618059353 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.618076087 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.618085329 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.618112016 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.618130478 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad rtph264depay0:src 0:00:01.618149715 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtph264depay0:src and decodepad3:proxypad30 0:00:01.618161293 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtph264depay0:src and decodepad3:proxypad30, successful 0:00:01.618171626 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.618179315 10134 0x7efdbc00aed0 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.618206004 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.618216381 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.618239832 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.618279251 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.618323904 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-h264, stream-format=(string)avc, alignment=(string)au, codec_data=(buffer)01640029ffe1003767640029ad00ce5014016ec04400002ee0000afc838000000bebc2000007735948bdf8c0000005f5e100000303b9aca45efc1b4110894b01000468fe3cb0, level=(string)4.1, profile=(string)high 0:00:01.618363268 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking rtph264depay0:src(0x7efcb801b010) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.618386035 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked rtph264depay0:src and decodepad3:proxypad30 0:00:01.618402533 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtph264depay0:src and decodepad3:proxypad30 0:00:01.618416077 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtph264depay0:src and decodepad3:proxypad30, successful 0:00:01.618426008 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.618548421 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking rtph264depay0:src(0x7efcb801b010) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.618567746 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked rtph264depay0:src and decodepad3:proxypad30 0:00:01.618582815 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtph264depay0:src and decodepad3:proxypad30 0:00:01.618593119 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtph264depay0:src and decodepad3:proxypad30, successful 0:00:01.618602957 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.618622173 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking rtph264depay0:src(0x7efcb801b010) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.618635773 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked rtph264depay0:src and decodepad3:proxypad30 0:00:01.618649459 10134 0x7efdbc00aed0 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "h264parse" 0:00:01.618678168 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.618696561 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.618718975 10134 0x7efdbc00aed0 INFO baseparse gstbaseparse.c:3942:gst_base_parse_set_pts_interpolation: PTS interpolation: no 0:00:01.618742973 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link rtph264depay0:src and h264parse1:sink 0:00:01.618769488 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked rtph264depay0:src and h264parse1:sink, successful 0:00:01.618780288 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.618796488 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.618805641 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.618831834 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad h264parse1:src 0:00:01.618848483 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link h264parse1:src and decodepad3:proxypad30 0:00:01.618859625 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked h264parse1:src and decodepad3:proxypad30, successful 0:00:01.618869501 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.618868238 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.618877861 10134 0x7efdbc00aed0 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.619068398 10134 0x7efdbc00aed0 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "capsfilter" 0:00:01.619096803 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.619112836 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.619128961 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.619143598 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from NULL to READY, pending PAUSED, next PAUSED 0:00:01.619154340 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (PAUSED pending) 0:00:01.619166892 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change READY to PAUSED, final PAUSED 0:00:01.619180985 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.619189676 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.619207127 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking h264parse1:src(0x7efcb801b490) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.619230660 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked h264parse1:src and decodepad3:proxypad30 0:00:01.619245740 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad capsfilter1:sink 0:00:01.619257165 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link h264parse1:src and capsfilter1:sink 0:00:01.619267662 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked h264parse1:src and capsfilter1:sink, successful 0:00:01.619277954 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.619286252 10134 0x7efdbc00aed0 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.619297563 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad capsfilter1:src 0:00:01.619308532 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter1:src and decodepad3:proxypad30 0:00:01.619318664 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter1:src and decodepad3:proxypad30, successful 0:00:01.619328633 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.619337636 10134 0x7efdbc00aed0 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.619567835 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.619582202 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.619646220 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.619679053 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.619797882 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.619866399 10134 0x7efdbc00aed0 INFO typefind gsttypefindelement.c:180:gst_type_find_element_have_type: found caps application/x-rtp, media=(string)video, payload=(int)97, clock-rate=(int)90000, encoding-name=(string)H264, packetization-mode=(string)1, profile-level-id=(string)640029, sprop-parameter-sets=(string)"Z2QAKa0AzlAUAW7ARAAALuAACvyDgAAAC+vCAAAHc1lIvfjAAAAF9eEAAAMDuaykXvwbQRCJSw\=\=\,aP48sA\=\=", a-framesize=(string)1280-720, a-sdplang=(string)en, a-cliprect=(string)"0\,0\,720\,1280", a-framerate=(string)30.0, ssrc=(uint)408537352, clock-base=(uint)0, seqnum-base=(uint)1, npt-start=(guint64)0, npt-stop=(guint64)493062000000, play-speed=(double)1, play-scale=(double)1, probability=100 0:00:01.619949893 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event time segment start=0:00:00.412134485, offset=0:00:00.000000000, stop=0:08:13.474134485, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.412134485, position 0:00:00.412134485, duration 99:99:99.999999999 0:00:01.624230426 10134 0x7efdbc00aed0 INFO h264parse gsth264parse.c:777:gst_h264_parse_process_nal: have SPS/PPS in stream 0:00:01.624369836 10134 0x7efdbc00aed0 INFO h264parse gsth264parse.c:1736:gst_h264_parse_update_src_caps: resolution changed 1280x720 0:00:01.624387043 10134 0x7efdbc00aed0 INFO h264parse gsth264parse.c:1760:gst_h264_parse_update_src_caps: pixel aspect ratio has been changed 1/1 0:00:01.624407409 10134 0x7efdbc00aed0 INFO h264parse gsth264parse.c:1793:gst_h264_parse_update_src_caps: PAR 1/1 0:00:01.624426326 10134 0x7efdbc00aed0 INFO baseparse gstbaseparse.c:3985:gst_base_parse_set_latency: min/max latency 0:00:00.033333333, 0:00:00.033333333 0:00:01.624481916 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.624544875 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, level=(string)4.1, profile=(string)high, pixel-aspect-ratio=(fraction)1/1, width=(int)1280, height=(int)720, framerate=(fraction)30/1, parsed=(boolean)true 0:00:01.624640662 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.624661229 10134 0x7efdbc00aed0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.624674379 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, level=(string)4.1, profile=(string)high, pixel-aspect-ratio=(fraction)1/1, width=(int)1280, height=(int)720, framerate=(fraction)30/1, parsed=(boolean)true 0:00:01.624709355 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter1:src(0x7efcb801b910) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.624734132 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter1:src and decodepad3:proxypad30 0:00:01.624757055 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter1:src and decodepad3:proxypad30 0:00:01.624771899 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter1:src and decodepad3:proxypad30, successful 0:00:01.624786105 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.624963472 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter1:src(0x7efcb801b910) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.624988428 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter1:src and decodepad3:proxypad30 0:00:01.625009555 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter1:src and decodepad3:proxypad30 0:00:01.625024168 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter1:src and decodepad3:proxypad30, successful 0:00:01.625038025 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.625102593 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter1:src(0x7efcb801b910) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.625117949 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter1:src and decodepad3:proxypad30 0:00:01.625132648 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter1:src and decodepad3:proxypad30 0:00:01.625142760 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter1:src and decodepad3:proxypad30, successful 0:00:01.625158511 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.625187375 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2071:gst_pad_unlink: unlinking capsfilter1:src(0x7efcb801b910) and decodepad3:proxypad30(0x7efd040060e0) 0:00:01.625201911 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstpad.c:2125:gst_pad_unlink: unlinked capsfilter1:src and decodepad3:proxypad30 0:00:01.625215884 10134 0x7efdbc00aed0 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "nvdec_h264" 0:00:01.625242444 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'sink' 0:00:01.625259455 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src' 0:00:01.625287339 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link capsfilter1:src and nvcuvidh264dec1:sink 0:00:01.625299902 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked capsfilter1:src and nvcuvidh264dec1:sink, successful 0:00:01.625310017 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.625337595 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to READY 0:00:01.625347433 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed NULL to READY (VOID_PENDING pending) 0:00:01.625381261 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query: pad has no peer 0:00:01.625411148 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.625419897 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad nvcuvidh264dec1:src 0:00:01.625466170 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link nvcuvidh264dec1:src and decodepad3:proxypad30 0:00:01.625479101 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked nvcuvidh264dec1:src and decodepad3:proxypad30, successful 0:00:01.625489732 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.625498299 10134 0x7efdbc00aed0 INFO GST_EVENT gstpad.c:5634:gst_pad_send_event_unchecked: Received event on flushing pad. Discarding 0:00:01.625518953 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.625533722 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.625566234 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.625585207 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.628232960 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PAUSED 0:00:01.628259287 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:01.628261275 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.628276460 10134 0x7efdb400d450 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.628338234 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PLAYING 0:00:01.628340246 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.628355148 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:3267:bin_handle_async_done: continue state change, pending PLAYING 0:00:01.628385457 10134 0x7efdb400d450 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.628400216 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.628410736 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.628557441 10134 0x7efd20003000 INFO GST_STATES gstbin.c:3061:gst_bin_continue_func: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.628628759 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.628713692 10134 0x7efd20003000 INFO GST_EVENT gstevent.c:1253:gst_event_new_latency: creating latency event 0:00:00.000000000 0:00:01.628711956 10134 0x7efdbc00aed0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", bitrate=(uint)26281680; 0:00:01.628711499 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.628813859 10134 0x7efd20003000 INFO bin gstbin.c:2593:gst_bin_do_latency_func: configured latency of 0:00:00.000000000 0:00:01.628821539 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:4098:gst_pad_peer_query:<'':decodepad3> pad has no peer 0:00:01.628839764 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.628857093 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.628869400 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.628876299 10134 0x7efdbc00aed0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.628878877 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.628923457 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsink_1' changed state to 4(PLAYING) successfully 0:00:01.628934771 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.628944129 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.628950946 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.628960975 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'filter2_1' changed state to 4(PLAYING) successfully 0:00:01.628970066 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.628969285 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message [2019-06-12 14:36:06.695 0x65FFF700 GST] CH(02) SRC_INFO, video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)30/1, format=(string)RGBA 0:00:01.628978415 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629013207 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629031469 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'conv_1' changed state to 4(PLAYING) successfully 0:00:01.629037618 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629041767 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629067278 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629074835 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) [2019-06-12 14:36:06.696 0x65FFF700 GST] CH(02) Save source pipeline.(GST_DEBUG_DUMP_DOT_DIR required) 0:00:01.629088945 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'filter1_1' changed state to 4(PLAYING) successfully 0:00:01.629092255 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629101056 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629122309 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629129244 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629142820 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvconv_1' changed state to 4(PLAYING) successfully 0:00:01.629146072 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629163153 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:1915:gst_bin_get_state_func: getting state 0:00:01.629155574 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629191787 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629182987 10134 0x7efdb400d450 INFO GST_STATES gstelement.c:2090:gst_element_get_state_func: waiting for element to commit state 0:00:01.629218224 10134 0x7efdb400d450 INFO GST_STATES gstelement.c:2104:gst_element_get_state_func: timed out 0:00:01.629239423 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_sink_1' changed state to 4(PLAYING) successfully 0:00:01.629241545 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629251485 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629277985 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629290211 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629294387 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:1915:gst_bin_get_state_func: getting state 0:00:01.629304958 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629341058 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629339032 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'fake_sink_1' changed state to 4(PLAYING) successfully 0:00:01.629367652 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629377796 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629386405 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629403718 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'fake_queue_1' changed state to 4(PLAYING) successfully 0:00:01.629419134 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629422998 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629444552 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629452708 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629469507 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'src_queue_1' changed state to 4(PLAYING) successfully 0:00:01.629472304 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629483363 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629505427 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629514007 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629531174 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'src_tee_1' changed state to 4(PLAYING) successfully 0:00:01.629533694 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629543388 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629569123 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629588072 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629597650 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629606057 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629625297 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvcuvidh264dec0' changed state to 4(PLAYING) successfully 0:00:01.629627737 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629638203 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629659626 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629667810 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629685383 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'capsfilter0' changed state to 4(PLAYING) successfully 0:00:01.629687821 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629698941 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629720263 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629729315 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629747039 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'h264parse0' changed state to 4(PLAYING) successfully 0:00:01.629749564 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629760310 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629782161 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629789632 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629803270 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'avdec_aac0' changed state to 4(PLAYING) successfully 0:00:01.629806191 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629814575 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629835592 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629845519 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629863201 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'aacparse0' changed state to 4(PLAYING) successfully 0:00:01.629865711 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629876506 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629897602 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629906857 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629923971 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'multiqueue0' changed state to 4(PLAYING) successfully 0:00:01.629926577 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.629937510 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.629964093 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.629973239 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.629990684 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'qtdemux0' changed state to 4(PLAYING) successfully 0:00:01.629994210 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.630001378 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:1915:gst_bin_get_state_func: getting state 0:00:01.630003724 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.630034711 10134 0x7efdb400d450 INFO GST_STATES gstelement.c:2090:gst_element_get_state_func: waiting for element to commit state 0:00:01.630045780 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.630058351 10134 0x7efdb400d450 INFO GST_STATES gstelement.c:2104:gst_element_get_state_func: timed out 0:00:01.630068757 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.630098435 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'typefind' changed state to 4(PLAYING) successfully 0:00:01.630101517 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.630111998 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.630130609 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.630148095 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'decodebin0' changed state to 4(PLAYING) successfully 0:00:01.630150083 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.630160158 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.630181782 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.630189607 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.630206498 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'source' changed state to 4(PLAYING) successfully 0:00:01.630209453 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.630218660 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.630238607 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.630255167 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'uridecodebin_1' changed state to 4(PLAYING) successfully 0:00:01.630258013 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.630267529 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.630287238 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.630303523 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_src_1' changed state to 4(PLAYING) successfully 0:00:01.630306393 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.630315540 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.630335093 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.630353970 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.630703393 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:1915:gst_bin_get_state_func: getting state 0:00:01.630890336 10134 0x7efdb400d450 INFO GST_STATES gstbin.c:1915:gst_bin_get_state_func: getting state 0:00:01.632416046 10134 0x7efdb400d450 INFO default gstdebugutils.c:811:gst_debug_bin_to_dot_file: wrote bin graph to : '/home/gamsi/test/test_pipeline/CH#2.dot' 0:00:01.632467984 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)7062240, maximum-bitrate=(uint)7062240; 0:00:01.632584923 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)136125; 0:00:01.661308382 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)3430080, maximum-bitrate=(uint)7062240; 0:00:01.661342864 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)128249; 0:00:01.670197474 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)2374800, maximum-bitrate=(uint)7062240; 0:00:01.697837049 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)123749; 0:00:01.802660685 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.834824396 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)2336160, maximum-bitrate=(uint)7062240; 0:00:01.835192595 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)NV12, width=(int)1280, height=(int)720, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, chroma-site=(string)mpeg2, colorimetry=(string)bt709, framerate=(fraction)30/1 0:00:01.835250370 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:659:gst_element_add_pad: adding pad 'src_0' 0:00:01.835291288 10134 0x7efdbc00aed0 INFO GST_ELEMENT_PADS gstelement.c:907:gst_element_get_static_pad: found pad tee_0:sink 0:00:01.835320897 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2315:gst_pad_link_prepare: trying to link decodebin_0:src_0 and tee_0:sink 0:00:01.835578167 10134 0x7efdbc00aed0 INFO GST_PADS gstpad.c:2521:gst_pad_link_full: linked decodebin_0:src_0 and tee_0:sink, successful 0:00:01.835596948 10134 0x7efdbc00aed0 INFO GST_EVENT gstevent.c:1382:gst_event_new_reconfigure: creating reconfigure event 0:00:01.835642569 10134 0x7efdbc00aed0 INFO decodebin gstdecodebin2.c:4664:gst_decode_bin_expose: added new decoded pad 0:00:01.835666828 10134 0x7efdbc00aed0 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PAUSED 0:00:01.835684416 10134 0x7efdbc00aed0 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:01.835697941 10134 0x7efdbc00aed0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.835738447 10134 0x7efdbc00aed0 INFO GST_STATES gstbin.c:3247:bin_handle_async_done: setting state from PAUSED to PAUSED, pending PLAYING 0:00:01.835739488 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.835759796 10134 0x7efdbc00aed0 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:01.835947075 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.836479435 10134 0x7efdbc00af70 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1280, height=(int)720, framerate=(fraction)30/1 0:00:01.836593695 10134 0x7efdbc00af70 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.836606944 10134 0x7efdbc00af70 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1280, height=(int)720, framerate=(fraction)30/1 0:00:01.836839261 10134 0x7efdbc00af70 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)30/1, format=(string)RGBA 0:00:01.836878268 10134 0x7efdbc00af70 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.836889626 10134 0x7efdbc00af70 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)30/1, format=(string)RGBA 0:00:01.836921176 10134 0x7efdbc00af70 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)720, framerate=(fraction)30/1, format=(string)RGBA 0:00:01.845691118 10134 0x7efdbc00aed0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.854584153 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.873656103 10134 0x7efdbc00af70 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PAUSED 0:00:01.873683828 10134 0x7efdbc00af70 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:01.873683665 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.873702508 10134 0x7efdbc00af70 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.873763457 10134 0x7efdbc00af70 INFO GST_STATES gstbin.c:3247:bin_handle_async_done: setting state from PAUSED to PAUSED, pending PLAYING 0:00:01.873780552 10134 0x7efdbc00af70 INFO GST_STATES gstbin.c:3267:bin_handle_async_done: continue state change, pending PLAYING 0:00:01.873766642 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.873848435 10134 0x7efd20003000 INFO GST_STATES gstbin.c:3061:gst_bin_continue_func: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.874077104 10134 0x7efd20003000 INFO GST_EVENT gstevent.c:1253:gst_event_new_latency: creating latency event 0:00:02.033333333 0:00:01.874225677 10134 0x7efd20003000 INFO bin gstbin.c:2593:gst_bin_do_latency_func: configured latency of 0:00:02.033333333 0:00:01.874257811 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.874285567 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.874307154 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.874323491 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.874354377 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsink_0' changed state to 4(PLAYING) successfully 0:00:01.874381247 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.874396561 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.874399824 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.874408277 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.874461981 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'filter2_0' changed state to 4(PLAYING) successfully 0:00:01.874466887 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.874483177 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.874518067 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.874530340 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.874553650 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'conv_0' changed state to 4(PLAYING) successfully 0:00:01.874558207 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.874573180 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.874603664 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.874616224 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.874642443 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.874639900 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'filter1_0' changed state to 4(PLAYING) successfully 0:00:01.874677020 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.874693687 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.874705677 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.874729620 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvconv_0' changed state to 4(PLAYING) successfully 0:00:01.874732050 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.874749947 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.874778340 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.874804620 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.874803396 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_sink_0' changed state to 4(PLAYING) successfully 0:00:01.874835013 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.874860196 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:01.874874080 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:01.874886853 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'fakesink_0' changed state to 4(PLAYING) successfully 0:00:01.874902533 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:01.874932833 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:01.874944936 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'queue3_0' changed state to 4(PLAYING) successfully 0:00:01.874961263 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:01.874974673 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:01.874986866 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'queue2_0' changed state to 4(PLAYING) successfully 0:00:01.875002716 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:01.875015513 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:01.875027820 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'tee_0' changed state to 4(PLAYING) successfully 0:00:01.875043123 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.875067713 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.875082933 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875094896 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875122856 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.875120093 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvcuvidh264dec1' changed state to 4(PLAYING) successfully 0:00:01.875160749 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.875177056 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875189056 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875212346 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'capsfilter1' changed state to 4(PLAYING) successfully 0:00:01.875214823 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.875232116 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.875258093 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875270489 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875293539 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'h264parse1' changed state to 4(PLAYING) successfully 0:00:01.875295852 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.875313142 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.875341719 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875354079 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875377402 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'rtph264depay0' changed state to 4(PLAYING) successfully 0:00:01.875379675 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.875395912 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.875423005 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875435009 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875457952 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'typefind' changed state to 4(PLAYING) successfully 0:00:01.875460159 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.875476915 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875502112 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875527899 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.875526405 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'decodebin_0' changed state to 4(PLAYING) successfully 0:00:01.875558969 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:01.875573432 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:01.875585819 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'queue1_0' changed state to 4(PLAYING) successfully 0:00:01.875600839 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:01.875625419 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'udpsink1' changed state to 4(PLAYING) successfully 0:00:01.875642435 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'manager' changed state to 4(PLAYING) successfully 0:00:01.875657282 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'udpsrc1' changed state to 4(PLAYING) successfully 0:00:01.875672035 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'udpsrc2' changed state to 4(PLAYING) successfully 0:00:01.875709415 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'udpsink0' changed state to 4(PLAYING) successfully 0:00:01.875723802 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'fakesrc0' changed state to 4(PLAYING) successfully 0:00:01.875739062 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875751612 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'rtspsrc_0' changed state to 4(PLAYING) successfully 0:00:01.875766285 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875778375 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875801625 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_src_0' changed state to 4(PLAYING) successfully 0:00:01.875803508 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.875819212 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.875846455 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.875871568 10134 0x1381d40 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.895437074 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.908269269 10134 0x7efdbc00aed0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", minimum-bitrate=(uint)2887200, maximum-bitrate=(uint)2887200, bitrate=(uint)4755984; 0:00:01.940668138 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)2261520, maximum-bitrate=(uint)7062240; 0:00:01.970584977 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.970604844 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)2193600, maximum-bitrate=(uint)7062240; 0:00:01.986809208 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.986822279 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.986834808 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_classifier' changed state to 3(PAUSED) successfully 0:00:01.986844848 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.986923908 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.986932293 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.986942304 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_conv' changed state to 3(PAUSED) successfully 0:00:01.986951370 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.986969363 10134 0x1381cf0 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efdc401d090 on task 0x7efd569da3b0 0:00:01.986992965 10134 0x1381cf0 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efd569da3b0 0:00:01.987013777 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987020205 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987028588 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_queue' changed state to 3(PAUSED) successfully 0:00:01.987040447 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987062021 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987071301 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_bin' changed state to 3(PAUSED) successfully 0:00:01.987082314 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987093047 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987099126 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987107724 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvstreammux' changed state to 3(PAUSED) successfully 0:00:01.987115514 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987130432 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987139955 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987146243 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987155027 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_filter_0' changed state to 3(PAUSED) successfully 0:00:01.987163225 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987199754 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987207469 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987217289 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_nvvid_0' changed state to 3(PAUSED) successfully 0:00:01.987227172 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987242198 10134 0x1381cf0 INFO basesrc gstbasesrc.c:1344:gst_base_src_do_seek: seeking: time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:01.987261769 10134 0x1381cf0 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x16ea9e0 on task 0x7efd569da4d0 0:00:01.987268878 10134 0x1381cf0 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efd569da4d0 0:00:01.987298509 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987305637 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987314832 10134 0x1381cf0 INFO GST_STATES gstbin.c:2807:gst_bin_change_state_func: child 'appsrc_0' changed state to 3(PAUSED) successfully without preroll 0:00:01.987324189 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987330417 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987338804 10134 0x1381cf0 INFO GST_STATES gstbin.c:2807:gst_bin_change_state_func: child 'bin_appsrc_0' changed state to 3(PAUSED) successfully without preroll 0:00:01.987346982 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987345465 10134 0x7efdc4006940 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'sink' in element "appsrc_0" 0:00:01.987360232 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987388645 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987388007 10134 0x7efdc4006940 FIXME default gstutils.c:3766:gst_pad_create_stream_id_internal: Creating random stream-id, consider implementing a deterministic way of creating a stream-id 0:00:01.987397204 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987420649 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_filter_1' changed state to 3(PAUSED) successfully 0:00:01.987429036 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987466373 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987474273 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987498189 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_nvvid_1' changed state to 3(PAUSED) successfully 0:00:01.987504813 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending VOID_PENDING, desired next PAUSED 0:00:01.987513364 10134 0x1381cf0 INFO basesrc gstbasesrc.c:1344:gst_base_src_do_seek: seeking: time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:01.987529613 10134 0x1381cf0 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x16eb520 on task 0x7efd0c0173b0 0:00:01.987537154 10134 0x1381cf0 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efd0c0173b0 0:00:01.987571208 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987578697 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987588547 10134 0x1381cf0 INFO GST_STATES gstbin.c:2807:gst_bin_change_state_func: child 'appsrc_1' changed state to 3(PAUSED) successfully without preroll 0:00:01.987598059 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PAUSED 0:00:01.987604317 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:01.987613274 10134 0x1381cf0 INFO GST_STATES gstbin.c:2807:gst_bin_change_state_func: child 'bin_appsrc_1' changed state to 3(PAUSED) successfully without preroll 0:00:01.987610422 10134 0x7efdc43f2370 INFO GST_ELEMENT_PADS gstelement.c:904:gst_element_get_static_pad: no such pad 'sink' in element "appsrc_1" 0:00:01.987623587 10134 0x1381cf0 INFO GST_STATES gstelement.c:2347:gst_element_continue_state: committing state from READY to PAUSED, pending PLAYING, next PLAYING 0:00:01.987645816 10134 0x7efdc43f2370 FIXME default gstutils.c:3766:gst_pad_create_stream_id_internal: Creating random stream-id, consider implementing a deterministic way of creating a stream-id 0:00:01.987646499 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (PLAYING pending) 0:00:01.987665091 10134 0x1381cf0 INFO GST_STATES gstelement.c:2354:gst_element_continue_state: continue state change PAUSED to PLAYING, final PLAYING 0:00:01.987727698 10134 0x1381cf0 INFO GST_EVENT gstevent.c:1253:gst_event_new_latency: creating latency event 0:00:00.000000000 0:00:01.987751066 10134 0x1381cf0 INFO bin gstbin.c:2593:gst_bin_do_latency_func: configured latency of 0:00:00.000000000 0:00:01.987767614 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current READY pending PAUSED, desired next PLAYING 0:00:01.987775950 10134 0x1381cf0 INFO GST_STATES gstbin.c:2770:gst_bin_change_state_func: child 'bin_sink' is changing state asynchronously to PLAYING 0:00:01.987784536 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.987796822 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.987804786 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.987811308 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.987820677 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvosd' changed state to 4(PLAYING) successfully 0:00:01.987829171 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.987836900 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.987843234 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.987852011 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'osd_conv' changed state to 4(PLAYING) successfully 0:00:01.987859931 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.987867466 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.987873743 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.987884274 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'osd_queue' changed state to 4(PLAYING) successfully 0:00:01.987892751 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.987898853 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.987908023 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'osd_bin' changed state to 4(PLAYING) successfully 0:00:01.987916456 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.987927451 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.987935024 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.987941533 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.987950291 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'display_tiler' changed state to 4(PLAYING) successfully 0:00:01.987958996 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.987966765 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.987973445 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.987981995 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'tiled_queue' changed state to 4(PLAYING) successfully 0:00:01.987990068 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.987996180 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988004808 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'display_tiler_bin' changed state to 4(PLAYING) successfully 0:00:01.988013036 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988023512 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988031337 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988037794 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988046932 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'secondary_gie_bin_queue' changed state to 4(PLAYING) successfully 0:00:01.988055636 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988063555 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988069976 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988078585 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'secondary_gie_bin_tee' changed state to 4(PLAYING) successfully 0:00:01.988102093 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988107996 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988116243 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'secondary_gie_bin' changed state to 4(PLAYING) successfully 0:00:01.988124172 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988133449 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988156035 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988162308 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988171093 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nv_tracker' changed state to 4(PLAYING) successfully 0:00:01.988178784 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988184780 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988193192 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'tracking_bin' changed state to 4(PLAYING) successfully 0:00:01.988201291 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988211462 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988219622 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988225850 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988234374 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_classifier' changed state to 4(PLAYING) successfully 0:00:01.988242712 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988250126 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988256605 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988264876 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_conv' changed state to 4(PLAYING) successfully 0:00:01.988272897 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988280153 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988286213 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988296653 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_queue' changed state to 4(PLAYING) successfully 0:00:01.988305268 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988311364 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988320109 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_bin' changed state to 4(PLAYING) successfully 0:00:01.988328624 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988337935 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988344287 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988352843 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvstreammux' changed state to 4(PLAYING) successfully 0:00:01.988364192 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988371829 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988378432 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988387334 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_filter_0' changed state to 4(PLAYING) successfully 0:00:01.988395774 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988403571 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988409790 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988418483 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_nvvid_0' changed state to 4(PLAYING) successfully 0:00:01.988431150 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988439408 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988449179 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_0' changed state to 4(PLAYING) successfully 0:00:01.988457341 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988449213 10134 0x7efdc4006940 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.988463386 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988485058 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_appsrc_0' changed state to 4(PLAYING) successfully 0:00:01.988496171 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988504106 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988510172 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988518779 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_filter_1' changed state to 4(PLAYING) successfully 0:00:01.988527265 10134 0x1381cf0 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:01.988534691 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988540915 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988555334 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_nvvid_1' changed state to 4(PLAYING) successfully 0:00:01.988572578 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988581426 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988590616 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_1' changed state to 4(PLAYING) successfully 0:00:01.988598740 10134 0x1381cf0 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:01.988605069 10134 0x1381cf0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:01.988590619 10134 0x7efdc43f2370 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.988613448 10134 0x1381cf0 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_appsrc_1' changed state to 4(PLAYING) successfully 0:00:01.989688602 10134 0x7efdc4006940 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.989740167 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.991353271 10134 0x7efdc43f2370 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.991369431 10134 0x7efdc4006940 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.991423001 10134 0x7efdc4006940 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.991455928 10134 0x7efdc43f2370 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.991472088 10134 0x7efdc43f2370 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.991561484 10134 0x7efdc4006940 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.991865577 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.992806512 10134 0x7efdc4006940 INFO task gsttask.c:451:gst_task_set_lock: setting stream lock 0x7efdc401cc10 on task 0x7efd0c017950 0:00:01.992834305 10134 0x7efdc4006940 INFO GST_PADS gstpad.c:5980:gst_pad_start_task: created task 0x7efd0c017950 0:00:01.992910745 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.992997842 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:01.993029342 10134 0x7efd08005c00 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.993060071 10134 0x7efd08005c00 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.993049822 10134 0x7efc94002ad0 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:01.993307628 10134 0x7efdc4006940 WARN structure gststructure.c:1935:priv_gst_structure_append_to_gstring: No value transform to serialize field 'device' of type 'gpointer' 0:00:01.993329931 10134 0x7efdc4006940 WARN structure gststructure.c:1935:priv_gst_structure_append_to_gstring: No value transform to serialize field 'name' of type 'gpointer' 0:00:01.993331301 10134 0x7efdc43f2370 WARN structure gststructure.c:1935:priv_gst_structure_append_to_gstring: No value transform to serialize field 'device' of type 'gpointer' 0:00:01.993289801 10134 0x7efdc4006940 INFO structure gststructure.c:3049:gst_structure_get_valist: Expected field 'free-func' in structure: buf-pool/config0, width=(uint)1280, height=(uint)720, max-buffers=(uint)4, num-batched-buffers=(uint)1, gpu_id=(uint)0, size=(uint)3686400, memtype=(uint)1, device=(gpointer)NULL, name=(gpointer)NULL; 0:00:01.993368315 10134 0x7efdc43f2370 WARN structure gststructure.c:1935:priv_gst_structure_append_to_gstring: No value transform to serialize field 'name' of type 'gpointer' 0:00:01.993313688 10134 0x7efdc43f2370 INFO structure gststructure.c:3049:gst_structure_get_valist: Expected field 'free-func' in structure: buf-pool/config0, width=(uint)1280, height=(uint)720, max-buffers=(uint)4, num-batched-buffers=(uint)1, gpu_id=(uint)0, size=(uint)3686400, memtype=(uint)1, device=(gpointer)NULL, name=(gpointer)NULL; 0:00:01.994200694 10134 0x7efd08005c00 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:01.995825431 10134 0x7efd08005c00 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:01.996302580 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)2164080, maximum-bitrate=(uint)7062240; 0:00:01.996419263 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)122999; 0:00:01.997071034 10134 0x7efd08005c00 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:02.004286390 10134 0x7efdbc00aed0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", minimum-bitrate=(uint)2854800, maximum-bitrate=(uint)2887200, bitrate=(uint)4583149; 0:00:02.016107919 10134 0x7efd08005c00 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.016503085 10134 0x7efdbc00aed0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", minimum-bitrate=(uint)2854800, maximum-bitrate=(uint)3950160, bitrate=(uint)4530400; 0:00:02.016535988 10134 0x7efdc42d59e0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:02.017069827 10134 0x7efdc42d59e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.017429602 10134 0x7efdc43f21e0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:02.017450004 10134 0x7efdc43f21e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.017482650 10134 0x7efdc43f21e0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:02.018604756 10134 0x7efdc43f21e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.018755375 10134 0x7efdc43f21e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.018803762 10134 0x7efdc43f21e0 INFO basetransform gstbasetransform.c:1367:gst_base_transform_setcaps: reuse caps 0:00:02.018810619 10134 0x7efdc43f21e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.018838448 10134 0x7efdc43f21e0 INFO GST_EVENT gstevent.c:679:gst_event_new_caps: creating caps event video/x-raw, format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.032661219 10134 0x7efdc43f2370 INFO GST_EVENT gstevent.c:760:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:02.032761399 10134 0x7efdc43f2370 INFO basesrc gstbasesrc.c:2843:gst_base_src_loop: marking pending DISCONT 0:00:02.034042183 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.034035263 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)1883520, maximum-bitrate=(uint)7062240; 0:00:02.069153144 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)1808400, maximum-bitrate=(uint)7062240; 0:00:02.096467048 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.101406111 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.101406563 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)1106640, maximum-bitrate=(uint)7062240; 0:00:02.162888568 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.171380155 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message [2019-06-12 14:36:07.256 0xAFA69700 GST] [FRAME_META] stream_id(1) frame_num(0) gie(type,batch_size,id)=(1,0,1) num(rects,strings)=(7,7) batch_id(0) nvosd_mode(GPU) 0:00:02.197772850 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)834960, maximum-bitrate=(uint)7062240; 0:00:02.221772185 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.221770103 10134 0x7efdc43f21e0 INFO GST_STATES gstbin.c:3238:bin_handle_async_done: committing state from READY to PAUSED, old pending PAUSED 0:00:02.221833854 10134 0x7efdc43f21e0 INFO GST_STATES gstbin.c:3258:bin_handle_async_done: completed state change, pending VOID 0:00:02.221849498 10134 0x7efdc43f21e0 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed READY to PAUSED (VOID_PENDING pending) 0:00:02.221875378 10134 0x7efdc43f21e0 INFO GST_STATES gstbin.c:3247:bin_handle_async_done: setting state from PAUSED to PAUSED, pending PLAYING 0:00:02.221877907 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.221891049 10134 0x7efdc43f21e0 INFO GST_STATES gstbin.c:3267:bin_handle_async_done: continue state change, pending PLAYING 0:00:02.221932538 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.221967858 10134 0x7efd20003000 INFO GST_STATES gstbin.c:3061:gst_bin_continue_func: continue state change PAUSED to PLAYING, final PLAYING 0:00:02.222172894 10134 0x7efd20003000 INFO GST_EVENT gstevent.c:1253:gst_event_new_latency: creating latency event 0:00:00.000000000 0:00:02.222278767 10134 0x7efd20003000 INFO bin gstbin.c:2593:gst_bin_do_latency_func: configured latency of 0:00:00.000000000 0:00:02.222315293 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:02.222339960 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:02.222360470 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.222373727 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:02.222402380 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsink0' changed state to 4(PLAYING) successfully 0:00:02.222405861 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.222424287 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:02.222452290 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.222464743 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) [2019-06-12 14:36:07.289 0xAFA69700 GST] [MAIN_APP_SINK] video/x-raw, format=(string)RGBA, width=(int)1280, height=(int)720, framerate=(fraction)0/1 0:00:02.222487867 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'filter1' changed state to 4(PLAYING) successfully 0:00:02.222491689 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.222510320 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next PLAYING 0:00:02.222538567 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.222550577 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:02.222572327 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvvidconv' changed state to 4(PLAYING) successfully 0:00:02.222574990 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.222591450 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.222622063 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:02.222650531 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.222650163 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_sink' changed state to 4(PLAYING) successfully 0:00:02.222686343 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.222708763 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.222722720 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.222735120 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvosd' changed state to 4(PLAYING) successfully 0:00:02.222750943 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.222764073 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.222776260 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'osd_conv' changed state to 4(PLAYING) successfully 0:00:02.222791233 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.222804613 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.222816659 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'osd_queue' changed state to 4(PLAYING) successfully 0:00:02.222831763 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.222844979 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'osd_bin' changed state to 4(PLAYING) successfully 0:00:02.222860359 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.222879296 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.222892436 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.222934082 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'display_tiler' changed state to 4(PLAYING) successfully 0:00:02.222950279 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.222963259 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.222978876 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'tiled_queue' changed state to 4(PLAYING) successfully 0:00:02.222993989 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.223009752 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'display_tiler_bin' changed state to 4(PLAYING) successfully 0:00:02.223025796 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223044689 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223058106 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223070346 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'secondary_gie_bin_queue' changed state to 4(PLAYING) successfully 0:00:02.223085826 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223099052 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223110919 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'secondary_gie_bin_tee' changed state to 4(PLAYING) successfully 0:00:02.223128519 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.223147366 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'secondary_gie_bin' changed state to 4(PLAYING) successfully 0:00:02.223162459 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223180056 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223193116 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223204932 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nv_tracker' changed state to 4(PLAYING) successfully 0:00:02.223219916 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.223232239 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'tracking_bin' changed state to 4(PLAYING) successfully 0:00:02.223247469 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223266616 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223282872 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223294766 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_classifier' changed state to 4(PLAYING) successfully 0:00:02.223310479 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223323292 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223344262 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_conv' changed state to 4(PLAYING) successfully 0:00:02.223359312 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223372289 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223384252 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_queue' changed state to 4(PLAYING) successfully 0:00:02.223398659 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.223411169 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'primary_gie_bin' changed state to 4(PLAYING) successfully 0:00:02.223426785 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223439722 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223451485 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'nvstreammux' changed state to 4(PLAYING) successfully 0:00:02.223465775 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223485902 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223499088 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223511022 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_filter_0' changed state to 4(PLAYING) successfully 0:00:02.223526478 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223539318 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223551155 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_nvvid_0' changed state to 4(PLAYING) successfully 0:00:02.223565862 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223578265 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223590018 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_0' changed state to 4(PLAYING) successfully 0:00:02.223604405 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.223617011 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_appsrc_0' changed state to 4(PLAYING) successfully 0:00:02.223631271 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223650228 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223663141 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223675745 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_filter_1' changed state to 4(PLAYING) successfully 0:00:02.223690618 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223703608 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223715441 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_nvvid_1' changed state to 4(PLAYING) successfully 0:00:02.223729971 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2316:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PLAYING 0:00:02.223742588 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2433:gst_bin_element_set_state: skipping transition from PLAYING to PLAYING 0:00:02.223754148 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'appsrc_1' changed state to 4(PLAYING) successfully 0:00:02.223768231 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.223780718 10134 0x7efd20003000 INFO GST_STATES gstbin.c:2764:gst_bin_change_state_func: child 'bin_appsrc_1' changed state to 4(PLAYING) successfully 0:00:02.223796485 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2372:gst_element_continue_state: completed state change to PLAYING 0:00:02.223808338 10134 0x7efd20003000 INFO GST_STATES gstelement.c:2277:_priv_gst_element_state_changed: notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending) 0:00:02.223837581 10134 0x1381cf0 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.229722972 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.230850061 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.230990466 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)122625; 0:00:02.264087465 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)834960, maximum-bitrate=(uint)8221920; 0:00:02.296354556 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.297487048 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.297524098 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)120750; 0:00:02.363020496 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.429623738 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.430961205 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.430968045 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)118875; 0:00:02.463552407 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)496080, maximum-bitrate=(uint)8221920; [2019-06-12 14:36:07.533 0xAFA69700 GST] [FRAME_META] stream_id(1) frame_num(0) gie(type,batch_size,id)=(1,0,1) num(rects,strings)=(7,7) batch_id(0) nvosd_mode(GPU) 0:00:02.497226022 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)115875; 0:00:02.562061427 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.562650249 10134 0x7efcfc0119e0 INFO videodecoder gstvideodecoder.c:1334:gst_video_decoder_sink_event_default: upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)", language-code=(string)en, bitrate=(uint)2454874, minimum-bitrate=(uint)429360, maximum-bitrate=(uint)8221920; 0:00:02.596083416 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.596107357 10134 0x7efcfc011c00 INFO audiodecoder gstaudiodecoder.c:2310:gst_audio_decoder_sink_eventfunc: upstream stream tags: taglist, audio-codec=(string)"MPEG-4\ AAC", maximum-bitrate=(uint)128284, bitrate=(uint)128284, language-code=(string)en, minimum-bitrate=(uint)113999; 0:00:02.662770220 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message [2019-06-12 14:36:07.782 0xAFA69700 GST] [FRAME_META] stream_id(1) frame_num(0) gie(type,batch_size,id)=(1,0,1) num(rects,strings)=(8,8) batch_id(0) nvosd_mode(GPU) 0:00:02.729819676 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message 0:00:02.795449726 10134 0x1381d90 INFO GST_BUS gstbus.c:567:gst_bus_timed_pop_filtered: we got woken up, recheck for message [2019-06-12 14:36:08.038 0xAFA69700 GST] [FRAME_META] stream_id(1) frame_num(0) gie(type,batch_size,id)=(1,0,1) num(rects,strings)=(9,9) batch_id(0) nvosd_mode(GPU) ^C root@DeepStream2:/mnt/shared/Build#