[meta-freescale] imxvpudec vs. jpegdec and when I need blocksize ?
Carlos Rafael Giani
dv at pseudoterminal.org
Sun Jan 18 03:02:53 PST 2015
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 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/adcfa08e/attachment-0001.html>
More information about the meta-freescale
mailing list