[meta-freescale] imxvpudec vs. jpegdec and when I need blocksize ?

Peter Hafner p.hafner75 at gmail.com
Sun Jan 18 01:33:32 PST 2015


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 at 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 at 0x783910> 
>>>> initializing physical memory allocator
>>>> 0:00:00.085588174   874   0x845780 INFO imxipuallocator 
>>>> ../src/ipu/allocator.c:169:gst_imx_ipu_allocator_init:<GstImxIpuAllocator at 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 at 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 at 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 at 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 at 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
>>>>
>>>
>>
>

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.yoctoproject.org/pipermail/meta-freescale/attachments/20150118/2d1ef4d5/attachment-0001.html>


More information about the meta-freescale mailing list