:-)
Please don't get me wrong, I was only thinking, what can I do ....
I already saw, I can not really step fast into the gstreamer, special in VPU on Freescale stuff.
So, I will play around with appsrc, and try it.

Otherwise, keep me updated about your progress.

Thanks
Peter


Am 18.01.2015 um 12:02 schrieb Carlos Rafael Giani:
I am restructuring the VPU code to not contain this one-frame delay, which would allow for decoding JPEGs directly. It is not a small update though, and will take some time. Until then, perhaps try this:
Push the same JPEG twice into the decoder. That is, read all of the bytes of the JPEG file into a buffer, and then send in these bytes twice into appsrc, as if you were sending in two JPEGs. This will give you one decoded picture.

On 2015-01-18 10:33, Peter Hafner wrote:
Hmm,
is there any other  possibility to get this running ?
Is that helpful, when my app not push data to stdout, that we using file src, I can try to implement appsrc!
And try to handle my EOS, by my self!

Regards
Peter

Am 13.01.2015 um 20:43 schrieb Carlos Rafael Giani:
Okay, I have a partial solution. The crashes most likely came from a bug I uncovered: internal temporary buffers were constantly being freed and allocated again. This is now fixed, and does not happen anymore.

But the reason why you get the h264parse error is that it simply does not receive any h264 data. This is because of an internal delay caused by a mechanism in the underlying libfslvpuwrap library. There is always a fixed delay of one frame. That is, the first encoded frame that is pushed into the decoder does not produce an output picture. Only after the second encoded frame is pushed, you get a decoded first picture. The VPU itself could deliver a picture immediately; this is a pure software problem. However, a fix is not trivial.
So, what currently happens is that after the JPEG gets pushed to the decoder, filesrc signals EOS. The decoder element then gets flushed; any frames that were already decoded but not yet pushed downstream are pushed downstream. In this case, this is precisely the decoded JPEG picture. It gets pushed, as expected. But the encoder does not receive this picture. This may be a bug in GStreamer (the encoder is not encoding anymore even though it should encode these remaining pictures). I'll ask in the GStreamer community.
It would of course be much simpler if there wasn't this one-frame delay. I am currently looking into possibilities on getting rid of that. It requires substantial refactoring of the VPU code in gstreamer-imx, but this is something I had planned already. I'll keep you posted.



On 2015-01-13 18:00, Peter Hafner wrote:
It's Debian Wheezy's Gstreamer (1.0), exact version,

~# gst-launch-1.0 --version
gst-launch-1.0 version 1.4.4
GStreamer 1.4.4
http://packages.qa.debian.org/gstreamer1.0

Debian is running on a Hummingboard i.MX6 Dual.

I'm using the gstreamer-imx version from here https://github.com/Freescale/gstreamer-imx (master), not the latest, one before. (467c91a from 29.12.2014)

Please let me know, if I can do anything :-)
Log's or what ever....

This is the working pipeline:
/root/Extender/extender/c_app/stream | gst-launch-1.0 -v fdsrc do-timestamp=true blocksize=2000000 num-buffers=-1 ! "image/jpeg,framerate=15/1,width=1280,height=720" ! jpegparse ! imxvpudec ! autovideosink

This is the not working pipeline:
/root/Extender/extender/c_app/stream | gst-launch-1.0 -v fdsrc do-timestamp=true blocksize=2000000 num-buffers=-1 ! "image/jpeg,framerate=15/1,width=1280,height=720" ! jpegparse ! imxvpudec ! imxvpuenc_h264  ! h264parse ! autovideosink

Setting pipeline to PAUSED ...
[INFO]    Product Info: i.MX6Q/D/S
[INFO]    Product Info: i.MX6Q/D/S
Pipeline is PREROLLING ...
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:src: caps = "image/jpeg\,\ framerate\=\(fraction\)15/1\,\ width\=\(int\)1280\,\ height\=\(int\)720"
/GstPipeline:pipeline0/GstJpegParse:jpegparse0.GstPad:sink: caps = "image/jpeg\,\ framerate\=\(fraction\)15/1\,\ width\=\(int\)1280\,\ height\=\(int\)720"
/GstPipeline:pipeline0/GstJpegParse:jpegparse0.GstPad:src: caps = "image/jpeg\,\ parsed\=\(boolean\)true\,\ format\=\(string\)UYVY\,\ interlaced\=\(boolean\)false\,\ width\=\(int\)1440\,\ height\=\(int\)900\,\ framerate\=\(fraction\)15/1"
/GstPipeline:pipeline0/GstImxVpuDec:imxvpudec0.GstPad:sink: caps = "image/jpeg\,\ parsed\=\(boolean\)true\,\ format\=\(string\)UYVY\,\ interlaced\=\(boolean\)false\,\ width\=\(int\)1440\,\ height\=\(int\)900\,\ framerate\=\(fraction\)15/1"
[INFO]    bitstreamMode 1, chromaInterleave 0, mapType 0, tiled2LinearEnable 0
/GstPipeline:pipeline0/GstImxVpuDec:imxvpudec0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)Y42B\,\ width\=\(int\)1440\,\ height\=\(int\)900\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)bt709\,\ framerate\=\(fraction\)15/1"
handling interrupt.
Interrupt: Stopping pipeline ...
Setting pipeline to NULL ...
/GstPipeline:pipeline0/GstImxVpuDec:imxvpudec0.GstPad:src: caps = "NULL"
/GstPipeline:pipeline0/GstImxVpuDec:imxvpudec0.GstPad:sink: caps = "NULL"
/GstPipeline:pipeline0/GstJpegParse:jpegparse0.GstPad:src: caps = "NULL"
/GstPipeline:pipeline0/GstJpegParse:jpegparse0.GstPad:sink: caps = "NULL"
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:src: caps = "NULL"
Freeing pipeline ...



Thanks
Peter

Am 13.01.2015 um 12:17 schrieb Carlos Rafael Giani:
What GStreamer version is this? And what gstreamer-imx version are you using? 0.10.0? master?
I'll try to reproduce the problem as soon as I can. But I need to know the versions.

On 2015-01-12 22:31, Peter Hafner wrote:
Hi,
I try to display a jpeg with gstreamer on i.mx6 dual.

This pipeline is working without any problems.
gst-launch-1.0 filesrc location=myfile3317.jpeg typefind=true ! jpegdec ! imagefreeze ! autovideosink

then I try to use the hw-encoder with this pipeline,
gst-launch-1.0 filesrc location=myfile3317.jpeg typefind=true ! "image/jpeg" ! imxvpudec ! imagefreeze ! autovideosink

If I set a block size blocksize=800000 then the gstreamer show's much more from the pic :-)
gst-launch-1.0 filesrc location=myfile3317.jpeg typefind=true blocksize=800000 ! "image/jpeg" ! imxvpudec ! imagefreeze ! autovideosink


Here, I didn't get a correct pic.
here a part from the log.


Setting pipeline to PAUSED ...
0:00:00.082927752   874   0x845780 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:744:gst_imx_blitter_video_sink_open_framebuffer_device:<autovideosink0-actual-sink-imxipuvideo> opening framebuffer /dev/fb0
0:00:00.083433102   874   0x845780 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:754:gst_imx_blitter_video_sink_open_framebuffer_device:<autovideosink0-actual-sink-imxipuvideo> framebuffer FD is 7
0:00:00.083678777   874   0x845780 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:725:gst_imx_blitter_video_sink_get_format_from_fb:<autovideosink0-actual-sink-imxipuvideo> framebuffer uses 32 bpp (sizes: r 8 g 8 b 8  offsets: r 16 g 8 b 0) => format BGRA
0:00:00.083985454   874   0x845780 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:824:gst_imx_blitter_video_sink_init_framebuffer:<autovideosink0-actual-sink-imxipuvideo> framebuffer resolution is 1280 x 1024
0:00:00.084671143   874   0x845780 TRACE         imxbaseblitter ../src/common/base_blitter.c:67:gst_imx_base_blitter_init:<GstImxBaseBlitter@0x858060> initializing base blitter
0:00:00.084930485   874   0x845780 INFO            imxipudevice ../src/ipu/device.c:61:gst_imx_ipu_open: IPU device opened
0:00:00.085291831   874   0x845780 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:62:gst_imx_phys_mem_allocator_init:<GstImxPhysMemAllocator@0x783910> initializing physical memory allocator
0:00:00.085588174   874   0x845780 INFO         imxipuallocator ../src/ipu/allocator.c:169:gst_imx_ipu_allocator_init:<GstImxIpuAllocator@0x783910> initialized IPU allocator
0:00:00.085887184   874   0x845780 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxipuallocator0> alloc_internal called: maxsize: 16384, align: 0, offset: 0, size: 16384
0:00:00.087249562   874   0x845780 DEBUG        imxipuallocator ../src/ipu/allocator.c:73:gst_imx_ipu_alloc_phys_mem:<imxipuallocator0> allocated 16384 bytes of physical memory at address 0x400f4000
0:00:00.087358899   874   0x845780 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxipuallocator0> allocated memory block 0x781d90 at phys addr 0x400f4000 with 16384 bytes
0:00:00.087447235   874   0x845780 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:178:gst_imx_phys_mem_allocator_map:<imxipuallocator0> mapping 16384 bytes from memory block 0x781d90 (phys addr 0x400f4000), current mapping refcount = 0 -> 1
0:00:00.087553906   874   0x845780 LOG          imxipuallocator ../src/ipu/allocator.c:123:gst_imx_ipu_map_phys_mem:<imxipuallocator0> mapped IPU physmem memory:  virt addr 0x76fc2000  phys addr 0x400f4000
0:00:00.087646909   874   0x845780 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:205:gst_imx_phys_mem_allocator_unmap:<imxipuallocator0> unmapping memory block 0x781d90 (phys addr 0x400f4000), current mapping refcount = 1 -> 0
0:00:00.087744579   874   0x845780 LOG          imxipuallocator ../src/ipu/allocator.c:135:gst_imx_ipu_unmap_phys_mem:<imxipuallocator0> unmapped IPU physmem memory:  virt addr 0x76fc2000  phys addr 0x400f4000
0:00:00.087834248   874   0x845780 INFO           imxipublitter ../src/ipu/blitter.c:160:gst_imx_ipu_blitter_init:<GstImxIpuBlitter@0x858060> initialized blitter
0:00:00.087939252   874   0x845780 DEBUG          imxipublitter ../src/ipu/blitter.c:212:gst_imx_ipu_blitter_set_deinterlace_mode:<imxipublitter0> set deinterlace mode to none
0:00:00.088045922   874   0x845780 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:880:gst_imx_blitter_video_sink_update_regions:<autovideosink0-actual-sink-imxipuvideo> video info in initial state -> using 1:1 display ratio
0:00:00.088134592   874   0x845780 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:972:gst_imx_blitter_video_sink_update_regions:<autovideosink0-actual-sink-imxipuvideo> not keeping aspect ratio
0:00:00.088218261   874   0x845780 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:973:gst_imx_blitter_video_sink_update_regions:<autovideosink0-actual-sink-imxipuvideo> setting video region to cover the entire window rectangle: (0,0 - 1280,1024)
0:00:00.088300597   874   0x845780 TRACE         imxbaseblitter ../src/common/base_blitter.c:638:gst_imx_base_blitter_calc_output_region_visibility:<imxipublitter0> output region is fully outside of the output buffer region
0:00:00.088364933   874   0x845780 TRACE         imxbaseblitter ../src/common/base_blitter.c:292:gst_imx_base_blitter_set_output_regions:<imxipublitter0> output region is fully outside of the output buffer region -> video region not visible
0:00:00.088436602   874   0x845780 TRACE         imxbaseblitter ../src/common/base_blitter.c:537:gst_imx_base_blitter_enable_crop:<imxipublitter0> set crop to 0
0:00:00.089586640   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:666:gst_imx_vpu_dec_start:<imxvpudec0> starting VPU decoder
[INFO]  Product Info: i.MX6Q/D/S
0:00:00.095314830   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:340:gst_imx_vpu_dec_load: VPU loaded
0:00:00.095408166   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:341:gst_imx_vpu_dec_load: VPU firmware version 2.1.2_r25182
0:00:00.095489502   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:342:gst_imx_vpu_dec_load: VPU library version 5.4.20
0:00:00.095559838   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:343:gst_imx_vpu_dec_load: VPU wrapper version 1.0.45 VPUWRAPPER_ARM_LINUX Build on Dec 22 2014 05:55:03
0:00:00.095669175   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:384:gst_imx_vpu_dec_alloc_dec_mem_blocks:<imxvpudec0> need to allocate 2 sub blocks for decoding
0:00:00.095742844   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:388:gst_imx_vpu_dec_alloc_dec_mem_blocks:<imxvpudec0> sub block 0  type: virtual  size: 5672
0:00:00.095883515   874   0x845780 INFO         imxvpumemblocks ../src/vpu/mem_blocks.c:50:gst_imx_vpu_alloc_virt_mem_block: allocated 5672 bytes of heap memory at virt addr 0x85a200
0:00:00.095969185   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:388:gst_imx_vpu_dec_alloc_dec_mem_blocks:<imxvpudec0> sub block 1  type: physical  size: 5236744
0:00:00.096137190   874   0x845780 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:62:gst_imx_phys_mem_allocator_init:<GstImxPhysMemAllocator@0x783988> initializing physical memory allocator
0:00:00.096331197   874   0x845780 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 5236744, align: 0, offset: 0, size: 5236744
0:00:00.112508067   874   0x845780 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x7621a000 phys: 0x49000000 cpu: 0xb9000000
0:00:00.112627738   874   0x845780 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x781e30 at phys addr 0x49000000 with 5236744 bytes
0:00:00.112711407   874   0x845780 INFO               imxvpudec ../src/vpu/decoder/decoder.c:693:gst_imx_vpu_dec_start:<imxvpudec0> VPU decoder started
Pipeline is PREROLLING ...
0:00:00.115685506   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:760:gst_imx_vpu_dec_set_format:<imxvpudec0> setting decoder format
0:00:00.115784842   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:763:gst_imx_vpu_dec_set_format:<imxvpudec0> draining remaining frames from decoder
0:00:00.115866845   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:540:gst_imx_vpu_dec_fill_param_set:<imxvpudec0> setting motion JPEG as stream format
[INFO]  bitstreamMode 1, chromaInterleave 0, mapType 0, tiled2LinearEnable 0
0:00:00.117108220   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:861:gst_imx_vpu_dec_set_format:<imxvpudec0> setting format finished
0:00:00.117229890   874   0x8460c0 WARN            videodecoder gstvideodecoder.c:2162:gst_video_decoder_chain:<imxvpudec0> Received buffer without a new-segment. Assuming timestamps start from 0.
0:00:00.117567235   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 201
0:00:00.117658571   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:961:gst_imx_vpu_dec_handle_frame:<imxvpudec0> using Y42B as video output format
0:00:00.117730240   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:974:gst_imx_vpu_dec_handle_frame:<imxvpudec0> minimum number of framebuffers indicated by the VPU: 1  chosen number: 7
0:00:00.117802576   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:975:gst_imx_vpu_dec_handle_frame:<imxvpudec0> interlacing: 0
0:00:00.118021583   874   0x8460c0 INFO      imxvpuframebuffers ../src/vpu/framebuffers.c:249:gst_imx_vpu_framebuffers_configure:<imxvpuframebuffers0> framebuffer requested width/height: 1440/900  actual width/height (after alignment): 1440/912  Y stride: 1440
0:00:00.118117253   874   0x8460c0 INFO      imxvpuframebuffers ../src/vpu/framebuffers.c:254:gst_imx_vpu_framebuffers_configure:<imxvpuframebuffers0> num framebuffers:  total: 7  available: 7
0:00:00.118211590   874   0x8460c0 INFO      imxvpuframebuffers ../src/vpu/framebuffers.c:259:gst_imx_vpu_framebuffers_configure:<imxvpuframebuffers0> framebuffer memory block size:  total: 3283201  Y: 1313280  U: 656640  V: 656640  Mv:  656640  alignment: 1
0:00:00.118299926   874   0x8460c0 INFO      imxvpuframebuffers ../src/vpu/framebuffers.c:264:gst_imx_vpu_framebuffers_configure:<imxvpuframebuffers0> total memory required for all framebuffers: 3283201 * 7 = 22982407 byte
0:00:00.118378595   874   0x8460c0 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 3283201, align: 0, offset: 0, size: 3283201
0:00:00.129105284   874   0x8460c0 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x74bde000 phys: 0x49500000 cpu: 0xb9500000
0:00:00.129259956   874   0x8460c0 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x781e80 at phys addr 0x49500000 with 3283201 bytes
0:00:00.129342292   874   0x8460c0 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 3283201, align: 0, offset: 0, size: 3283201
0:00:00.140380325   874   0x8460c0 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x748bc000 phys: 0x49900000 cpu: 0xb9900000
0:00:00.140514996   874   0x8460c0 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x781ed0 at phys addr 0x49900000 with 3283201 bytes
0:00:00.140598999   874   0x8460c0 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 3283201, align: 0, offset: 0, size: 3283201
0:00:00.155443158   874   0x8460c0 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x7459a000 phys: 0x49d00000 cpu: 0xb9d00000
0:00:00.155580163   874   0x8460c0 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x781f20 at phys addr 0x49d00000 with 3283201 bytes
0:00:00.155664499   874   0x8460c0 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 3283201, align: 0, offset: 0, size: 3283201
0:00:00.166008175   874   0x8460c0 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x74278000 phys: 0x4a100000 cpu: 0xba100000
0:00:00.166145180   874   0x8460c0 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x781f70 at phys addr 0x4a100000 with 3283201 bytes
0:00:00.166252184   874   0x8460c0 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 3283201, align: 0, offset: 0, size: 3283201
0:00:00.177512891   874   0x8460c0 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x73f56000 phys: 0x4a500000 cpu: 0xba500000
0:00:00.177649562   874   0x8460c0 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x75908808 at phys addr 0x4a500000 with 3283201 bytes
0:00:00.177733565   874   0x8460c0 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 3283201, align: 0, offset: 0, size: 3283201
0:00:00.188530256   874   0x8460c0 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x73c34000 phys: 0x4a900000 cpu: 0xba900000
0:00:00.188666261   874   0x8460c0 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x75908858 at phys addr 0x4a900000 with 3283201 bytes
0:00:00.188750597   874   0x8460c0 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxvpudecallocator0> alloc_internal called: maxsize: 3283201, align: 0, offset: 0, size: 3283201
0:00:00.201501353   874   0x8460c0 DEBUG     imxvpudecallocator ../src/vpu/decoder/allocator.c:84:gst_imx_vpu_dec_alloc_phys_mem:<imxvpudecallocator0> addresses: virt: 0x73912000 phys: 0x4ad00000 cpu: 0xbad00000
0:00:00.201640358   874   0x8460c0 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxvpudecallocator0> allocated memory block 0x759088a8 at phys addr 0x4ad00000 with 3283201 bytes
0:00:00.201750695   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:996:gst_imx_vpu_dec_handle_frame:<imxvpudec0> output state width is 0 - using the value 1440 from the framebuffers object instead
0:00:00.201826364   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:1001:gst_imx_vpu_dec_handle_frame:<imxvpudec0> output state height is 0 - using the value 912 from the framebuffers object instead
0:00:00.201916034   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1331:gst_imx_vpu_dec_handle_frame:<imxvpudec0> nothing to output (ret code: 0x201)
[WARN]  pic was forced to be done
0:00:00.702796320   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 4
0:00:00.703094663   874   0x8460c0 LOG       imxvpuframebuffers ../src/vpu/framebuffers.c:178:gst_imx_vpu_framebuffers_wait_until_frames_available:<imxvpuframebuffers0> flushing = 0  exit_loop = 0
0:00:00.704455042   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:1183:gst_imx_vpu_dec_handle_frame:<imxvpudec0> not using system frame numbers with this bitstream format
0:00:00.705665748   874   0x8460c0 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:915:gst_imx_blitter_video_sink_update_regions:<autovideosink0-actual-sink-imxipuvideo> calculated display ratio:  30:19
0:00:00.705733417   874   0x8460c0 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:951:gst_imx_blitter_video_sink_update_regions:<autovideosink0-actual-sink-imxipuvideo> maximizing video width
0:00:00.705776419   874   0x8460c0 INFO     imxblittervideosink ../src/common/blitter_video_sink.c:966:gst_imx_blitter_video_sink_update_regions:<autovideosink0-actual-sink-imxipuvideo> setting video region to (0,107 - 1280,917)
0:00:00.705833754   874   0x8460c0 TRACE         imxbaseblitter ../src/common/base_blitter.c:623:gst_imx_base_blitter_calc_output_region_visibility:<imxipublitter0> output region is fully contained in the output buffer region
0:00:00.705878422   874   0x8460c0 TRACE         imxbaseblitter ../src/common/base_blitter.c:285:gst_imx_base_blitter_set_output_regions:<imxipublitter0> output region is fully contained in the output buffer region -> video region fully visible
0:00:00.706528110   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:1467:gst_imx_vpu_dec_decide_allocation:<imxvpudec0> number of allocation pools in query: 1
0:00:00.706604113   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:1500:gst_imx_vpu_dec_decide_allocation:<imxvpudec0> no pool supports VPU buffers; creating new pool
0:00:00.706799453   874   0x8460c0 INFO      imxvpufbbufferpool ../src/vpu/fb_buffer_pool.c:240:gst_imx_vpu_fb_buffer_pool_init:<GstImxVpuFbBufferPool@0x7590f068> initializing VPU buffer pool
0:00:00.706879455   874   0x8460c0 INFO               imxvpudec ../src/vpu/decoder/decoder.c:1512:gst_imx_vpu_dec_decide_allocation:<imxvpufbbufferpool0> pool config:  outcaps: video/x-raw, format=(string)Y42B, width=(int)1440, height=(int)912, pixel-aspect-ratio=(fraction)1/1, interlace-mode=(string)progressive, colorimetry=(string)bt709, framerate=(fraction)0/1  size: 3283201  min buffers: 0  max buffers: 0
0:00:00.707307136   874   0x8460c0 LOG       imxvpufbbufferpool ../src/vpu/fb_buffer_pool.c:319:gst_imx_vpu_set_buffer_contents: setting phys mem meta for buffer with pointer 0x75906048: phys addr 0x49500000 x/y padding 0/0
0:00:00.707385139   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:1230:gst_imx_vpu_dec_handle_frame:<imxvpudec0> system frame number invalid or unusable - getting oldest pending frame instead
0:00:00.707433140   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:1233:gst_imx_vpu_dec_handle_frame:<imxvpudec0> output frame:  codecframe: 0x85c5e8  framebuffer phys addr: 0x49500000  system frame number: <none; oldest frame> gstbuffer addr: 0x75906048  field type: 0  pic type: 0  Y stride: 1440  CbCr stride: 720
0:00:00.707815820   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1339:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU did not use input frame, and no consumed frame info available -> drop input frame
0:00:00.711211266   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.711624946   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.714566044   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.715035059   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.717967157   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.718474507   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.721398937   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.721885953   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.725473406   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.725914087   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.728608176   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.729031524   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.731703612   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.732125626   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.734801049   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.735247730   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.737888818   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.738333499   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.741244596   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.741647610   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.744284364   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.744705712   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.747363467   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.747779814   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.750314898   874 0x75902150 LOG           imxphysmemmeta ../src/common/phys_mem_meta.c:67:gst_imx_phys_meta_transform: not copying metadata: only a region is being copied (not the entire block)
0:00:00.750716912   874 0x75902150 TRACE         imxbaseblitter ../src/common/base_blitter.c:160:gst_imx_base_blitter_set_input_buffer:<imxipublitter0> input buffer does not use DMA memory - need to copy it to an internal input DMA buffer
0:00:00.750727245   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.751211928   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.751255596   874 0x75902150 INFO    imxphysmembufferpool ../src/common/phys_mem_buffer_pool.c:288:gst_imx_phys_mem_buffer_pool_init:<GstImxPhysMemBufferPool@0x75005140> initializing physical memory buffer pool
0:00:00.753648676   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.753745346   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.753614675   874 0x75902150 INFO    imxphysmembufferpool ../src/common/phys_mem_buffer_pool.c:140:gst_imx_phys_mem_buffer_pool_set_config:<imxphysmembufferpool0> caps used for config: video/x-raw, format=(string)Y42B, width=(int)1440, height=(int)912, pixel-aspect-ratio=(fraction)1/1, interlace-mode=(string)progressive, colorimetry=(string)bt709, framerate=(fraction)25/1
0:00:00.754131359   874 0x75902150 INFO    imxphysmembufferpool ../src/common/phys_mem_buffer_pool.c:150:gst_imx_phys_mem_buffer_pool_set_config:<imxphysmembufferpool0> using horiz/vert alignment: 16/8
0:00:00.754390034   874 0x75902150 INFO    imxphysmembufferpool ../src/common/phys_mem_buffer_pool.c:168:gst_imx_phys_mem_buffer_pool_set_config:<imxphysmembufferpool0> aligned video info:  width/height: 1440/912  padding values right/bottom 0 0
0:00:00.754659710   874 0x75902150 DEBUG    imxphysmemallocator ../src/common/phys_mem_allocator.c:117:gst_imx_phys_mem_allocator_alloc_internal:<imxipuallocator0> alloc_internal called: maxsize: 2626560, align: 0, offset: 0, size: 2626560
0:00:00.756913785   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.757389801   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.760733912   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.760910918   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.763640675   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.763778680   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.766536438   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.766680110   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.768621841   874 0x75902150 DEBUG        imxipuallocator ../src/ipu/allocator.c:73:gst_imx_ipu_alloc_phys_mem:<imxipuallocator0> allocated 2626560 bytes of physical memory at address 0x4b100000
0:00:00.768716178   874 0x75902150 INFO     imxphysmemallocator ../src/common/phys_mem_allocator.c:152:gst_imx_phys_mem_allocator_alloc:<imxipuallocator0> allocated memory block 0x75908d50 at phys addr 0x4b100000 with 2626560 bytes
0:00:00.768792847   874 0x75902150 DEBUG   imxphysmembufferpool ../src/common/phys_mem_buffer_pool.c:209:gst_imx_phys_mem_buffer_pool_alloc_buffer:<imxphysmembufferpool0> allocated 2626560 bytes for new buffer
0:00:00.769027188   874 0x75902150 DEBUG   imxphysmembufferpool ../src/common/phys_mem_buffer_pool.c:232:gst_imx_phys_mem_buffer_pool_alloc_buffer:<imxphysmembufferpool0> added video meta with width/height 1440/912
0:00:00.769106524   874 0x75902150 DEBUG   imxphysmembufferpool ../src/common/phys_mem_buffer_pool.c:248:gst_imx_phys_mem_buffer_pool_alloc_buffer:<imxphysmembufferpool0> phys mem meta padding: x/y 0/0 using horiz/vert alignment: 16/8
0:00:00.769217194   874 0x75902150 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:178:gst_imx_phys_mem_allocator_map:<imxipuallocator0> mapping 2626560 bytes from memory block 0x75908d50 (phys addr 0x4b100000), current mapping refcount = 0 -> 1
0:00:00.769357866   874 0x75902150 LOG          imxipuallocator ../src/ipu/allocator.c:123:gst_imx_ipu_map_phys_mem:<imxipuallocator0> mapped IPU physmem memory:  virt addr 0x72b6e000  phys addr 0x4b100000
0:00:00.769437868   874 0x75902150 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:178:gst_imx_phys_mem_allocator_map:<imxipuallocator0> mapping 2626560 bytes from memory block 0x75908d50 (phys addr 0x4b100000), current mapping refcount = 1 -> 2
0:00:00.769507537   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.769523204   874 0x75902150 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:178:gst_imx_phys_mem_allocator_map:<imxipuallocator0> mapping 2626560 bytes from memory block 0x75908d50 (phys addr 0x4b100000), current mapping refcount = 2 -> 3
0:00:00.769591873   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.773289663   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.773744012   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.775391067   874 0x75902150 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:205:gst_imx_phys_mem_allocator_unmap:<imxipuallocator0> unmapping memory block 0x75908d50 (phys addr 0x4b100000), current mapping refcount = 3 -> 2
0:00:00.775530071   874 0x75902150 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:205:gst_imx_phys_mem_allocator_unmap:<imxipuallocator0> unmapping memory block 0x75908d50 (phys addr 0x4b100000), current mapping refcount = 2 -> 1
0:00:00.775619074   874 0x75902150 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:205:gst_imx_phys_mem_allocator_unmap:<imxipuallocator0> unmapping memory block 0x75908d50 (phys addr 0x4b100000), current mapping refcount = 1 -> 0
0:00:00.775791080   874 0x75902150 LOG          imxipuallocator ../src/ipu/allocator.c:135:gst_imx_ipu_unmap_phys_mem:<imxipuallocator0> unmapped IPU physmem memory:  virt addr 0x72b6e000  phys addr 0x4b100000
0:00:00.775889416   874 0x75902150 LOG            imxipublitter ../src/ipu/blitter.c:414:gst_imx_ipu_blitter_blit_frame:<imxipublitter0> task input:  width:  1440  height: 912  format: 0x50323234  crop: 0,0 1440x912  phys addr 0x4b100000  deinterlace enable 0 motion 0x0
0:00:00.775988086   874 0x75902150 LOG            imxipublitter ../src/ipu/blitter.c:423:gst_imx_ipu_blitter_blit_frame:<imxipublitter0> task output:  width:  1280  height: 1024  format: 0x41524742 crop: 0,107 1280x810  paddr 0x40100000  rotate: 0
0:00:00.776080756   874 0x75902150 LOG            imxipublitter ../src/ipu/blitter.c:436:gst_imx_ipu_blitter_blit_frame:<imxipublitter0> need to clear empty regions
0:00:00.776146758   874 0x75902150 LOG            imxipublitter ../src/ipu/blitter.c:461:gst_imx_ipu_blitter_blit_frame:<imxipublitter0> clear op task input:  width:  64  height: 64  format: 0x34424752 crop: 0,0 1440x912  phys addr 0x400f4000  deinterlace enable 0 motion 0x0
0:00:00.776266096   874 0x75902150 LOG            imxipublitter ../src/ipu/blitter.c:470:gst_imx_ipu_blitter_blit_frame:<imxipublitter0> clear op task output:  width:  1280  height: 1024  format: 0x41524742  crop: 0,0 1280x1024  paddr 0x40100000  rotate: 0
0:00:00.777719144   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.778291163   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.780808580   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.781069589   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.783764345   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.784042355   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.786569105   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.786845781   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.789352865   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.789625540   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.792153291   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.792441634   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.794923384   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.795226727   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.797720477   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.797989152   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.800487569   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.800753244   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.803279662   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.803554671   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.806044754   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.806329430   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.808818513   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.809086855   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.811584605   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.811854614   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.813589672   874 0x75902150 ERROR          imxipublitter ../src/ipu/blitter.c:474:gst_imx_ipu_blitter_blit_frame:<imxipublitter0> queuing IPU task failed: Invalid argument
0:00:00.816013086   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.816428433   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.820376564   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.820694242   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
Pipeline is PREROLLED ...
Setting pipeline to PLAYING ...
0:00:00.825322729   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.825384731   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
New clock: GstSystemClock
0:00:00.827711475   874 0x75902150 TRACE         imxbaseblitter ../src/common/base_blitter.c:160:gst_imx_base_blitter_set_input_buffer:<imxipublitter0> input buffer does not use DMA memory - need to copy it to an internal input DMA buffer
0:00:00.827728142   874   0x8460c0 LOG                imxvpudec ../src/vpu/decoder/decoder.c:925:gst_imx_vpu_dec_handle_frame:<imxvpudec0> VPU_DecDecodeBuf returns: 109
0:00:00.828056153   874   0x8460c0 DEBUG              imxvpudec ../src/vpu/decoder/decoder.c:1042:gst_imx_vpu_dec_handle_frame:<imxvpudec0> need more input
0:00:00.828229826   874 0x75902150 LOG      imxphysmemallocator ../src/common/phys_mem_allocator.c:178:gst_imx_phys_mem_allocator_map:<imxipuallocator0> mapping 2626560 bytes from