This thread has been locked.
If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.
Hi,
My goal is to get static FPS after the ducati264dec plugin and before the vpe plugin. But when i put videorate plagin between ducatih264dec and vpe pipelin drops.
Example of pipeline and bug log:
root@am57xx-evm:/run/media/sda1/Records# GST_DEBUG=*vpe*:9 gst-launch-1.0 filesrc location=2020-03-26-10-54-42.mp4 ! qtdemux ! h264parse ! ducatih264dec ! videorate ! vpe ! fakesink
Log
root@am57xx-evm:/run/media/sda1/Records# GST_DEBUG=*vpe*:9 gst-launch-1.0 filesrc location=2020-03-26-10-54-42.mp4 ! qtdemux ! h264parse ! ducatih264dec ! videorate ! vpe ! fakesink
Setting pipeline to PAUSED ...
0:00:00.081086893 1563 0x1918a0 DEBUG vpe gstvpe.c:1016:gst_vpe_change_state:<vpe0> begin: changing state NULL -> READY
0:00:00.081147405 1563 0x1918a0 DEBUG vpe gstvpe.c:1028:gst_vpe_change_state:<vpe0> parent state change returned: 1
0:00:00.081168227 1563 0x1918a0 DEBUG vpe gstvpe.c:1044:gst_vpe_change_state:<vpe0> end
0:00:00.124542805 1563 0x1918a0 DEBUG vpe gstvpe.c:1016:gst_vpe_change_state:<vpe0> begin: changing state READY -> PAUSED
0:00:00.124631947 1563 0x1918a0 DEBUG vpe gstvpe.c:724:gst_vpe_activate_mode:<vpe0> gst_vpe_activate_mode (active = 1)
0:00:00.124948008 1563 0x1918a0 DEBUG vpe gstvpe.c:731:gst_vpe_activate_mode:<vpe0> gst_pad_start_task returned 1
0:00:00.125010147 1563 0x1918a0 DEBUG vpe gstvpe.c:1028:gst_vpe_change_state:<vpe0> parent state change returned: 1
0:00:00.125039427 1563 0x1918a0 DEBUG vpe gstvpe.c:1044:gst_vpe_change_state:<vpe0> end
Pipeline is PREROLLING ...
0:00:00.129580592 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=stream-start
0:00:00.130028576 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.136124347 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=caps
0:00:00.136466435 1563 0x190030 DEBUG vpe gstvpe.c:115:gst_vpe_parse_input_caps:<vpe0> Input caps: video/x-raw, format=(string)NV12, width=(int)896, height=(int)400, framerate=(fraction)24000/1001, pixel-aspect-ratio=(fraction)4095/4096, drm_mem=(boolean)true
0:00:00.137209659 1563 0x190030 DEBUG vpe gstvpe.c:186:gst_vpe_set_output_caps:<vpe0> Downstream allowed caps: video/x-raw, format=(string)NV12, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ]; video/x-raw, format=(string)YUYV, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ]; video/x-raw, format=(string)YUY2, width=(int)[ 1, 2147483647 ], height=(int)[ 1, 2147483647 ], framerate=(fraction)[ 0/1, 2147483647/1 ]
0:00:00.137698797 1563 0x190030 DEBUG vpe gstvpe.c:231:gst_vpe_set_output_caps:<vpe0> Passthrough = TRUE
0:00:00.138069352 1563 0x190030 DEBUG vpe gstvpe.c:286:gst_vpe_set_output_caps:<vpe0> framerate conversion: from 24000/1001 to 24000/1001, repeat_factor: 1
0:00:00.138470976 1563 0x190030 INFO vpe gstvpe.c:755:gst_vpe_sink_setcaps:<vpe0> set caps done 1
0:00:00.139085368 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=segment
0:00:00.139332621 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.139617125 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.139934000 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.140197845 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.140444285 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.140793693 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.141071040 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.148944920 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=caps
0:00:00.149305552 1563 0x190030 DEBUG vpe gstvpe.c:115:gst_vpe_parse_input_caps:<vpe0> Input caps: video/x-raw, format=(string)NV12, width=(int)896, height=(int)400, framerate=(fraction)24000/1001, pixel-aspect-ratio=(fraction)4095/4096, drm_mem=(boolean)true, max-ref-frames=(int)21
0:00:00.149650243 1563 0x190030 DEBUG vpe gstvpe.c:121:gst_vpe_parse_input_caps:<vpe0> Already set caps comapred with the new caps, returned FALSE
0:00:00.150034299 1563 0x190030 DEBUG vpe gstvpe.c:231:gst_vpe_set_output_caps:<vpe0> Passthrough = TRUE
0:00:00.150367277 1563 0x190030 DEBUG vpe gstvpe.c:286:gst_vpe_set_output_caps:<vpe0> framerate conversion: from 24000/1001 to 24000/1001, repeat_factor: 1
0:00:00.150945883 1563 0x190030 INFO vpe gstvpe.c:755:gst_vpe_sink_setcaps:<vpe0> set caps done 1
0:00:00.176332130 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.176772469 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.189328546 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.189716832 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.202571728 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.202779290 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.206226360 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.006675010 ( ptr 0xb5324a18)
0:00:00.206301512 1563 0x190030 DEBUG vpe gstvpe.c:550:gst_vpe_create:<vpe0> dce_init() done
0:00:00.206405456 1563 0x190030 DEBUG vpe gstvpe.c:115:gst_vpe_parse_input_caps:<vpe0> Input caps: video/x-raw, format=(string)NV12, width=(int)896, height=(int)400, framerate=(fraction)24000/1001, pixel-aspect-ratio=(fraction)4095/4096, drm_mem=(boolean)true, max-ref-frames=(int)21
0:00:00.206534288 1563 0x190030 DEBUG vpe gstvpe.c:121:gst_vpe_parse_input_caps:<vpe0> Already set caps comapred with the new caps, returned TRUE
0:00:00.206697930 1563 0x190030 DEBUG vpe gstvpe.c:577:gst_vpe_init_input_bufs:<vpe0> Using min input buffers: 12
0:00:00.206757304 1563 0x190030 DEBUG vpe gstvpe.c:578:gst_vpe_init_input_bufs:<vpe0> parse/set caps done
0:00:00.207118912 1563 0x190030 DEBUG vpe gstvpe.c:584:gst_vpe_init_input_bufs:<vpe0> gst_vpe_init_input_buffers done
0:00:00.207233429 1563 0x190030 DEBUG vpe gstvpe.c:231:gst_vpe_set_output_caps:<vpe0> Passthrough = FALSE
0:00:00.207380968 1563 0x190030 DEBUG vpe gstvpe.c:286:gst_vpe_set_output_caps:<vpe0> framerate conversion: from 24000/1001 to 24000/1001, repeat_factor: 1
0:00:00.207668400 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5324a18
0:00:00.207729888 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.207804714 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 0/128, 0
0:00:00.207915002 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.208044648 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 0
0:00:00.208141922 1563 0x190030 DEBUG vpe gstvpe.c:599:gst_vpe_set_streaming:<vpe0> Calling open(/dev/v4l/by-path/platform-489d0000.vpe-video-index0)
0:00:00.208312560 1563 0x190030 DEBUG vpe gstvpe.c:605:gst_vpe_set_streaming:<vpe0> Opened /dev/v4l/by-path/platform-489d0000.vpe-video-index0
0:00:00.208428541 1563 0x190030 DEBUG vpe gstvpe.c:531:gst_vpe_print_driver_capabilities:<vpe0> driver: 'vpe'
0:00:00.208504344 1563 0x190030 DEBUG vpe gstvpe.c:532:gst_vpe_print_driver_capabilities:<vpe0> card: 'vpe'
0:00:00.208745416 1563 0x190030 DEBUG vpe gstvpe.c:533:gst_vpe_print_driver_capabilities:<vpe0> bus_info: 'platform:vpe'
0:00:00.208848709 1563 0x190030 DEBUG vpe gstvpe.c:534:gst_vpe_print_driver_capabilities:<vpe0> version: 0004133b
0:00:00.209040818 1563 0x190030 DEBUG vpe gstvpe.c:535:gst_vpe_print_driver_capabilities:<vpe0> capabilites: 84204000
0:00:00.209159240 1563 0x190030 DEBUG vpe gstvpe.c:433:gst_vpe_input_set_fmt:<vpe0> input S_FMT field: 0, image: 896x400, numbufs: 12
0:00:00.209280914 1563 0x190030 DEBUG vpe gstvpe.c:441:gst_vpe_input_set_fmt:<vpe0> sizeimage[0] = 537600, sizeimage[1] = 0
0:00:00.209406493 1563 0x190030 DEBUG vpe gstvpe.c:450:gst_vpe_input_set_fmt:<vpe0> Crop values: top: 24, left: 32, width: 720, height: 304
0:00:00.209533048 1563 0x190030 DEBUG vpe gstvpe.c:356:gst_vpe_output_set_fmt:<vpe0> vpe: output S_FMT image: 720x304
0:00:00.209704986 1563 0x190030 DEBUG vpe gstvpe.c:364:gst_vpe_output_set_fmt:<vpe0> sizeimage[0] = 328320, sizeimage[1] = 0
0:00:00.209779976 1563 0x190030 DEBUG vpe gstvpe.c:577:gst_vpe_init_input_bufs:<vpe0> Using min input buffers: 12
0:00:00.209890101 1563 0x190030 DEBUG vpe gstvpe.c:578:gst_vpe_init_input_bufs:<vpe0> parse/set caps done
0:00:00.210060576 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210177370 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210289773 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210401362 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210511000 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210657725 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210772568 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210883669 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.210994120 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.211104570 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.211217136 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.211346293 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.211472685 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.211687568 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.211798669 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.211902776 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.212022661 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.212126605 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.212231037 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.212339048 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.212458120 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.212809642 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.212927413 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.213226720 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.213521309 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.213623464 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.213687392 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.213836720 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.213937573 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.214038589 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.214147250 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.214245826 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf input, index = 0, fd = 27, plane[0], size = 537600, plane[1] size = 0
0:00:00.214337082 1563 0x190030 DEBUG vpe gstvpebufferpool.c:641:gst_vpe_buffer_pool_set_streaming: Start streaming for type: 10
0:00:00.214727808 1563 0x190030 DEBUG vpe gstvpebuffer.c:96:gst_vpe_buffer_new: Allocated a new VPE buffer, 720x304, index: 0, type: 9
0:00:00.214786042 1563 0x190030 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324ab8
0:00:00.214842976 1563 0x190030 DEBUG vpe gstvpebufferpool.c:221:gst_vpe_buffer_pool_put: vpebufferpool: buf marked free: index = 0, q_cnt = 0
0:00:00.215012962 1563 0x190030 DEBUG vpe gstvpebuffer.c:96:gst_vpe_buffer_new: Allocated a new VPE buffer, 720x304, index: 1, type: 9
0:00:00.215090717 1563 0x190030 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324b58
0:00:00.215147325 1563 0x190030 DEBUG vpe gstvpebufferpool.c:221:gst_vpe_buffer_pool_put: vpebufferpool: buf marked free: index = 1, q_cnt = 0
0:00:00.215325120 1563 0x190030 DEBUG vpe gstvpebuffer.c:96:gst_vpe_buffer_new: Allocated a new VPE buffer, 720x304, index: 2, type: 9
0:00:00.215400434 1563 0x190030 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324bf8
0:00:00.215454765 1563 0x190030 DEBUG vpe gstvpebufferpool.c:221:gst_vpe_buffer_pool_put: vpebufferpool: buf marked free: index = 2, q_cnt = 0
0:00:00.215579042 1563 0x190030 DEBUG vpe gstvpebuffer.c:96:gst_vpe_buffer_new: Allocated a new VPE buffer, 720x304, index: 3, type: 9
0:00:00.215751306 1563 0x190030 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324c98
0:00:00.215816373 1563 0x190030 DEBUG vpe gstvpebufferpool.c:221:gst_vpe_buffer_pool_put: vpebufferpool: buf marked free: index = 3, q_cnt = 0
0:00:00.215955778 1563 0x190030 DEBUG vpe gstvpebuffer.c:96:gst_vpe_buffer_new: Allocated a new VPE buffer, 720x304, index: 4, type: 9
0:00:00.216047685 1563 0x190030 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324d38
0:00:00.216092906 1563 0x190030 DEBUG vpe gstvpebufferpool.c:221:gst_vpe_buffer_pool_put: vpebufferpool: buf marked free: index = 4, q_cnt = 0
0:00:00.216333002 1563 0x190030 DEBUG vpe gstvpebuffer.c:96:gst_vpe_buffer_new: Allocated a new VPE buffer, 720x304, index: 5, type: 9
0:00:00.216425234 1563 0x190030 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324dd8
0:00:00.216472245 1563 0x190030 DEBUG vpe gstvpebufferpool.c:221:gst_vpe_buffer_pool_put: vpebufferpool: buf marked free: index = 5, q_cnt = 0
0:00:00.216630845 1563 0x190030 DEBUG vpe gstvpe.c:624:gst_vpe_set_streaming:<vpe0> gst_vpe_init_output_buffers done
0:00:00.216791722 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf output, index = 0, fd = 57, plane[0], size = 328320, plane[1] size = 0
0:00:00.216892738 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf output, index = 0, fd = 57, plane[0], size = 328320, plane[1] size = 0
0:00:00.216999610 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf output, index = 0, fd = 57, plane[0], size = 328320, plane[1] size = 0
0:00:00.217107458 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf output, index = 0, fd = 57, plane[0], size = 328320, plane[1] size = 0
0:00:00.217228320 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf output, index = 0, fd = 57, plane[0], size = 328320, plane[1] size = 0
0:00:00.217319413 1563 0x190030 DEBUG vpe gstvpebufferpool.c:609:gst_vpe_buffer_pool_set_streaming: query buf output, index = 0, fd = 57, plane[0], size = 328320, plane[1] size = 0
0:00:00.217865160 1563 0x190030 DEBUG vpe gstvpebufferpool.c:636:gst_vpe_buffer_pool_set_streaming: vpebufferpool: op QBUF succeeded: index = 0
0:00:00.218332664 1563 0x190030 DEBUG vpe gstvpebufferpool.c:636:gst_vpe_buffer_pool_set_streaming: vpebufferpool: op QBUF succeeded: index = 1
0:00:00.218836930 1563 0x190030 DEBUG vpe gstvpebufferpool.c:636:gst_vpe_buffer_pool_set_streaming: vpebufferpool: op QBUF succeeded: index = 2
0:00:00.219306224 1563 0x190030 DEBUG vpe gstvpebufferpool.c:636:gst_vpe_buffer_pool_set_streaming: vpebufferpool: op QBUF succeeded: index = 3
0:00:00.219777632 1563 0x190030 DEBUG vpe gstvpebufferpool.c:636:gst_vpe_buffer_pool_set_streaming: vpebufferpool: op QBUF succeeded: index = 4
0:00:00.220242858 1563 0x190030 DEBUG vpe gstvpebufferpool.c:636:gst_vpe_buffer_pool_set_streaming: vpebufferpool: op QBUF succeeded: index = 5
0:00:00.220296050 1563 0x190030 DEBUG vpe gstvpebufferpool.c:641:gst_vpe_buffer_pool_set_streaming: Start streaming for type: 9
0:00:00.220361768 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 0
0:00:00.220410893 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 27
0:00:00.220505402 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.220767946 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 0, q_cnt: 1
0:00:00.220882789 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.220936632 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.220980226 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.221002349 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.221026098 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from input Q, try again
0:00:00.221098322 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.048383343 ( ptr 0xb5324e78)
0:00:00.221150213 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.221204544 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 27
0:00:00.221268634 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.221360704 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 0, q_cnt: 1
0:00:00.228183432 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.090091676 ( ptr 0xb5304558)
0:00:00.228246546 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5304558
0:00:00.228507789 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.228570741 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 1/128, 1
0:00:00.228698272 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.228757320 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 1
0:00:00.228878994 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.228923402 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 34
0:00:00.229018400 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=29
0:00:00.229184808 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 1, q_cnt: 1
0:00:00.231118101 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.231222045 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 0, type: 9, field: 1, q_cnt: 1
0:00:00.231253440 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.006675000 (ptr 0xb5324ab8)
Pipeline is PREROLLED ...
Setting pipeline to PLAYING ...
0:00:00.232022690 1563 0x1918a0 DEBUG vpe gstvpe.c:992:gst_vpe_src_event:<vpe0> begin: event=latency
0:00:00.232084992 1563 0x1918a0 DEBUG vpe gstvpe.c:1003:gst_vpe_src_event:<vpe0> end
0:00:00.232241152 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.232338264 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 1, type: 9, field: 1, q_cnt: 1
0:00:00.232373400 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.048383000 (ptr 0xb5324b58)
0:00:00.232393408 1563 0x1918a0 DEBUG vpe gstvpe.c:1016:gst_vpe_change_state:<vpe0> begin: changing state PAUSED -> PLAYING
0:00:00.232416506 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324ab8
0:00:00.232419434 1563 0x1918a0 DEBUG vpe gstvpe.c:1028:gst_vpe_change_state:<vpe0> parent state change returned: 1
0:00:00.232475066 1563 0x1918a0 DEBUG vpe gstvpe.c:1044:gst_vpe_change_state:<vpe0> end
0:00:00.232517360 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 0
0:00:00.232543712 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.232697594 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 2, type: 9, field: 1, q_cnt: 1
0:00:00.232737285 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.090091000 (ptr 0xb5324bf8)
New clock: GstSystemClock
0:00:00.232772584 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324b58
0:00:00.232854568 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 1
0:00:00.232880106 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.232902880 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.232921098 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.232939317 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.232965018 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.232989418 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 0, type: 10, field: 1, q_cnt: 1
0:00:00.233008125 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.233092386 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.233111581 1563 0x190090 WARN vpe gstvpebufferpool.c:307:gst_vpe_buffer_pool_dequeue: Dequeued buffer that was not queued, index: 0
0:00:00.233200397 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.131800010 ( ptr 0xb5336140)
0:00:00.233250824 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5336140
0:00:00.233290514 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.233334597 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 2/128, 1
0:00:00.233371848 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.233980546 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 2
0:00:00.234158016 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.234687984 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 35
0:00:00.234828690 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.235025354 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 2, q_cnt: 1
0:00:00.235636981 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.235767440 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.239211418 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.173508343 ( ptr 0xb5336000)
0:00:00.239283642 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5336000
0:00:00.239353426 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.239414914 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 3/128, 2
0:00:00.239464853 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.239641509 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 3
0:00:00.239718776 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 3
0:00:00.239773757 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 32
0:00:00.239891528 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.240143661 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 3, q_cnt: 1
0:00:00.243208464 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.243335506 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 3, type: 9, field: 1, q_cnt: 1
0:00:00.243374709 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.131800000 (ptr 0xb5324c98)
0:00:00.243418629 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324bf8
0:00:00.243517368 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 2
0:00:00.243550226 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.243671576 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 4, type: 9, field: 1, q_cnt: 1
0:00:00.243714357 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.173508000 (ptr 0xb5324d38)
0:00:00.243756650 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324c98
0:00:00.243858154 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 3
0:00:00.243910696 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.243944368 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.244009922 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.244050426 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.244201218 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 29
0:00:00.244298330 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 1, type: 10, field: 1, q_cnt: 1
0:00:00.244247578 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.215216676 ( ptr 0xb5304378)
0:00:00.244393490 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.244824394 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.244862946 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 2, type: 10, field: 1, q_cnt: 1
0:00:00.244961197 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.245148914 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.245216421 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 3, type: 10, field: 1, q_cnt: 1
0:00:00.245264082 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.245303610 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.245351922 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5304378
0:00:00.245413248 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.245470832 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 4/128, 0
0:00:00.245519469 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.245585186 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 4
0:00:00.245662616 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.245715157 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 36
0:00:00.245766885 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.246143784 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 4, q_cnt: 1
0:00:00.250218909 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.256925010 ( ptr 0xb53045f8)
0:00:00.250453962 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb53045f8
0:00:00.250677792 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.250905037 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 5/128, 1
0:00:00.251114064 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.251327320 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 5
0:00:00.251547408 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.251805397 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 39
0:00:00.252045168 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.252433941 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 5, q_cnt: 1
0:00:00.255415458 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.255537784 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 5, type: 9, field: 1, q_cnt: 1
0:00:00.255582354 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.215216000 (ptr 0xb5324dd8)
0:00:00.255644656 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324d38
0:00:00.255749088 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 4
0:00:00.255785362 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.255906061 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 0, type: 9, field: 1, q_cnt: 1
0:00:00.255948029 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.256925000 (ptr 0xb5324ab8)
0:00:00.255990322 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324dd8
0:00:00.256250101 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 5
0:00:00.256293208 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.256326717 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.256353557 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.256380072 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.256477184 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.256512482 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 4, type: 10, field: 1, q_cnt: 1
0:00:00.256572181 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.256784949 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.256829357 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 5, type: 10, field: 1, q_cnt: 1
0:00:00.256877018 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.256905322 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.256787226 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.298633343 ( ptr 0xb5324f18)
0:00:00.257206418 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5324f18
0:00:00.257421138 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.257648221 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 6/128, 0
0:00:00.257784861 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.257930448 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 6
0:00:00.258069040 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.258125160 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 38
0:00:00.258265216 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.258563546 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 6, q_cnt: 1
0:00:00.259036256 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.259410226 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.263213048 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.340341676 ( ptr 0xb5304698)
0:00:00.263422400 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5304698
0:00:00.263635168 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.263863714 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 7/128, 1
0:00:00.264061517 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.264269730 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 7
0:00:00.264467696 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.264678024 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 40
0:00:00.264895509 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.265196930 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 7, q_cnt: 1
0:00:00.267011314 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.267135754 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 1, type: 9, field: 1, q_cnt: 1
0:00:00.267180650 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.298633000 (ptr 0xb5324b58)
0:00:00.267230264 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324ab8
0:00:00.267336810 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 0
0:00:00.267374061 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.267500453 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 2, type: 9, field: 1, q_cnt: 1
0:00:00.267542421 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.340341000 (ptr 0xb5324bf8)
0:00:00.267586341 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324b58
0:00:00.267771130 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 1
0:00:00.267808218 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.267841565 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.267868568 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.267894920 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.267996261 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.268044410 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 6, type: 10, field: 1, q_cnt: 1
0:00:00.268094349 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.268252461 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.268290362 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 7, type: 10, field: 1, q_cnt: 1
0:00:00.268336397 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.268364701 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.269224394 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.382050010 ( ptr 0xb53361e0)
0:00:00.269448061 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb53361e0
0:00:00.269667010 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.269867578 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 8/128, 0
0:00:00.270058224 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.270264810 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 8
0:00:00.270484410 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.270702872 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 37
0:00:00.270896933 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.271192661 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 8, q_cnt: 1
0:00:00.275220613 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.423758343 ( ptr 0xb5323b50)
0:00:00.275430778 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5323b50
0:00:00.275669085 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.275874045 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 9/128, 1
0:00:00.276065341 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.276269976 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 9
0:00:00.276469893 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.276701368 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 43
0:00:00.276902098 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.277196525 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 9, q_cnt: 1
0:00:00.278480290 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.278681184 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 3, type: 9, field: 1, q_cnt: 1
0:00:00.278735352 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.382050000 (ptr 0xb5324c98)
0:00:00.278783013 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324bf8
0:00:00.278889072 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 2
0:00:00.278942752 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.279110461 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 4, type: 9, field: 1, q_cnt: 1
0:00:00.279152754 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.423758000 (ptr 0xb5324d38)
0:00:00.279196674 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324c98
0:00:00.279300456 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 3
0:00:00.279335917 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.279369101 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.279395453 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.279422130 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.279526237 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.279562186 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 8, type: 10, field: 1, q_cnt: 1
0:00:00.279643032 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.279807162 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.279844738 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 9, type: 10, field: 1, q_cnt: 1
0:00:00.279890610 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.279918752 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.281218296 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.465466676 ( ptr 0xb5336500)
0:00:00.281418376 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5336500
0:00:00.281652290 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.281856274 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 10/128, 0
0:00:00.282047408 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.282253506 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 10
0:00:00.282451309 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.282684573 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 42
0:00:00.282901570 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.283194208 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 10, q_cnt: 1
0:00:00.283703680 1563 0x190030 DEBUG vpe gstvpe.c:920:gst_vpe_event:<vpe0> begin: event=tag
0:00:00.284077488 1563 0x190030 DEBUG vpe gstvpe.c:983:gst_vpe_event:<vpe0> end ret=1
0:00:00.288193930 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.507175010 ( ptr 0xb5336640)
0:00:00.288385226 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5336640
0:00:00.288541386 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.288715277 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 11/128, 1
0:00:00.288864768 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.289028085 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 11
0:00:00.289201162 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.289378306 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 44
0:00:00.289530888 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.289782533 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 11, q_cnt: 1
0:00:00.290024744 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.290119416 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 5, type: 9, field: 1, q_cnt: 1
0:00:00.290154714 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.465466000 (ptr 0xb5324dd8)
0:00:00.290192616 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324d38
0:00:00.290287938 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 4
0:00:00.290317381 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.290399202 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.290421000 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.290442472 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.290526408 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.290555525 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 10, type: 10, field: 1, q_cnt: 1
0:00:00.290594240 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.290726488 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.290755117 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 11, type: 10, field: 1, q_cnt: 1
0:00:00.290837589 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.290862314 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.294189498 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.548883343 ( ptr 0xb5336280)
0:00:00.294355743 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5336280
0:00:00.294526869 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.294702223 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 12/128, 0
0:00:00.294852527 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.295015357 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 12
0:00:00.295171517 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.295486765 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 41
0:00:00.295777450 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.296143775 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 12, q_cnt: 1
0:00:00.300219714 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.590591676 ( ptr 0xb5323a10)
0:00:00.300428741 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5323a10
0:00:00.300638581 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.300863711 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 13/128, 1
0:00:00.301061677 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.301267613 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 13
0:00:00.301465578 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.301677533 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 47
0:00:00.301871919 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.302190909 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 13, q_cnt: 1
0:00:00.302424010 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.302577405 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 0, type: 9, field: 1, q_cnt: 1
0:00:00.302665407 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.507175000 (ptr 0xb5324ab8)
0:00:00.302713719 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324dd8
0:00:00.302818639 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 5
0:00:00.302856703 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.302974311 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 1, type: 9, field: 1, q_cnt: 1
0:00:00.303016442 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.548883000 (ptr 0xb5324b58)
0:00:00.303071911 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324ab8
0:00:00.303234578 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 0
0:00:00.303271829 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.303377399 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 2, type: 9, field: 1, q_cnt: 1
0:00:00.303418066 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.590591000 (ptr 0xb5324bf8)
0:00:00.303460034 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324b58
0:00:00.303561375 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 1
0:00:00.303630509 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.303665482 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.303724042 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.303752509 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.303861983 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.303898909 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 12, type: 10, field: 1, q_cnt: 1
0:00:00.303947871 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.304044983 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.304079957 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 13, type: 10, field: 1, q_cnt: 1
0:00:00.304135589 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.304163730 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.308216245 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.632300010 ( ptr 0xb53238d0)
0:00:00.308254309 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb53238d0
0:00:00.308280010 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.308311893 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 14/128, 0
0:00:00.308335317 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.308376146 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 14
0:00:00.308406727 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.308433567 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 46
0:00:00.308459431 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.308590215 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 14, q_cnt: 1
0:00:00.312218658 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.674008343 ( ptr 0xb5323e70)
0:00:00.312255421 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5323e70
0:00:00.312279983 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.312311215 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 15/128, 1
0:00:00.312335453 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.312375957 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 15
0:00:00.312406863 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.312434842 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 48
0:00:00.312461031 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.312594093 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 15, q_cnt: 1
0:00:00.314269397 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.314391559 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 3, type: 9, field: 1, q_cnt: 1
0:00:00.314437594 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.632300000 (ptr 0xb5324c98)
0:00:00.314488509 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324bf8
0:00:00.314592941 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 2
0:00:00.314673135 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.314781309 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 4, type: 9, field: 1, q_cnt: 1
0:00:00.314824415 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.674008000 (ptr 0xb5324d38)
0:00:00.314882650 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324c98
0:00:00.315022543 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 3
0:00:00.315060445 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.315094117 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.315120957 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.315147309 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.315243933 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.315279882 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 14, type: 10, field: 1, q_cnt: 1
0:00:00.315327543 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.315424655 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.315471341 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 15, type: 10, field: 1, q_cnt: 1
0:00:00.315516399 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.315544703 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.316209034 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.715716676 ( ptr 0xb5336320)
0:00:00.316244007 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5336320
0:00:00.316268733 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.316300127 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 16/128, 0
0:00:00.316323551 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.316363567 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 16
0:00:00.316393661 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.316420501 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 45
0:00:00.316445714 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=31
0:00:00.316573082 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 16, q_cnt: 1
0:00:00.320213562 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.757425010 ( ptr 0xb5323c90)
0:00:00.320250487 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5323c90
0:00:00.320275538 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.320307583 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 17/128, 1
0:00:00.320331007 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.320370861 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 17
0:00:00.320401279 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.320428119 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 51
0:00:00.320453983 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.320570453 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 17, q_cnt: 1
0:00:00.324212234 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.799133343 ( ptr 0xb53400b0)
0:00:00.324248997 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb53400b0
0:00:00.324273885 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.324305767 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 18/128, 2
0:00:00.324329191 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.324369370 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 18
0:00:00.324399626 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 3
0:00:00.324426629 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 50
0:00:00.324452655 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=29
0:00:00.324570751 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 18, q_cnt: 1
0:00:00.325777575 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.325900714 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 5, type: 9, field: 1, q_cnt: 1
0:00:00.325946098 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.715716000 (ptr 0xb5324dd8)
0:00:00.325995061 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324d38
0:00:00.326098191 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 4
0:00:00.326135767 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.326240850 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 0, type: 9, field: 1, q_cnt: 1
0:00:00.326281842 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.757425000 (ptr 0xb5324ab8)
0:00:00.326323810 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324dd8
0:00:00.326437677 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 5
0:00:00.326536578 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.326711282 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 1, type: 9, field: 1, q_cnt: 1
0:00:00.326763173 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.799133000 (ptr 0xb5324b58)
0:00:00.326849386 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324ab8
0:00:00.326969109 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 0
0:00:00.327005058 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.327039055 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.327065895 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.327092735 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.327200909 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 31
0:00:00.327237021 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 16, type: 10, field: 1, q_cnt: 1
0:00:00.327285007 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.327484762 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.327521687 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 17, type: 10, field: 1, q_cnt: 1
0:00:00.327568047 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.327681914 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 29
0:00:00.327718189 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 18, type: 10, field: 1, q_cnt: 1
0:00:00.327764061 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.327791877 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.329223506 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.840841676 ( ptr 0xb5324978)
0:00:00.329294103 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb5324978
0:00:00.329347458 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.329408133 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 19/128, 0
0:00:00.329457909 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.329526879 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 19
0:00:00.329584463 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.329672303 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 52
0:00:00.329728423 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=29
0:00:00.330059613 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 19, q_cnt: 1
0:00:00.334215095 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.882550010 ( ptr 0xb53403d0)
0:00:00.334435509 1563 0x190030 DEBUG vpe gstvpe.c:876:gst_vpe_chain:<vpe0> Importing buffer not allocated by self 0xb53403d0
0:00:00.334667471 1563 0x190030 DEBUG vpe gstvpebufferpool.c:452:gst_vpe_buffer_pool_import: Entered gst_vpe_buffer_pool_get
0:00:00.334867063 1563 0x190030 WARN vpe gstvpebufferpool.c:471:gst_vpe_buffer_pool_import: Allocating a new input buffer index: 20/128, 1
0:00:00.335083247 1563 0x190030 DEBUG vpe gstvpebuffer.c:155:gst_vpe_buffer_import: Importing buffer
0:00:00.335299594 1563 0x190030 DEBUG vpe gstvpebufferpool.c:481:gst_vpe_buffer_pool_import: New buffer allocated, index: 20
0:00:00.335498698 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.335708538 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 49
0:00:00.335902925 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.336208250 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 20, q_cnt: 1
0:00:00.337901610 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.338026050 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 2, type: 9, field: 1, q_cnt: 1
0:00:00.338069970 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.840841000 (ptr 0xb5324bf8)
0:00:00.338120559 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324b58
0:00:00.338224829 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 1
0:00:00.338261754 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.338367162 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 3, type: 9, field: 1, q_cnt: 1
0:00:00.338407341 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.882550000 (ptr 0xb5324c98)
0:00:00.338448983 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324bf8
0:00:00.338563663 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 2
0:00:00.338709087 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.338747477 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.338775943 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.338802458 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.338904287 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 29
0:00:00.338939261 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 19, type: 10, field: 1, q_cnt: 1
0:00:00.338988223 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.339100626 1563 0x190090 LOG vpe gstvpebufferpool.c:303:gst_vpe_buffer_pool_dequeue: DQBUF input for v4l2_index: 30
0:00:00.339137226 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for input succeeded, index: 20, type: 10, field: 1, q_cnt: 1
0:00:00.339181959 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
0:00:00.339271101 1563 0x190090 LOG vpe gstvpebufferpool.c:332:gst_vpe_buffer_pool_dequeue: No buffers to dequeue from input Q
0:00:00.340226767 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.924258343 ( ptr 0xb5340510)
0:00:00.340430263 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 1
0:00:00.340667106 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 34
0:00:00.340868162 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=30
0:00:00.341159173 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 1, q_cnt: 1
0:00:00.345215754 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:00.965966676 ( ptr 0xb5340150)
0:00:00.345425757 1563 0x190030 DEBUG vpe gstvpe.c:890:gst_vpe_chain:<vpe0> Push the buffer into the V4L2 driver 2
0:00:00.345641615 1563 0x190030 DEBUG vpe gstvpebufferpool.c:355:gst_vpe_buffer_pool_queue: Queueing buffer, fd: 32
0:00:00.345859263 1563 0x190030 DEBUG vpe gstvpebufferpool.c:379:gst_vpe_buffer_pool_queue: Queueing V4L2_FIELD_ANY index=29
0:00:00.346159709 1563 0x190030 LOG vpe gstvpebufferpool.c:395:gst_vpe_buffer_pool_queue: Q_CNT after QBUF index = 3, q_cnt: 1
0:00:00.349375791 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.349498605 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 4, type: 9, field: 1, q_cnt: 1
0:00:00.349540735 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.924258000 (ptr 0xb5324d38)
0:00:00.349588397 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324c98
0:00:00.349710071 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 3
0:00:00.349760010 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.349931949 1563 0x190090 LOG vpe gstvpebufferpool.c:314:gst_vpe_buffer_pool_dequeue: DQBUF for output succeeded, index: 5, type: 9, field: 1, q_cnt: 1
0:00:00.349974567 1563 0x190090 DEBUG vpe gstvpe.c:499:gst_vpe_dequeue_loop:<vpe0> push: 0:00:00.965966000 (ptr 0xb5324dd8)
0:00:00.350018162 1563 0x190090 DEBUG vpe gstvpebufferpool.c:197:gst_vpe_buffer_pool_put: Entered for output Q, buf=0xb5324d38
0:00:00.350165213 1563 0x190090 DEBUG vpe gstvpebufferpool.c:214:gst_vpe_buffer_pool_put: vpebufferpool: output QBUF succeeded: index = 4
0:00:00.350201487 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for output Q
0:00:00.350235159 1563 0x190090 LOG vpe gstvpebufferpool.c:294:gst_vpe_buffer_pool_dequeue: No buffers to DQBUF from output Q, try again
0:00:00.350261511 1563 0x190090 DEBUG vpe gstvpebufferpool.c:697:gst_vpe_buffer_pool_alloc_buffer: Failed (nil)
0:00:00.350288026 1563 0x190090 LOG vpe gstvpebufferpool.c:274:gst_vpe_buffer_pool_dequeue: Entered for input Q
(gst-launch-1.0:1563): GStreamer-CRITICAL **: 16:30:23.892: gst_buffer_peek_memory: assertion 'GST_IS_BUFFER (buffer)' failed
** (gst-launch-1.0:1563): CRITICAL **: 16:30:23.892: gst_fd_memory_get_fd: assertion 'mem != NULL' failed
Caught SIGSEGV
0:00:00.352068738 1563 0x190030 DEBUG vpe gstvpe.c:835:gst_vpe_chain:<vpe0> chain: 0:00:01.007675010 ( ptr 0xb53360a0)
#0 __GI___poll (timeout=-1, nfds=2, fds=0x1b48a0)
#1 __GI___poll (fds=0x1b48a0, nfds=2, timeout=-1)
#2 0xb6dd454a in ?? () from /usr/lib/libglib-2.0.so.0
Spinning. Please run 'gdb gst-launch-1.0 1563' to continue debugging, Ctrl-C to quit, or Ctrl-\ to dump core.
^\Quit (core dumped)
root@am57xx-evm:/run/media/sda1/Records#
But another pipeline without ducatih264dec works fine.
Example of pipeline which works fine:
root@am57xx-evm:/run/media/sda1/Records# gst-launch-1.0 videotestsrc ! videorate ! vpe ! fakesink
Thanks,
Nikolay.
Hi Nikolay,
Can you let me know what is the resolution and fps of the mp4 stream being tested here?
What is the target fps expected?
Did you check what happens when videorate is added vpe instead of ducati?
Thanks
RamPrasad
Video resolution is 720x304 and 24fps in that case. Also i trying another videos this different resolution (fullhd, hd, etc).
I trying to set different fps in caps after videorate plugin. But the pipeline always crashes, even if you don't set fps in caps at all.
And I did mistake. I got the same error without ducati too.
UPD: The error can only be avoided when vpe does not do a resolution conversion (that is, another resolution is not specified in the caps after vpe).
Hi Nikolayy,
i am not sure if videorate plugin will be work with along with hardware based plugins(ducati and vpe)
gstducati and vpe are HW based plugins with buffer sharing mechanism of dma-buf
but when videorate element comes in between, it is software plugin and it either duplicates of drops the buffers based the framerate expected.
Thanks
RamPrasad
Hi Nikolay,
I tested this pipeline
gst-launch-1.0 filesrc location=/usr/share/ti/video/HistoryOfTIAV-480p.mp4 ! qtdemux ! mpeg4videoparse ! ducatimpeg4dec ! vpe ! 'video/x-raw, width=(int)1280, height=(int)800' ! videorate ! fakesink
I don't see any issue. How did you find out the fps drops?
Thanks
RamPrasad