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.