This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

TDA4VM: 09-01-00-06 SDK codec seems to be a problem?

Part Number: TDA4VM

Tool/software:

Dear experts,

I ran the demo in the official SDK, used the official development board, and ran the decoding function. I encountered the following error:

[ 1314.227896] unclassified data detected!

the detailed log is as follows:

root@j721e-evm:/opt/vision_apps# ./vx_app_multi_cam_codec.out --cfg /opt/vision_apps/app_multi_cam_codec.cfg
APP: Init ... !!!
MEM: Init ... !!!
MEM: Initialized DMA HEAP (fd=5) !!!
MEM: Init ... Done !!!
IPC: Init ... !!!
IPC: Init ... Done !!!
REMOTE_SERVICE: Init ... !!!
REMOTE_SERVICE: Init ... Done !!!
  2464.963754 s: GTC Frequency = 200 MHz
APP: Init ... Done !!!
  2464.967245 s:  VX_ZONE_INIT:Enabled
  2464.967286 s:  VX_ZONE_ERROR:Enabled
  2464.967292 s:  VX_ZONE_WARNING:Enabled
  2464.970489 s:  VX_ZONE_INIT:[tivxInitLocal:130] Initialization Done !!!
  2464.974870 s:  VX_ZONE_INIT:[tivxHostInitLocal:101] Initialization Done for HOST !!!
  2464.979141 s: ISS: Enumerating sensors ... !!!
  2465.379874 s: ISS: Enumerating sensors ... found 0 : IMX390-UB953_D3
  2465.379930 s: ISS: Enumerating sensors ... found 1 : AR0233-UB953_MARS
  2465.379936 s: ISS: Enumerating sensors ... found 2 : AR0820-UB953_LI
  2465.379942 s: ISS: Enumerating sensors ... found 3 : UB9xxx_RAW12_TESTPATTERN
  2465.379947 s: ISS: Enumerating sensors ... found 4 : UB96x_UYVY_TESTPATTERN
  2465.379952 s: ISS: Enumerating sensors ... found 5 : GW_AR0233_UYVY
Sensor selected : IMX390-UB953_D3
Querying IMX390-UB953_D3
  2465.379970 s: ISS: Querying sensor [IMX390-UB953_D3] ... !!!
[MCU2_0]   2465.379440 s: Error writing 0x2 to UB960 register 0x1
  2465.380087 s: ISS: Querying sensor [IMX390-UB953_D3] ... Done !!!
[MCU2_0]   2465.379515 s:  UB960 Error: Reg Write Failed for regAddr 1, cnt = 0
Capture->Encode Selection Yes(1)/No(0)
[MCU2_0]   2465.379567 s: Error : ub960_cfgScript returned -1 while configuring DES 0
[MCU2_0]   2465.379660 s: Error writing 0x2 to UB960 register 0x1
[MCU2_0]   2465.379703 s:  UB960 Error: Reg Write Failed for regAddr 1, cnt = 0
[MCU2_0]   2465.379748 s: Error :  returned -1 while configuring DES 1
0
Decode->Display Selection Yes(1)/No(0)
1
Max number of cameras supported by sensor IMX390-UB953_D3 = 12
Please enter number of channels to be enabled
1
gst_wrapper: GstCmdString:
filesrc location=/opt/vision_apps/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
! h264parse
! v4l2h264dec capture-io-mode=dmabuf-import
! video/x-raw, format=(string)NV12
! tiovxmemalloc pool-size=15
! appsink name=myAppSink0 drop=true wait-on-eos=false max-buffers=4



 =========================
 Demo : Camera Demo
 =========================

 s: Save CSIx, VISS and LDC outputs

 p: Print performance statistics

 x: Exit

 Enter Choice: [ 1314.227896] unclassified data detected!




 =========================
 Demo : Camera Demo
 =========================

 s: Save CSIx, VISS and LDC outputs

 p: Print performance statistics

 x: Exit

 Enter Choice: p


Summary of CPU load,
====================

CPU: mpu1_0: TOTAL LOAD =   1.27 % ( HWI =   0. 6 %, SWI =   0. 3 % )
CPU: mcu2_0: TOTAL LOAD =   7. 0 % ( HWI =   0. 0 %, SWI =   0. 0 % )
CPU: mcu2_1: TOTAL LOAD =   1. 0 % ( HWI =   0. 0 %, SWI =   0. 0 % )
CPU:  c6x_1: TOTAL LOAD =   0. 0 % ( HWI =   0. 0 %, SWI =   0. 0 % )
CPU:  c6x_2: TOTAL LOAD =   0. 0 % ( HWI =   0. 0 %, SWI =   0. 0 % )
CPU:  c7x_1: TOTAL LOAD =   0. 0 % ( HWI =   0. 0 %, SWI =   0. 0 % )


HWA performance statistics,
===========================



DDR performance statistics,
===========================

DDR: READ  BW: AVG =     24 MB/s, PEAK =   3832 MB/s
DDR: WRITE BW: AVG =     29 MB/s, PEAK =   8050 MB/s
DDR: TOTAL BW: AVG =     53 MB/s, PEAK =  11882 MB/s


Detailed CPU performance/memory statistics,
===========================================

DDR_SHARED_MEM: Alloc's: 29 alloc's of 84074428 bytes
DDR_SHARED_MEM: Free's : 4 free's  of 12533760 bytes
DDR_SHARED_MEM: Open's : 25 allocs  of 71540668 bytes

CPU: mcu2_0: TASK:      FREERTOS_TA:   0.66 %
CPU: mcu2_0: TASK:           IPC_RX:   0. 0 %
CPU: mcu2_0: TASK:       REMOTE_SRV:   0. 0 %
CPU: mcu2_0: TASK:        LOAD_TEST:   0. 0 %
CPU: mcu2_0: TASK:      lwIP main l:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CPU_0:   0. 0 %
CPU: mcu2_0: TASK:        TIVX_V1NF:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_V1LDC:   0. 0 %
CPU: mcu2_0: TASK:      TIVX_V1MSC1:   0. 0 %
CPU: mcu2_0: TASK:      TIVX_V1MSC2:   0. 0 %
CPU: mcu2_0: TASK:      TIVX_V1VISS:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT1:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT2:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_DISP1:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_DISP2:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CSITX:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT3:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT4:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT5:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT6:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT7:   0. 0 %
CPU: mcu2_0: TASK:       TIVX_CAPT8:   0. 0 %
CPU: mcu2_0: TASK:      TIVX_DPM2M1:   0. 0 %
CPU: mcu2_0: TASK:      TIVX_DPM2M2:   0. 0 %

CPU: mcu2_0: HEAP:    DDR_LOCAL_MEM: size =   16777216 B, free =   16760064 B ( 99 % unused)
CPU: mcu2_0: HEAP:           L3_MEM: size =     262144 B, free =     261888 B ( 99 % unused)

CPU: mcu2_1: TASK:      FREERTOS_TA:   0.65 %
CPU: mcu2_1: TASK:           IPC_RX:   0. 0 %
CPU: mcu2_1: TASK:       REMOTE_SRV:   0. 0 %
CPU: mcu2_1: TASK:        LOAD_TEST:   0. 0 %
CPU: mcu2_1: TASK:       TIVX_CPU_1:   0. 0 %
CPU: mcu2_1: TASK:         TIVX_SDE:   0. 0 %
CPU: mcu2_1: TASK:         TIVX_DOF:   0. 0 %
CPU: mcu2_1: TASK:      IPC_TEST_RX:   0. 0 %
CPU: mcu2_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU: mcu2_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU: mcu2_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU: mcu2_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU: mcu2_1: TASK:      IPC_TEST_TX:   0. 0 %

CPU: mcu2_1: HEAP:    DDR_LOCAL_MEM: size =   16777216 B, free =   16773376 B ( 99 % unused)
CPU: mcu2_1: HEAP:           L3_MEM: size =     262144 B, free =     262144 B (100 % unused)

CPU:  c6x_1: TASK:      FREERTOS_TA:   0. 0 %
CPU:  c6x_1: TASK:           IPC_RX:   0. 0 %
CPU:  c6x_1: TASK:       REMOTE_SRV:   0. 0 %
CPU:  c6x_1: TASK:        LOAD_TEST:   0. 0 %
CPU:  c6x_1: TASK:         TIVX_CPU:   0. 0 %
CPU:  c6x_1: TASK:      IPC_TEST_RX:   0. 0 %
CPU:  c6x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_1: TASK:      IPC_TEST_TX:   0. 0 %

CPU:  c6x_1: HEAP:    DDR_LOCAL_MEM: size =   16777216 B, free =   16773376 B ( 99 % unused)
CPU:  c6x_1: HEAP:           L2_MEM: size =     229376 B, free =     229376 B (100 % unused)
CPU:  c6x_1: HEAP:  DDR_SCRATCH_MEM: size =   50331648 B, free =   50331648 B (100 % unused)

CPU:  c6x_2: TASK:      FREERTOS_TA:   0. 0 %
CPU:  c6x_2: TASK:           IPC_RX:   0. 0 %
CPU:  c6x_2: TASK:       REMOTE_SRV:   0. 0 %
CPU:  c6x_2: TASK:        LOAD_TEST:   0. 0 %
CPU:  c6x_2: TASK:         TIVX_CPU:   0. 0 %
CPU:  c6x_2: TASK:      IPC_TEST_RX:   0. 0 %
CPU:  c6x_2: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_2: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_2: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_2: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c6x_2: TASK:      IPC_TEST_TX:   0. 0 %

CPU:  c6x_2: HEAP:    DDR_LOCAL_MEM: size =   16777216 B, free =   16773376 B ( 99 % unused)
CPU:  c6x_2: HEAP:           L2_MEM: size =     229376 B, free =     229376 B (100 % unused)
CPU:  c6x_2: HEAP:  DDR_SCRATCH_MEM: size =   50331648 B, free =   50331648 B (100 % unused)

CPU:  c7x_1: TASK:      FREERTOS_TA:   0. 0 %
CPU:  c7x_1: TASK:           IPC_RX:   0. 0 %
CPU:  c7x_1: TASK:       REMOTE_SRV:   0. 0 %
CPU:  c7x_1: TASK:        LOAD_TEST:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P1:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P2:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P3:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P4:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P5:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P6:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P7:   0. 0 %
CPU:  c7x_1: TASK:      TIVX_C71_P8:   0. 0 %
CPU:  c7x_1: TASK:      IPC_TEST_RX:   0. 0 %
CPU:  c7x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c7x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c7x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c7x_1: TASK:      IPC_TEST_TX:   0. 0 %
CPU:  c7x_1: TASK:      IPC_TEST_TX:   0. 0 %

CPU:  c7x_1: HEAP:    DDR_LOCAL_MEM: size =  268435456 B, free =  268435200 B ( 99 % unused)
CPU:  c7x_1: HEAP:           L3_MEM: size =    8159232 B, free =    8159232 B (100 % unused)
CPU:  c7x_1: HEAP:           L2_MEM: size =     458752 B, free =     458752 B (100 % unused)
CPU:  c7x_1: HEAP:           L1_MEM: size =      16384 B, free =      16384 B (100 % unused)
CPU:  c7x_1: HEAP:  DDR_SCRATCH_MEM: size =  385875968 B, free =  385875968 B (100 % unused)


GRAPH:    display_graph (#nodes =   2, #executions =      0)
 NODE:      VPAC_MSC1:          img_mosaic_node: avg =      0 usecs, min/max = 18446744073709551 /      0 usecs, #executions =          0
 NODE:       DISPLAY1:              DisplayNode: avg =      0 usecs, min/max = 18446744073709551 /      0 usecs, #executions =          0

 PERF:           FILEIO: avg =      0 usecs, min/max = 4294967295 /      0 usecs, #executions =          0
 PERF:            TOTAL: avg =   9286 usecs, min/max =      0 /  64998 usecs, #executions =          7

 PERF:            TOTAL:  107.68 FPS

GST_WRAPPER PUSH/PULL COUNTS:

Push count : -1
Pull count : 0

Regards,

Xin

  • Hi experts,

    I tested the Gstreamer code on the command line, which was also problematic, as shown below:

    root@Linux:~# gst-launch-1.0 filesrc location=/opt/vision_apps/test_encode/0000000500.yuv  rawvideoparse width=1024 height=512 format=nv12 framerate=30/1  ! v4l2h264enc ! filesink location=/opt/vision_apps/test_encode/test.264
    Setting pipeline to PAUSED ...
    Pipeline is PREROLLING ...
    ERROR: from element /GstPipeline:pipeline0/GstFileSrc:filesrc0: Internal data stream error.
    Additional debug info:
    ../gstreamer-1.20.7/libs/gst/base/gstbasesrc.c(3127): gst_base_src_loop (): /GstPipeline:pipeline0/GstFileSrc:filesrc0:
    streaming stopped, reason not-linked (-1)
    ERROR: pipeline doesn't want to preroll.
    Setting pipeline to NULL ...
    Freeing pipeline ...
    root@Linux:~#
    

    Regards,

    Xin

  • Hi Xin, 

    The "unclassified data detected" print that you are seeing is just a warning. Nothing should be wrong with the decoder.

    However, I recommend switching to the 9.2 SDK version. Encoding is broken for the TDA4VM 9.1 release (FAQ). 

    Thanks,
    Sarabesh S.

  • Hi Sarabesh S,

    Is the 9.2 SDK version encoding and decoding verification OK?

    Regards,

    Xin

  • Hi Sarabesh S,

    Is there a patch to fix the 9.1 SDK codec issues?

    Regards,

    Xin

  • Hi Xin, 

    Unfortunately there has yet to be one released. The fix was made in the 9.2 SDK. Please make the transition to the 9.2 release if possible. SDK 10.0 is being released soon so efforts to back-port may not be possible. 

    Thanks,
    Sarabesh S.

  • Hi Sarabesh,

    What is the reason for the following error when decoding?

    VX_ZONE_ERROR:[tivxReferenceImportHandle:1589] [Entry 1] Memory size mis-match: Expecting [3133440] but given [2088960]

    The detailed log is as follows:

    root@j721e-evm:/opt/vision_apps/test_decode# ./test_decode.sh
    APP: Init ... !!!
    MEM: Init ... !!!
    MEM: Initialized DMA HEAP (fd=5) !!!
    MEM: Init ... Done !!!
    IPC: Init ... !!!
    IPC: Init ... Done !!!
    REMOTE_SERVICE: Init ... !!!
    REMOTE_SERVICE: Init ... Done !!!
       413.915708 s: GTC Frequency = 200 MHz
    APP: Init ... Done !!!
       413.915802 s:  VX_ZONE_INIT:Enabled
       413.915812 s:  VX_ZONE_ERROR:Enabled
       413.916760 s:  VX_ZONE_WARNING:Enabled
       413.917359 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-0
       413.917635 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-1
       413.917793 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-2
       413.917926 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-3
       413.917939 s:  VX_ZONE_INIT:[tivxInitLocal:136] Initialization Done !!!
       413.918457 s:  VX_ZONE_INIT:[tivxHostInitLocal:101] Initialization Done for HOST !!!
    in_width = 1920 , in_height = 1088
    app_update_param_set done!
    Creating context done!
    Kernel loading done!
    Img Mosaic init done!
    App Init Done!
    display_graph create done!
    Img Mosaic graph done!
    gst_wrapper: GstCmdString:
    filesrc location=/opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/TI_Custom_1920x1080_5secs.264
    ! h264parse
    ! v4l2h264dec capture-io-mode=dmabuf-import
    ! video/x-raw, format=(string)NV12
    ! tiovxmemalloc pool-size=10
    ! appsink name=myAppSink0 drop=true wait-on-eos=false max-buffers=4
    
    Codec Pipeline done!
    App Create Graph Done!
    Display Graph verify done!
    appCodecSinkInit Done!
    App Verify Graph Done!
    app_pipeline_params_defaults returned
    appCodecStart Done!
       414.190365 s:  VX_ZONE_ERROR:[tivxReferenceImportHandle:1589] [Entry 1] Memory size mis-match: Expecting [3133440] but given [2088960]
    

    When I switched the decoded h264 file and set GST_DEBUG=4, I encountered the following problems:

    root@j721e-evm:/opt/vision_apps/test_decode# ./test_decode.sh
    APP: Init ... !!!
    MEM: Init ... !!!
    MEM: Initialized DMA HEAP (fd=5) !!!
    MEM: Init ... Done !!!
    IPC: Init ... !!!
    IPC: Init ... Done !!!
    REMOTE_SERVICE: Init ... !!!
    REMOTE_SERVICE: Init ... Done !!!
      3050.439629 s: GTC Frequency = 200 MHz
    APP: Init ... Done !!!
      3050.443329 s:  VX_ZONE_INIT:Enabled
      3050.443508 s:  VX_ZONE_ERROR:Enabled
      3050.443573 s:  VX_ZONE_WARNING:Enabled
      3050.447890 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-0
      3050.448151 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-1
      3050.448303 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-2
      3050.448452 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-3
      3050.448523 s:  VX_ZONE_INIT:[tivxInitLocal:136] Initialization Done !!!
      3050.452300 s:  VX_ZONE_INIT:[tivxHostInitLocal:101] Initialization Done for HOST !!!
    in_width = 1920 , in_height = 1088
    app_update_param_set done!
    Creating context done!
    Kernel loading done!
    Img Mosaic init done!
    App Init Done!
    display_graph create done!
    Img Mosaic graph done!
    gst_wrapper: GstCmdString:
    filesrc location=/opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    ! h264parse
    ! v4l2h264dec capture-io-mode=dmabuf-import
    ! video/x-raw, format=(string)NV12
    ! tiovxmemalloc pool-size=10
    ! appsink name=myAppSink0 drop=true wait-on-eos=false max-buffers=4
    
    0:00:00.010396721  1527      0x35dda00 INFO                GST_INIT gst.c:591:init_pre: Initializing GStreamer Core Library version 1.20.7
    0:00:00.010662733  1527      0x35dda00 INFO                GST_INIT gst.c:592:init_pre: Using library installed in /usr/lib
    0:00:00.010772327  1527      0x35dda00 INFO                GST_INIT gst.c:610:init_pre: Linux j721e-evm 6.1.80-ti-g2e423244f8c0 #1 SMP PREEMPT Wed Mar 20 14:43:33 UTC 2024 aarch64
    0:00:00.011599138  1527      0x35dda00 INFO                GST_INIT gstmessage.c:129:_priv_gst_message_initialize: init messages
    0:00:00.017423792  1527      0x35dda00 INFO                GST_INIT gstcontext.c:86:_priv_gst_context_initialize: init contexts
    0:00:00.017903220  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:324:_priv_gst_plugin_initialize: registering 0 static plugins
    0:00:00.018256879  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:232:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.018385409  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:234:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.018562448  1527      0x35dda00 INFO            GST_REGISTRY gstregistry.c:1826:ensure_current_registry: reading registry cache: /home/root/.cache/gstreamer-1.0/registry.aarch64.bin
    0:00:00.054827372  1527      0x35dda00 INFO            GST_REGISTRY gstregistrybinary.c:683:priv_gst_registry_binary_read_cache: loaded /home/root/.cache/gstreamer-1.0/registry.aarch64.bin in 0.036108 seconds
    0:00:00.055015087  1527      0x35dda00 INFO            GST_REGISTRY gstregistry.c:1693:scan_and_update_registry: Validating plugins from registry cache: /home/root/.cache/gstreamer-1.0/registry.aarch64.bin
    0:00:00.068929757  1527      0x35dda00 INFO            GST_REGISTRY gstregistry.c:1375:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-1.0/libgstvideo4linux2.so is stale
    0:00:00.000206542  1538     0x3c0a8200 INFO                GST_INIT gst.c:591:init_pre: Initializing GStreamer Core Library version 1.20.7
    0:00:00.000445811  1538     0x3c0a8200 INFO                GST_INIT gst.c:592:init_pre: Using library installed in /usr/lib
    0:00:00.000529488  1538     0x3c0a8200 INFO                GST_INIT gst.c:610:init_pre: Linux j721e-evm 6.1.80-ti-g2e423244f8c0 #1 SMP PREEMPT Wed Mar 20 14:43:33 UTC 2024 aarch64
    0:00:00.001005736  1538     0x3c0a8200 INFO                GST_INIT gstmessage.c:129:_priv_gst_message_initialize: init messages
    0:00:00.001876131  1538     0x3c0a8200 INFO                GST_INIT gstcontext.c:86:_priv_gst_context_initialize: init contexts
    0:00:00.002295955  1538     0x3c0a8200 INFO      GST_PLUGIN_LOADING gstplugin.c:324:_priv_gst_plugin_initialize: registering 0 static plugins
    0:00:00.002546695  1538     0x3c0a8200 INFO      GST_PLUGIN_LOADING gstplugin.c:232:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.002638282  1538     0x3c0a8200 INFO      GST_PLUGIN_LOADING gstplugin.c:234:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.002773978  1538     0x3c0a8200 INFO            GST_REGISTRY gstregistry.c:1861:ensure_current_registry: registry reading and updating done
    0:00:00.002869076  1538     0x3c0a8200 INFO                GST_INIT gst.c:826:init_post: GLib runtime version: 2.72.3
    0:00:00.002963913  1538     0x3c0a8200 INFO                GST_INIT gst.c:828:init_post: GLib headers version: 2.72.3
    0:00:00.003028724  1538     0x3c0a8200 INFO                GST_INIT gst.c:830:init_post: initialized GStreamer successfully
    0:00:00.060846997  1538     0x3c0a8200 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideo4linux2.so" loaded
    0:00:00.144838741  1527      0x35dda00 INFO            GST_REGISTRY gstregistry.c:1794:scan_and_update_registry: Registry cache changed. Writing new registry cache
    0:00:00.144888940  1527      0x35dda00 INFO            GST_REGISTRY gstregistrybinary.c:431:priv_gst_registry_binary_write_cache: Building binary registry cache image
    0:00:00.161833158  1527      0x35dda00 INFO            GST_REGISTRY gstregistrybinary.c:463:priv_gst_registry_binary_write_cache: Writing binary registry cache
    0:00:00.214730380  1527      0x35dda00 INFO            GST_REGISTRY gstregistrybinary.c:314:gst_registry_binary_cache_finish: Wrote binary registry cache
    0:00:00.214875792  1527      0x35dda00 INFO            GST_REGISTRY gstregistry.c:1803:scan_and_update_registry: Registry cache written successfully
    0:00:00.214910675  1527      0x35dda00 INFO            GST_REGISTRY gstregistry.c:1861:ensure_current_registry: registry reading and updating done
    0:00:00.214936062  1527      0x35dda00 INFO                GST_INIT gst.c:826:init_post: GLib runtime version: 2.72.3
    0:00:00.214956464  1527      0x35dda00 INFO                GST_INIT gst.c:828:init_post: GLib headers version: 2.72.3
    0:00:00.214970910  1527      0x35dda00 INFO                GST_INIT gst.c:830:init_post: initialized GStreamer successfully
    0:00:00.215076058  1527      0x35dda00 INFO            GST_PIPELINE gstparse.c:344:gst_parse_launch_full: parsing pipeline description 'filesrc location=/opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    ! h264parse
    ! v4l2h264dec capture-io-mode=dmabuf-import
    ! video/x-raw, format=(string)NV12
    ! tiovxmemalloc pool-size=10
    ! appsink name=myAppSink0 drop=true wait-on-eos=false max-buffers=4
    '
    0:00:00.226748123  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstcoreelements.so" loaded
    0:00:00.226804537  1527      0x35dda00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesrc"
    0:00:00.227082179  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseSrc@0x3a2a2e0> adding pad 'src'
    0:00:00.227165956  1527      0x35dda00 INFO                 filesrc gstfilesrc.c:237:gst_file_src_set_location: filename : /opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.227185053  1527      0x35dda00 INFO                 filesrc gstfilesrc.c:238:gst_file_src_set_location: uri      : file:///opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.266845014  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideoparsersbad.so" loaded
    0:00:00.266890108  1527      0x35dda00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "h264parse"
    0:00:00.267112521  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseParse@0x3a2e270> adding pad 'sink'
    0:00:00.267154599  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseParse@0x3a2e270> adding pad 'src'
    0:00:00.267286375  1527      0x35dda00 INFO               baseparse gstbaseparse.c:4049:gst_base_parse_set_pts_interpolation:<GstH264Parse@0x3a2e270> PTS interpolation: no
    0:00:00.267305827  1527      0x35dda00 INFO               baseparse gstbaseparse.c:4067:gst_base_parse_set_infer_ts:<GstH264Parse@0x3a2e270> TS inferring: no
    0:00:00.273846798  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideo4linux2.so" loaded
    0:00:00.273891597  1527      0x35dda00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "v4l2h264dec"
    0:00:00.274129516  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstVideoDecoder@0x3974c10> adding pad 'sink'
    0:00:00.274169539  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstVideoDecoder@0x3974c10> adding pad 'src'
    0:00:00.299746192  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgsttiovx.so" loaded
    0:00:00.299792726  1527      0x35dda00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "tiovxmemalloc"
    0:00:00.299984831  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x3a3c360> adding pad 'sink'
    0:00:00.300040996  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x3a3c360> adding pad 'src'
    0:00:00.301262494  1527      0x35dda00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstapp.so" loaded
    0:00:00.301303358  1527      0x35dda00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "appsink"
    0:00:00.301604852  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseSink@0x3a36c70> adding pad 'sink'
    0:00:00.301712706  1527      0x35dda00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "pipeline"
    0:00:00.301930398  1527      0x35dda00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of GstFileSrc named filesrc0 to some pad of GstH264Parse named h264parse0 (0/0) with caps "(NULL)"
    0:00:00.301958490  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element filesrc0:(any) to element h264parse0:(any)
    0:00:00.301984997  1527      0x35dda00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link filesrc0:src and h264parse0:sink
    0:00:00.302036097  1527      0x35dda00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<h264parse0:src> pad has no peer
    0:00:00.302072554  1527      0x35dda00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: filesrc0 and h264parse0 in same bin, no need for ghost pads
    0:00:00.302107422  1527      0x35dda00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link filesrc0:src and h264parse0:sink
    0:00:00.302133064  1527      0x35dda00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<h264parse0:src> pad has no peer
    0:00:00.302161247  1527      0x35dda00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked filesrc0:src and h264parse0:sink, successful
    0:00:00.302176778  1527      0x35dda00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.302193234  1527      0x35dda00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<filesrc0:src> Received event on flushing pad. Discarding
    0:00:00.302228247  1527      0x35dda00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of GstH264Parse named h264parse0 to some pad of v4l2h264dec named v4l2h264dec0 (0/0) with caps "(NULL)"
    0:00:00.302248824  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element h264parse0:(any) to element v4l2h264dec0:(any)
    0:00:00.302271435  1527      0x35dda00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link h264parse0:src and v4l2h264dec0:sink
    0:00:00.302332555  1527      0x35dda00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<v4l2h264dec0:src> pad has no peer
    0:00:00.302396471  1527      0x35dda00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: h264parse0 and v4l2h264dec0 in same bin, no need for ghost pads
    0:00:00.302426843  1527      0x35dda00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link h264parse0:src and v4l2h264dec0:sink
    0:00:00.302452340  1527      0x35dda00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<v4l2h264dec0:src> pad has no peer
    0:00:00.302491933  1527      0x35dda00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked h264parse0:src and v4l2h264dec0:sink, successful
    0:00:00.302507504  1527      0x35dda00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.302522866  1527      0x35dda00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<h264parse0:src> Received event on flushing pad. Discarding
    0:00:00.302562944  1527      0x35dda00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of v4l2h264dec named v4l2h264dec0 to some pad of GstTIOVXMemAlloc named tiovxmemalloc0 (0/0) with caps "video/x-raw, format=(string)NV12"
    0:00:00.302615033  1527      0x35dda00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "capsfilter"
    0:00:00.302764530  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x3a44160> adding pad 'sink'
    0:00:00.302800548  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x3a44160> adding pad 'src'
    0:00:00.302830625  1527      0x35dda00 INFO              GST_STATES gstbin.c:2070:gst_bin_get_state_func:<pipeline0> getting state
    0:00:00.302884890  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<capsfilter0> completed state change to NULL
    0:00:00.302915232  1527      0x35dda00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.302945805  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element v4l2h264dec0:(any) to element capsfilter0:sink
    0:00:00.302965516  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:1018:gst_element_get_static_pad: found pad capsfilter0:sink
    0:00:00.302984418  1527      0x35dda00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: v4l2h264dec0 and capsfilter0 in same bin, no need for ghost pads
    0:00:00.303012820  1527      0x35dda00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link v4l2h264dec0:src and capsfilter0:sink
    0:00:00.303046843  1527      0x35dda00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<capsfilter0:src> pad has no peer
    0:00:00.303082551  1527      0x35dda00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked v4l2h264dec0:src and capsfilter0:sink, successful
    0:00:00.303097952  1527      0x35dda00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.303113373  1527      0x35dda00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<v4l2h264dec0:src> Received event on flushing pad. Discarding
    0:00:00.303138190  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element capsfilter0:src to element tiovxmemalloc0:(any)
    0:00:00.303155657  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstelement.c:1018:gst_element_get_static_pad: found pad capsfilter0:src
    0:00:00.303176823  1527      0x35dda00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link capsfilter0:src and tiovxmemalloc0:sink
    0:00:00.303212581  1527      0x35dda00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<tiovxmemalloc0:src> pad has no peer
    0:00:00.303242834  1527      0x35dda00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: capsfilter0 and tiovxmemalloc0 in same bin, no need for ghost pads
    0:00:00.303267046  1527      0x35dda00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link capsfilter0:src and tiovxmemalloc0:sink
    0:00:00.303299163  1527      0x35dda00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<tiovxmemalloc0:src> pad has no peer
    0:00:00.303323780  1527      0x35dda00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked capsfilter0:src and tiovxmemalloc0:sink, successful
    0:00:00.303337706  1527      0x35dda00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.303352983  1527      0x35dda00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<capsfilter0:src> Received event on flushing pad. Discarding
    0:00:00.303386105  1527      0x35dda00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of GstTIOVXMemAlloc named tiovxmemalloc0 to some pad of GstAppSink named myAppSink0 (0/0) with caps "(NULL)"
    0:00:00.303405167  1527      0x35dda00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element tiovxmemalloc0:(any) to element myAppSink0:(any)
    0:00:00.303426148  1527      0x35dda00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link tiovxmemalloc0:src and myAppSink0:sink
    0:00:00.303471722  1527      0x35dda00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: tiovxmemalloc0 and myAppSink0 in same bin, no need for ghost pads
    0:00:00.303496319  1527      0x35dda00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link tiovxmemalloc0:src and myAppSink0:sink
    0:00:00.303537527  1527      0x35dda00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked tiovxmemalloc0:src and myAppSink0:sink, successful
    0:00:00.303552324  1527      0x35dda00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.303568135  1527      0x35dda00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<tiovxmemalloc0:src> Received event on flushing pad. Discarding
    Codec Pipeline done!
    App Create Graph Done!
    Display Graph verify done!
    0:00:00.318673870  1527      0x35dda00 INFO           GST_PARENTAGE gstbin.c:4378:gst_bin_get_by_name: [pipeline0]: looking up child element myAppSink0
    appCodecSinkInit Done!
    App Verify Graph Done!
    app_pipeline_params_defaults returned
    0:00:00.418934691  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<myAppSink0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.419001501  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<myAppSink0> completed state change to READY
    0:00:00.419024367  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<myAppSink0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.419078027  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'myAppSink0' changed state to 2(READY) successfully
    0:00:00.419105214  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxmemalloc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.419125245  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<tiovxmemalloc0> completed state change to READY
    0:00:00.419142591  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<tiovxmemalloc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.419166903  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'tiovxmemalloc0' changed state to 2(READY) successfully
    0:00:00.419189675  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.419207621  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<capsfilter0> completed state change to READY
    0:00:00.419224383  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.419248454  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 2(READY) successfully
    0:00:00.419270451  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<v4l2h264dec0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.419660380  1527      0x35dda00 INFO                    v4l2 v4l2_calls.c:588:gst_v4l2_open:<v4l2h264dec0:sink> Opened device 'vxd-dec' (/dev/video0) successfully
    0:00:00.419693328  1527      0x35dda00 INFO                    v4l2 v4l2_calls.c:684:gst_v4l2_dup:<v4l2h264dec0:src> Cloned device 'vxd-dec' (/dev/video0) successfully
    0:00:00.419730216  1527      0x35dda00 INFO                    v4l2 gstv4l2object.c:1256:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink> got 3 format(s):
    0:00:00.419749202  1527      0x35dda00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink>   MJPG
    0:00:00.419765663  1527      0x35dda00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink>   HEVC
    0:00:00.419781655  1527      0x35dda00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink>   H264
    0:00:00.421890264  1527      0x35dda00 INFO                    v4l2 gstv4l2object.c:4764:gst_v4l2_object_probe_caps:<v4l2h264dec0:sink> probed caps: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }, parsed=(boolean)true
    0:00:00.421922876  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<v4l2h264dec0> completed state change to READY
    0:00:00.421944063  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<v4l2h264dec0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.421982796  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'v4l2h264dec0' changed state to 2(READY) successfully
    0:00:00.422016308  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<h264parse0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.422037550  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<h264parse0> completed state change to READY
    0:00:00.422054691  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.422077863  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully
    0:00:00.422099039  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.422117446  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<filesrc0> completed state change to READY
    0:00:00.422134727  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.422157829  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 2(READY) successfully
    0:00:00.422190421  1527      0x35dda00 INFO              GST_STATES gstelement.c:2780:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PLAYING, next PAUSED
    0:00:00.422209113  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed NULL to READY (PLAYING pending)
    0:00:00.422230554  1527      0x35dda00 INFO              GST_STATES gstelement.c:2788:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PLAYING
    0:00:00.422273018  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<myAppSink0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.422321011  1527      0x35dda00 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'myAppSink0' is changing state asynchronously to PAUSED
    0:00:00.422344568  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxmemalloc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.422375035  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<tiovxmemalloc0> completed state change to PAUSED
    0:00:00.422393572  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<tiovxmemalloc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.422429819  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'tiovxmemalloc0' changed state to 3(PAUSED) successfully
    0:00:00.422452771  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.422480143  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
    0:00:00.422497590  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.422521731  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 3(PAUSED) successfully
    0:00:00.422544243  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<v4l2h264dec0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.422604183  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<v4l2h264dec0> completed state change to PAUSED
    0:00:00.422622599  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<v4l2h264dec0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.422648221  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'v4l2h264dec0' changed state to 3(PAUSED) successfully
    0:00:00.422670868  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<h264parse0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.422865102  1527      0x35dda00 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file /opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.424168216  1527      0x35dda00 WARN                 basesrc gstbasesrc.c:3688:gst_base_src_start_complete:<filesrc0> pad not activated yet
    0:00:00.424250897  1527      0x35dda00 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file /opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.424613059  1527      0x35dda00 INFO               GST_EVENT gstevent.c:972:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
    0:00:00.424715407  1527      0x35dda00 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0x3a2c450 on task 0x3a304d0
    0:00:00.424737674  1527      0x35dda00 INFO                GST_PADS gstpad.c:6292:gst_pad_start_task:<h264parse0:sink> created task 0x3a304d0
    0:00:00.424943589  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<h264parse0> completed state change to PAUSED
    0:00:00.424977052  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.425011754  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 3(PAUSED) successfully
    0:00:00.425040041  1527      0x35dda00 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.425070004  1527      0x35dda00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<filesrc0> completed state change to PAUSED
    0:00:00.425088510  1527      0x35dda00 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.425112432  1527      0x35dda00 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 3(PAUSED) successfully
    0:00:00.425138009  1527      0x35dda00 INFO                pipeline gstpipeline.c:533:gst_pipeline_change_state:<pipeline0> pipeline is not live
    appCodecStart Done!
    0:00:00.425447927  1527      0x3a33b00 INFO        GST_ELEMENT_PADS gstelement.c:1018:gst_element_get_static_pad: found pad h264parse0:sink
    0:00:00.427770157  1527      0x3a33b00 INFO               h264parse gsth264parse.c:2093:gst_h264_parse_update_src_caps:<h264parse0> resolution changed 1920x1080
    0:00:00.428002920  1527      0x3a33b00 INFO               baseparse gstbaseparse.c:4093:gst_base_parse_set_latency:<h264parse0> min/max latency 0:00:00.033333333, 0:00:00.033333333
    0:00:00.428245573  1527      0x3a33b00 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-h264, width=(int)1920, height=(int)1080, framerate=(fraction)30/1, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, stream-format=(string)byte-stream, alignment=(string)au, profile=(string)high, level=(string)4
    0:00:00.433461197  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:3268:gst_v4l2_object_setup_pool:<v4l2h264dec0:sink> accessing buffers via mode 2
    0:00:00.434026014  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:593:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> increasing minimum buffers to 2
    0:00:00.434056182  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:606:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> reducing maximum buffers to 32
    0:00:00.434256432  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> can't allocate, setting maximum to minimum
    0:00:00.434385146  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:1256:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src> got 6 format(s):
    0:00:00.434461647  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   NV12
    0:00:00.434525587  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   YM12
    0:00:00.434584501  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   NV16
    0:00:00.434649536  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   YM16
    0:00:00.434709096  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   TI16
    0:00:00.434766065  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   TI12
    0:00:00.434893565  1527      0x3a33b00 WARN                    v4l2 gstv4l2object.c:4701:gst_v4l2_object_probe_caps:<v4l2h264dec0:src> Failed to probe pixel aspect ratio with VIDIOC_CROPCAP: Invalid argument
    0:00:00.435473399  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:4764:gst_v4l2_object_probe_caps:<v4l2h264dec0:src> probed caps: video/x-raw, format=(string)NV12, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string){ progressive, interleaved }, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw, format=(string)I420, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string){ progressive, interleaved }, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw, format=(string)NV16, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string){ progressive, interleaved }, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw(format:Interlaced), format=(string)NV12, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string)alternate, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw(format:Interlaced), format=(string)I420, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string)alternate, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw(format:Interlaced), format=(string)NV16, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string)alternate, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }
    0:00:00.435989697  1527      0x3a33b00 INFO               videometa gstvideometa.c:1072:gst_video_time_code_meta_api_get_type: registering
    0:00:00.436172736  1527      0x3a33b00 INFO            videodecoder gstvideodecoder.c:1637:gst_video_decoder_sink_event_default:<v4l2h264dec0> upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)";
    0:00:00.436402519  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> can't allocate, setting maximum to minimum
    0:00:00.438695792  1527      0x3a33b00 WARN                    v4l2 gstv4l2object.c:2359:gst_v4l2_object_get_streamparm:<v4l2h264dec0:src> VIDIOC_G_PARM failed
    0:00:00.443110405  1527      0x3a33b00 INFO                    v4l2 gstv4l2object.c:3268:gst_v4l2_object_setup_pool:<v4l2h264dec0:src> accessing buffers via mode 5
    0:00:00.443382635  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:593:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> increasing minimum buffers to 2
    0:00:00.443466992  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:606:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> reducing maximum buffers to 32
    0:00:00.443542887  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> can't allocate, setting maximum to minimum
    0:00:00.443559269  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:622:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> adding needed video meta
    0:00:00.443826329  1527      0x3a33b00 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.444088113  1527      0x3a33b00 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<capsfilter0> reuse caps
    0:00:00.444221204  1527      0x3a33b00 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.444330312  1527      0x3a33b00 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<tiovxmemalloc0> reuse caps
    0:00:00.444426659  1527      0x3a33b00 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.444534817  1527      0x3a33b00 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.444761859  1527      0x3a33b00 INFO            tiovxcontext gsttiovxcontext.c:141:gst_tiovx_context_init: Calling appInit() from GST!
    0:00:00.444993382  1527      0x3a33b00 INFO           tiovxmemalloc gsttiovxutils.c:629:gst_tiovx_get_exemplar_from_caps:<tiovxmemalloc0> creating image with width: 1920        height: 1080    format: 0x3231564e
    0:00:00.445176246  1527      0x3a33b00 INFO           tiovxmemalloc gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.445194597  1527      0x3a33b00 INFO           tiovxmemalloc gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.445541533  1527      0x3a33b00 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffff9002c130> New TIOVX buffer pool
    0:00:00.445792712  1527      0x3a33b00 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff9002d050> New TIOVX allocator
    0:00:00.445925632  1527      0x3a33b00 INFO           tiovxmemalloc gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 10 buffers of 3110400 size
    0:00:00.446090515  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:606:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> reducing maximum buffers to 32
    0:00:00.446162230  1527      0x3a33b00 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> can't allocate, setting maximum to minimum
    0:00:00.446292760  1527      0x3a33b00 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff9002d130> New TIOVX allocator
    0:00:00.477774180  1527      0x3a33b00 ERROR         v4l2bufferpool gstv4l2bufferpool.c:981:gst_v4l2_buffer_pool_start:<v4l2h264dec0:pool0:src> cannot import buffers from downstream pool
    0:00:00.477832864  1527      0x3a33b00 ERROR             bufferpool gstbufferpool.c:572:gst_buffer_pool_set_active:<v4l2h264dec0:pool0:src> start failed
    0:00:00.477897474  1527      0x3a33b00 ERROR         v4l2bufferpool gstv4l2bufferpool.c:981:gst_v4l2_buffer_pool_start:<v4l2h264dec0:pool0:src> cannot import buffers from downstream pool
    0:00:00.477929927  1527      0x3a33b00 ERROR             bufferpool gstbufferpool.c:572:gst_buffer_pool_set_active:<v4l2h264dec0:pool0:src> start failed
    0:00:00.477972025  1527      0x3a33b00 WARN            v4l2videodec gstv4l2videodec.c:904:gst_v4l2_video_dec_handle_frame:<v4l2h264dec0> error: Failed to allocate required memory.
    0:00:00.477998922  1527      0x3a33b00 WARN            v4l2videodec gstv4l2videodec.c:904:gst_v4l2_video_dec_handle_frame:<v4l2h264dec0> error: Buffer pool activation failed
    0:00:00.478044530  1527      0x3a33b00 INFO        GST_ERROR_SYSTEM gstelement.c:2273:gst_element_message_full_with_details:<v4l2h264dec0> posting message: Failed to allocate required memory.
    0:00:00.478180856  1527      0x3a33b00 INFO        GST_ERROR_SYSTEM gstelement.c:2300:gst_element_message_full_with_details:<v4l2h264dec0> posted error message: Failed to allocate required memory.
    0:00:00.478230574  1527      0x3a33b00 INFO            videodecoder gstvideodecoder.c:3150:gst_video_decoder_prepare_finish_frame:<v4l2h264dec0> Guessing PTS=0:00:00.000000000 for frame... DTS=0:00:00.000000000
    0:00:00.478329012  1527      0x3a33b00 WARN               baseparse gstbaseparse.c:3684:gst_base_parse_loop:<h264parse0> error: Internal data stream error.
    0:00:00.478351264  1527      0x3a33b00 WARN               baseparse gstbaseparse.c:3684:gst_base_parse_loop:<h264parse0> error: streaming stopped, reason error (-5)
    0:00:00.478392497  1527      0x3a33b00 INFO        GST_ERROR_SYSTEM gstelement.c:2273:gst_element_message_full_with_details:<h264parse0> posting message: Internal data stream error.
    0:00:00.478424894  1527      0x3a33b00 INFO        GST_ERROR_SYSTEM gstelement.c:2300:gst_element_message_full_with_details:<h264parse0> posted error message: Internal data stream error.
    0:00:00.478513021  1527      0x3a33b00 WARN            videodecoder gstvideodecoder.c:1419:gst_video_decoder_sink_event_default:<v4l2h264dec0> error: No valid frames decoded before end of stream
    0:00:00.478532257  1527      0x3a33b00 WARN            videodecoder gstvideodecoder.c:1419:gst_video_decoder_sink_event_default:<v4l2h264dec0> error: no valid frames found
    0:00:00.478558199  1527      0x3a33b00 INFO        GST_ERROR_SYSTEM gstelement.c:2273:gst_element_message_full_with_details:<v4l2h264dec0> posting message: No valid frames decoded before end of stream
    0:00:00.478585736  1527      0x3a33b00 INFO        GST_ERROR_SYSTEM gstelement.c:2300:gst_element_message_full_with_details:<v4l2h264dec0> posted error message: No valid frames decoded before end of stream
    

    Regards,

    Xin

  • Hi Xin,

    Is this still on the 9.1 SDK? I know in the Linux 9.1 SDK there are memory allocation issues as highlighted in the FAQ from my first response. This is likely still the case for Linux+RTOS (AKA Vision Apps) as well. Could you try this on 9.0 or 9.2 and see if the problem still persists?

    Thanks,
    Sarabesh S.

  • Hi Saeabesh,

    I tested the version 9.2, and there were no problems with the encoding, but there were problems with the decoding.

    Regards,

    Xin

  • Hi, 

    Could you please share what problems you are seeing? What pipeline or demo are you running? Are you able to test decode in just the Linux SDK or do you need Vision Apps (AKA Linux+RTOS)?

    Thanks,
    Sarabesh S.

  • Hi Sarabesh,

    I used linux+rtos mode, using the same interface as in the codec demo in vision Apps. When using only the Linux sdk, it can be decoded by command in the terminal. In my case, I got the following error:

    The detailed log is as follows:

    root@j721e-evm:/opt/vision_apps/test_decode# export GST_DEBUG=3
    root@j721e-evm:/opt/vision_apps/test_decode# ./test_decode.sh
    APP: Init ... !!!
    MEM: Init ... !!!
    MEM: Initialized DMA HEAP (fd=5) !!!
    MEM: Init ... Done !!!
    IPC: Init ... !!!
    IPC: Init ... Done !!!
    REMOTE_SERVICE: Init ... !!!
    REMOTE_SERVICE: Init ... Done !!!
       292.560001 s: GTC Frequency = 200 MHz
    APP: Init ... Done !!!
       292.560262 s:  VX_ZONE_INIT:Enabled
       292.560332 s:  VX_ZONE_ERROR:Enabled
       292.560389 s:  VX_ZONE_WARNING:Enabled
       292.560955 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-0
       292.561219 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-1
       292.561374 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-2
       292.561500 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-3
       292.561565 s:  VX_ZONE_INIT:[tivxInitLocal:136] Initialization Done !!!
       292.562042 s:  VX_ZONE_INIT:[tivxHostInitLocal:101] Initialization Done for HOST !!!
    in_width = 1920 , in_height = 1088
    app_update_param_set done!
    Creating context done!
    Kernel loading done!
    Img Mosaic init done!
    App Init Done!
    display_graph create done!
    Img Mosaic graph done!
    gst_wrapper: GstCmdString:
    filesrc location=/opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    ! h264parse
    ! v4l2h264dec capture-io-mode=dmabuf-import
    ! video/x-raw, format=(string)NV12
    ! tiovxmemalloc pool-size=2
    ! appsink name=myAppSink0 drop=true wait-on-eos=false max-buffers=4
    
    Codec Pipeline done!
    App Create Graph Done!
    Display Graph verify done!
    appCodecSinkInit Done!
    App Verify Graph Done!
    app_pipeline_params_defaults returned
    0:00:00.162610065  2470     0x1459e130 WARN                 basesrc gstbasesrc.c:3688:gst_base_src_start_complete:<filesrc0> pad not activated yet
    appCodecStart Done!
    0:00:00.169575597  2470     0x1459b300 WARN                    v4l2 gstv4l2object.c:4701:gst_v4l2_object_probe_caps:<v4l2h264dec0:src> Failed to probe pixel aspect ratio with VIDIOC_CROPCAP: Invalid argument
    0:00:00.172514612  2470     0x1459b300 WARN                    v4l2 gstv4l2object.c:2359:gst_v4l2_object_get_streamparm:<v4l2h264dec0:src> VIDIOC_G_PARM failed
    0:00:00.188023455  2470     0x1459b300 ERROR         v4l2bufferpool gstv4l2bufferpool.c:981:gst_v4l2_buffer_pool_start:<v4l2h264dec0:pool0:src> cannot import buffers from downstream pool
    0:00:00.188085210  2470     0x1459b300 ERROR             bufferpool gstbufferpool.c:572:gst_buffer_pool_set_active:<v4l2h264dec0:pool0:src> start failed
    0:00:00.188151906  2470     0x1459b300 ERROR         v4l2bufferpool gstv4l2bufferpool.c:981:gst_v4l2_buffer_pool_start:<v4l2h264dec0:pool0:src> cannot import buffers from downstream pool
    0:00:00.188199866  2470     0x1459b300 ERROR             bufferpool gstbufferpool.c:572:gst_buffer_pool_set_active:<v4l2h264dec0:pool0:src> start failed
    0:00:00.188240251  2470     0x1459b300 WARN            v4l2videodec gstv4l2videodec.c:904:gst_v4l2_video_dec_handle_frame:<v4l2h264dec0> error: Failed to allocate required memory.
    0:00:00.188267746  2470     0x1459b300 WARN            v4l2videodec gstv4l2videodec.c:904:gst_v4l2_video_dec_handle_frame:<v4l2h264dec0> error: Buffer pool activation failed
    0:00:00.188438491  2470     0x1459b300 WARN               baseparse gstbaseparse.c:3684:gst_base_parse_loop:<h264parse0> error: Internal data stream error.
    0:00:00.188463362  2470     0x1459b300 WARN               baseparse gstbaseparse.c:3684:gst_base_parse_loop:<h264parse0> error: streaming stopped, reason error (-5)
    0:00:00.188578552  2470     0x1459b300 WARN            videodecoder gstvideodecoder.c:1419:gst_video_decoder_sink_event_default:<v4l2h264dec0> error: No valid frames decoded before end of stream
    0:00:00.188601137  2470     0x1459b300 WARN            videodecoder gstvideodecoder.c:1419:gst_video_decoder_sink_event_default:<v4l2h264dec0> error: no valid frames found
    ^C
    Clean up and exit while handling signal 2
    Application did not close some rpmsg_char devices
    

    Regards,

    Xin

  • Xin, 

    I have tested decoder functionality some days ago with the multi-cam-codec demo and got successful YUV output files. I will test again. To be clear, are there any modifications you've made to the demo code?

    Best,
    Sarabesh S.

  • Hi sarabesh,

    No changes were made, using the same API codec.

    Regards,

    Xin

  • Hi Sarabesh,

    Below is the full log of running app_multi_cam_codec dmeo, I just turned on the decoder function and export GST_DEBUG=4. The error encountered is at the bottom of the log.

    root@j721e-evm:/opt/vision_apps# export GST_DEBUG=4
    root@j721e-evm:/opt/vision_apps# ./run_app_multi_cam_codec.sh
    APP: Init ... !!!
    MEM: Init ... !!!
    MEM: Initialized DMA HEAP (fd=5) !!!
    MEM: Init ... Done !!!
    IPC: Init ... !!!
    IPC: Init ... Done !!!
    REMOTE_SERVICE: Init ... !!!
    REMOTE_SERVICE: Init ... Done !!!
       954.075141 s: GTC Frequency = 200 MHz
    APP: Init ... Done !!!
       954.078671 s:  VX_ZONE_INIT:Enabled
       954.078684 s:  VX_ZONE_ERROR:Enabled
       954.078693 s:  VX_ZONE_WARNING:Enabled
       954.083444 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-0
       954.083552 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-1
       954.083653 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-2
       954.083741 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:116] Added target MPU-3
       954.083755 s:  VX_ZONE_INIT:[tivxInitLocal:136] Initialization Done !!!
       954.088269 s:  VX_ZONE_INIT:[tivxHostInitLocal:101] Initialization Done for HOST !!!
       954.092546 s: ISS: Enumerating sensors ... !!!
       954.493215 s: ISS: Enumerating sensors ... found 0 : IMX390-UB953_D3
       954.493244 s: ISS: Enumerating sensors ... found 1 : IMX390-UB953-DISCOVERY-NARROW
       954.493264 s: ISS: Enumerating sensors ... found 2 : IMX390-UB953-DISCOVERY-MID
       954.493282 s: ISS: Enumerating sensors ... found 3 : IMX390-UB953-DISCOVERY-WIDE
       954.493298 s: ISS: Enumerating sensors ... found 4 : AR0233-UB953_MARS
       954.493313 s: ISS: Enumerating sensors ... found 5 : AR0820-UB953_LI
       954.493327 s: ISS: Enumerating sensors ... found 6 : UB9xxx_RAW12_TESTPATTERN
       954.493343 s: ISS: Enumerating sensors ... found 7 : UB96x_UYVY_TESTPATTERN
       954.493356 s: ISS: Enumerating sensors ... found 8 : GW_AR0233_UYVY
    Sensor selected : IMX390-UB953_D3
    Querying IMX390-UB953_D3
       954.493402 s: ISS: Querying sensor [IMX390-UB953_D3] ... !!!
       954.493535 s: ISS: Querying sensor [IMX390-UB953_D3] ... Done !!!
    Capture->Encode Selection Yes(1)/No(0)
    [MCU2_0]    954.492780 s: Error writing 0x2 to UB960 register 0x1
    [MCU2_0]    954.492854 s:  UB960 Error: Reg Write Failed for regAddr 1, cnt = 0
    [MCU2_0]    954.492909 s: Error : ub960_cfgScript returned -1 while configuring DES 0
    [MCU2_0]    954.492999 s: Error writing 0x2 to UB960 register 0x1
    [MCU2_0]    954.493044 s:  UB960 Error: Reg Write Failed for regAddr 1, cnt = 0
    [MCU2_0]    954.493087 s: Error :  returned -1 while configuring DES 1
    0
    Decode->Display Selection Yes(1)/No(0)
    1
    Max number of cameras supported by sensor IMX390-UB953_D3 = 12
    Please enter number of channels to be enabled
    1
    gst_wrapper: GstCmdString:
    filesrc location=/opt/vision_apps/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    ! h264parse
    ! v4l2h264dec capture-io-mode=dmabuf-import
    ! video/x-raw, format=(string)NV12
    ! tiovxmemalloc pool-size=15
    ! appsink name=myAppSink0 drop=true wait-on-eos=false max-buffers=4
    
    0:00:00.011519729  1879      0x246de00 INFO                GST_INIT gst.c:591:init_pre: Initializing GStreamer Core Library version 1.20.7
    0:00:00.011598728  1879      0x246de00 INFO                GST_INIT gst.c:592:init_pre: Using library installed in /usr/lib
    0:00:00.011636565  1879      0x246de00 INFO                GST_INIT gst.c:610:init_pre: Linux j721e-evm 6.1.80-ti-g2e423244f8c0 #1 SMP PREEMPT Wed Mar 20 14:43:33 UTC 2024 aarch64
    0:00:00.012387126  1879      0x246de00 INFO                GST_INIT gstmessage.c:129:_priv_gst_message_initialize: init messages
    0:00:00.018991612  1879      0x246de00 INFO                GST_INIT gstcontext.c:86:_priv_gst_context_initialize: init contexts
    0:00:00.019350976  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:324:_priv_gst_plugin_initialize: registering 0 static plugins
    0:00:00.019566143  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:232:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.019591994  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:234:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.019708271  1879      0x246de00 INFO            GST_REGISTRY gstregistry.c:1826:ensure_current_registry: reading registry cache: /home/root/.cache/gstreamer-1.0/registry.aarch64.bin
    0:00:00.056877981  1879      0x246de00 INFO            GST_REGISTRY gstregistrybinary.c:683:priv_gst_registry_binary_read_cache: loaded /home/root/.cache/gstreamer-1.0/registry.aarch64.bin in 0.037107 seconds
    0:00:00.057096912  1879      0x246de00 INFO            GST_REGISTRY gstregistry.c:1693:scan_and_update_registry: Validating plugins from registry cache: /home/root/.cache/gstreamer-1.0/registry.aarch64.bin
    0:00:00.069082332  1879      0x246de00 INFO            GST_REGISTRY gstregistry.c:1375:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-1.0/libgstvideo4linux2.so is stale
    0:00:00.000139007  1954     0x32737200 INFO                GST_INIT gst.c:591:init_pre: Initializing GStreamer Core Library version 1.20.7
    0:00:00.000215346  1954     0x32737200 INFO                GST_INIT gst.c:592:init_pre: Using library installed in /usr/lib
    0:00:00.000264744  1954     0x32737200 INFO                GST_INIT gst.c:610:init_pre: Linux j721e-evm 6.1.80-ti-g2e423244f8c0 #1 SMP PREEMPT Wed Mar 20 14:43:33 UTC 2024 aarch64
    0:00:00.000699673  1954     0x32737200 INFO                GST_INIT gstmessage.c:129:_priv_gst_message_initialize: init messages
    0:00:00.001507512  1954     0x32737200 INFO                GST_INIT gstcontext.c:86:_priv_gst_context_initialize: init contexts
    0:00:00.001824044  1954     0x32737200 INFO      GST_PLUGIN_LOADING gstplugin.c:324:_priv_gst_plugin_initialize: registering 0 static plugins
    0:00:00.001998859  1954     0x32737200 INFO      GST_PLUGIN_LOADING gstplugin.c:232:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.002021255  1954     0x32737200 INFO      GST_PLUGIN_LOADING gstplugin.c:234:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.002106810  1954     0x32737200 INFO            GST_REGISTRY gstregistry.c:1861:ensure_current_registry: registry reading and updating done
    0:00:00.002126186  1954     0x32737200 INFO                GST_INIT gst.c:826:init_post: GLib runtime version: 2.72.3
    0:00:00.002142082  1954     0x32737200 INFO                GST_INIT gst.c:828:init_post: GLib headers version: 2.72.3
    0:00:00.002154607  1954     0x32737200 INFO                GST_INIT gst.c:830:init_post: initialized GStreamer successfully
    0:00:00.065430493  1954     0x32737200 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideo4linux2.so" loaded
    0:00:00.150348460  1879      0x246de00 INFO            GST_REGISTRY gstregistry.c:1794:scan_and_update_registry: Registry cache changed. Writing new registry cache
    0:00:00.150403308  1879      0x246de00 INFO            GST_REGISTRY gstregistrybinary.c:431:priv_gst_registry_binary_write_cache: Building binary registry cache image
    0:00:00.167388970  1879      0x246de00 INFO            GST_REGISTRY gstregistrybinary.c:463:priv_gst_registry_binary_write_cache: Writing binary registry cache
    0:00:00.218940495  1879      0x246de00 INFO            GST_REGISTRY gstregistrybinary.c:314:gst_registry_binary_cache_finish: Wrote binary registry cache
    0:00:00.219093624  1879      0x246de00 INFO            GST_REGISTRY gstregistry.c:1803:scan_and_update_registry: Registry cache written successfully
    0:00:00.219130541  1879      0x246de00 INFO            GST_REGISTRY gstregistry.c:1861:ensure_current_registry: registry reading and updating done
    0:00:00.219153417  1879      0x246de00 INFO                GST_INIT gst.c:826:init_post: GLib runtime version: 2.72.3
    0:00:00.219173238  1879      0x246de00 INFO                GST_INIT gst.c:828:init_post: GLib headers version: 2.72.3
    0:00:00.219186369  1879      0x246de00 INFO                GST_INIT gst.c:830:init_post: initialized GStreamer successfully
    0:00:00.219289299  1879      0x246de00 INFO            GST_PIPELINE gstparse.c:344:gst_parse_launch_full: parsing pipeline description 'filesrc location=/opt/vision_apps/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    ! h264parse
    ! v4l2h264dec capture-io-mode=dmabuf-import
    ! video/x-raw, format=(string)NV12
    ! tiovxmemalloc pool-size=15
    ! appsink name=myAppSink0 drop=true wait-on-eos=false max-buffers=4
    '
    0:00:00.232418066  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstcoreelements.so" loaded
    0:00:00.232475384  1879      0x246de00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesrc"
    0:00:00.232771885  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseSrc@0x28be2e0> adding pad 'src'
    0:00:00.232852225  1879      0x246de00 INFO                 filesrc gstfilesrc.c:237:gst_file_src_set_location: filename : /opt/vision_apps/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.232869871  1879      0x246de00 INFO                 filesrc gstfilesrc.c:238:gst_file_src_set_location: uri      : file:///opt/vision_apps/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.277862228  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideoparsersbad.so" loaded
    0:00:00.277906420  1879      0x246de00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "h264parse"
    0:00:00.278137948  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseParse@0x28c2270> adding pad 'sink'
    0:00:00.278178775  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseParse@0x28c2270> adding pad 'src'
    0:00:00.278311392  1879      0x246de00 INFO               baseparse gstbaseparse.c:4049:gst_base_parse_set_pts_interpolation:<GstH264Parse@0x28c2270> PTS interpolation: no
    0:00:00.278330163  1879      0x246de00 INFO               baseparse gstbaseparse.c:4067:gst_base_parse_set_infer_ts:<GstH264Parse@0x28c2270> TS inferring: no
    0:00:00.284691476  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideo4linux2.so" loaded
    0:00:00.284738178  1879      0x246de00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "v4l2h264dec"
    0:00:00.285013793  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstVideoDecoder@0x2858810> adding pad 'sink'
    0:00:00.285057006  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstVideoDecoder@0x2858810> adding pad 'src'
    0:00:00.314103977  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgsttiovx.so" loaded
    0:00:00.314148819  1879      0x246de00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "tiovxmemalloc"
    0:00:00.314338209  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x28d0360> adding pad 'sink'
    0:00:00.314389417  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x28d0360> adding pad 'src'
    0:00:00.315725475  1879      0x246de00 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstapp.so" loaded
    0:00:00.315763647  1879      0x246de00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "appsink"
    0:00:00.316059658  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseSink@0x28cac70> adding pad 'sink'
    0:00:00.316164809  1879      0x246de00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "pipeline"
    0:00:00.316376221  1879      0x246de00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of GstFileSrc named filesrc0 to some pad of GstH264Parse named h264parse0 (0/0) with caps "(NULL)"
    0:00:00.316403877  1879      0x246de00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element filesrc0:(any) to element h264parse0:(any)
    0:00:00.316430329  1879      0x246de00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link filesrc0:src and h264parse0:sink
    0:00:00.316478941  1879      0x246de00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<h264parse0:src> pad has no peer
    0:00:00.316513048  1879      0x246de00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: filesrc0 and h264parse0 in same bin, no need for ghost pads
    0:00:00.316547135  1879      0x246de00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link filesrc0:src and h264parse0:sink
    0:00:00.316572121  1879      0x246de00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<h264parse0:src> pad has no peer
    0:00:00.316599853  1879      0x246de00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked filesrc0:src and h264parse0:sink, successful
    0:00:00.316615269  1879      0x246de00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.316631335  1879      0x246de00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<filesrc0:src> Received event on flushing pad. Discarding
    0:00:00.316664761  1879      0x246de00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of GstH264Parse named h264parse0 to some pad of v4l2h264dec named v4l2h264dec0 (0/0) with caps "(NULL)"
    0:00:00.316685433  1879      0x246de00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element h264parse0:(any) to element v4l2h264dec0:(any)
    0:00:00.316706499  1879      0x246de00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link h264parse0:src and v4l2h264dec0:sink
    0:00:00.316769322  1879      0x246de00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<v4l2h264dec0:src> pad has no peer
    0:00:00.316834501  1879      0x246de00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: h264parse0 and v4l2h264dec0 in same bin, no need for ghost pads
    0:00:00.316863762  1879      0x246de00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link h264parse0:src and v4l2h264dec0:sink
    0:00:00.316887779  1879      0x246de00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<v4l2h264dec0:src> pad has no peer
    0:00:00.316927066  1879      0x246de00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked h264parse0:src and v4l2h264dec0:sink, successful
    0:00:00.316943317  1879      0x246de00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.316958918  1879      0x246de00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<h264parse0:src> Received event on flushing pad. Discarding
    0:00:00.316999255  1879      0x246de00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of v4l2h264dec named v4l2h264dec0 to some pad of GstTIOVXMemAlloc named tiovxmemalloc0 (0/0) with caps "video/x-raw, format=(string)NV12"
    0:00:00.317022731  1879      0x246de00 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "capsfilter"
    0:00:00.317166164  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x28d8160> adding pad 'sink'
    0:00:00.317203541  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:760:gst_element_add_pad:<GstBaseTransform@0x28d8160> adding pad 'src'
    0:00:00.317234343  1879      0x246de00 INFO              GST_STATES gstbin.c:2070:gst_bin_get_state_func:<pipeline0> getting state
    0:00:00.317288251  1879      0x246de00 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<capsfilter0> completed state change to NULL
    0:00:00.317318137  1879      0x246de00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.317347209  1879      0x246de00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element v4l2h264dec0:(any) to element capsfilter0:sink
    0:00:00.317366180  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:1018:gst_element_get_static_pad: found pad capsfilter0:sink
    0:00:00.317383596  1879      0x246de00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: v4l2h264dec0 and capsfilter0 in same bin, no need for ghost pads
    0:00:00.317410217  1879      0x246de00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link v4l2h264dec0:src and capsfilter0:sink
    0:00:00.317443459  1879      0x246de00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<capsfilter0:src> pad has no peer
    0:00:00.317478231  1879      0x246de00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked v4l2h264dec0:src and capsfilter0:sink, successful
    0:00:00.317493507  1879      0x246de00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.317508588  1879      0x246de00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<v4l2h264dec0:src> Received event on flushing pad. Discarding
    0:00:00.317533034  1879      0x246de00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element capsfilter0:src to element tiovxmemalloc0:(any)
    0:00:00.317549855  1879      0x246de00 INFO        GST_ELEMENT_PADS gstelement.c:1018:gst_element_get_static_pad: found pad capsfilter0:src
    0:00:00.317569981  1879      0x246de00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link capsfilter0:src and tiovxmemalloc0:sink
    0:00:00.317605363  1879      0x246de00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<tiovxmemalloc0:src> pad has no peer
    0:00:00.317632859  1879      0x246de00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: capsfilter0 and tiovxmemalloc0 in same bin, no need for ghost pads
    0:00:00.317656496  1879      0x246de00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link capsfilter0:src and tiovxmemalloc0:sink
    0:00:00.317688732  1879      0x246de00 INFO                GST_PADS gstpad.c:4357:gst_pad_peer_query:<tiovxmemalloc0:src> pad has no peer
    0:00:00.317713334  1879      0x246de00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked capsfilter0:src and tiovxmemalloc0:sink, successful
    0:00:00.317727680  1879      0x246de00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.317742785  1879      0x246de00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<capsfilter0:src> Received event on flushing pad. Discarding
    0:00:00.317774922  1879      0x246de00 INFO            GST_PIPELINE gst/parse/grammar.y:683:gst_parse_perform_link: linking some pad of GstTIOVXMemAlloc named tiovxmemalloc0 to some pad of GstAppSink named myAppSink0 (0/0) with caps "(NULL)"
    0:00:00.317793643  1879      0x246de00 INFO        GST_ELEMENT_PADS gstutils.c:1816:gst_element_link_pads_full: trying to link element tiovxmemalloc0:(any) to element myAppSink0:(any)
    0:00:00.317814299  1879      0x246de00 INFO                GST_PADS gstutils.c:1079:gst_pad_check_link: trying to link tiovxmemalloc0:src and myAppSink0:sink
    0:00:00.317861332  1879      0x246de00 INFO                GST_PADS gstutils.c:1632:prepare_link_maybe_ghosting: tiovxmemalloc0 and myAppSink0 in same bin, no need for ghost pads
    0:00:00.317885888  1879      0x246de00 INFO                GST_PADS gstpad.c:2382:gst_pad_link_prepare: trying to link tiovxmemalloc0:src and myAppSink0:sink
    0:00:00.317927960  1879      0x246de00 INFO                GST_PADS gstpad.c:2590:gst_pad_link_full: linked tiovxmemalloc0:src and myAppSink0:sink, successful
    0:00:00.317942686  1879      0x246de00 INFO               GST_EVENT gstevent.c:1660:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.317957282  1879      0x246de00 INFO               GST_EVENT gstpad.c:5946:gst_pad_send_event_unchecked:<tiovxmemalloc0:src> Received event on flushing pad. Discarding
    0:00:00.338719806  1879      0x246de00 INFO           GST_PARENTAGE gstbin.c:4378:gst_bin_get_by_name: [pipeline0]: looking up child element myAppSink0
    0:00:00.439419827  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<myAppSink0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.439489091  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<myAppSink0> completed state change to READY
    0:00:00.439511037  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<myAppSink0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.439569710  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'myAppSink0' changed state to 2(READY) successfully
    0:00:00.439596921  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxmemalloc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.439616017  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<tiovxmemalloc0> completed state change to READY
    0:00:00.439632898  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<tiovxmemalloc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.439657189  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'tiovxmemalloc0' changed state to 2(READY) successfully
    0:00:00.439679761  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.439697737  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<capsfilter0> completed state change to READY
    0:00:00.439714453  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.439738139  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 2(READY) successfully
    0:00:00.439760390  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<v4l2h264dec0> current NULL pending VOID_PENDING, desired next READY
    
    
     =========================
     Demo : Camera Demo
     =========================
    
     s: Save CSIx, VISS and LDC outputs
    
     p: Print performance statistics
    
     x: Exit
    
    0:00:00.440193963  1879      0x287ff30 INFO                    v4l2 v4l2_calls.c:588:gst_v4l2_open:<v4l2h264dec0:sink> Opened device 'vxd-dec' (/dev/video0) successfully
    0:00:00.440295629  1879      0x287ff30 INFO                    v4l2 v4l2_calls.c:684:gst_v4l2_dup:<v4l2h264dec0:src> Cloned device 'vxd-dec' (/dev/video0) successfully
    0:00:00.440343756  1879      0x287ff30 INFO                    v4l2 gstv4l2object.c:1256:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink> got 3 format(s):
    0:00:00.440372983  1879      0x287ff30 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink>   MJPG
    0:00:00.440398709  1879      0x287ff30 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink>   HEVC
    0:00:00.440424420  1879      0x287ff30 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:sink>   H264
     Enter Choice: 0:00:00.442695842  1879      0x287ff30 INFO                    v4l2 gstv4l2object.c:4764:gst_v4l2_object_probe_caps:<v4l2h264dec0:sink> probed caps: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }, parsed=(boolean)true
    0:00:00.442733034  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<v4l2h264dec0> completed state change to READY
    0:00:00.442754000  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<v4l2h264dec0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.442792602  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'v4l2h264dec0' changed state to 2(READY) successfully
    0:00:00.442827774  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<h264parse0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.442849815  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<h264parse0> completed state change to READY
    0:00:00.442867756  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.442891512  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully
    0:00:00.442912928  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.442932110  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<filesrc0> completed state change to READY
    0:00:00.442949620  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.442982062  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 2(READY) successfully
    0:00:00.443014954  1879      0x287ff30 INFO              GST_STATES gstelement.c:2780:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PLAYING, next PAUSED
    0:00:00.443034110  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed NULL to READY (PLAYING pending)
    0:00:00.443056491  1879      0x287ff30 INFO              GST_STATES gstelement.c:2788:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PLAYING
    0:00:00.443104264  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<myAppSink0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.443153991  1879      0x287ff30 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'myAppSink0' is changing state asynchronously to PAUSED
    0:00:00.443179243  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxmemalloc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.443211159  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<tiovxmemalloc0> completed state change to PAUSED
    0:00:00.443229550  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<tiovxmemalloc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.443253477  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'tiovxmemalloc0' changed state to 3(PAUSED) successfully
    0:00:00.443276038  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.443303619  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
    0:00:00.443321005  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.443343511  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 3(PAUSED) successfully
    0:00:00.443364618  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<v4l2h264dec0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.443399935  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<v4l2h264dec0> completed state change to PAUSED
    0:00:00.443418365  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<v4l2h264dec0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.443440787  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'v4l2h264dec0' changed state to 3(PAUSED) successfully
    0:00:00.443462723  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<h264parse0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.443687930  1879      0x287ff30 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file /opt/vision_apps/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.443788995  1879      0x287ff30 WARN                 basesrc gstbasesrc.c:3688:gst_base_src_start_complete:<filesrc0> pad not activated yet
    0:00:00.443845883  1879      0x287ff30 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file /opt/vision_apps/test_data/psdkra/app_multi_cam_codec/test_video_1080p30.264
    0:00:00.444143574  1879      0x287ff30 INFO               GST_EVENT gstevent.c:972:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
    0:00:00.444247895  1879      0x287ff30 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0x28c0450 on task 0x28c45f0
    0:00:00.444269126  1879      0x287ff30 INFO                GST_PADS gstpad.c:6292:gst_pad_start_task:<h264parse0:sink> created task 0x28c45f0
    0:00:00.444491928  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<h264parse0> completed state change to PAUSED
    0:00:00.444527710  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.444563287  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 3(PAUSED) successfully
    0:00:00.444589003  1879      0x287ff30 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.444619440  1879      0x287ff30 INFO              GST_STATES gstelement.c:2808:gst_element_continue_state:<filesrc0> completed state change to PAUSED
    0:00:00.444637886  1879      0x287ff30 INFO              GST_STATES gstelement.c:2708:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.444661487  1879      0x287ff30 INFO              GST_STATES gstbin.c:2929:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 3(PAUSED) successfully
    0:00:00.444687313  1879      0x287ff30 INFO                pipeline gstpipeline.c:533:gst_pipeline_change_state:<pipeline0> pipeline is not live
    0:00:00.444923946  1879      0x28c7f60 INFO        GST_ELEMENT_PADS gstelement.c:1018:gst_element_get_static_pad: found pad h264parse0:sink
    0:00:00.445674311  1879      0x28c7f60 INFO               h264parse gsth264parse.c:2093:gst_h264_parse_update_src_caps:<h264parse0> resolution changed 1920x1080
    0:00:00.445911084  1879      0x28c7f60 INFO               baseparse gstbaseparse.c:4093:gst_base_parse_set_latency:<h264parse0> min/max latency 0:00:00.033333333, 0:00:00.033333333
    0:00:00.446197249  1879      0x28c7f60 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-h264, width=(int)1920, height=(int)1080, framerate=(fraction)30/1, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, stream-format=(string)byte-stream, alignment=(string)au, profile=(string)high, level=(string)4
    0:00:00.451299542  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:3268:gst_v4l2_object_setup_pool:<v4l2h264dec0:sink> accessing buffers via mode 2
    0:00:00.451869382  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:593:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> increasing minimum buffers to 2
    0:00:00.451897484  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:606:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> reducing maximum buffers to 32
    0:00:00.452043221  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> can't allocate, setting maximum to minimum
    0:00:00.452233762  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:1256:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src> got 6 format(s):
    0:00:00.452307140  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   NV12
    0:00:00.452376039  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   YM12
    0:00:00.452444913  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   NV16
    0:00:00.452505276  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   YM16
    0:00:00.452563234  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   TI16
    0:00:00.452620347  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:1260:gst_v4l2_object_fill_format_list:<v4l2h264dec0:src>   TI12
    0:00:00.452758170  1879      0x28c7f60 WARN                    v4l2 gstv4l2object.c:4701:gst_v4l2_object_probe_caps:<v4l2h264dec0:src> Failed to probe pixel aspect ratio with VIDIOC_CROPCAP: Invalid argument
    0:00:00.453431666  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:4764:gst_v4l2_object_probe_caps:<v4l2h264dec0:src> probed caps: video/x-raw, format=(string)NV12, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string){ progressive, interleaved }, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw, format=(string)I420, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string){ progressive, interleaved }, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw, format=(string)NV16, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string){ progressive, interleaved }, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw(format:Interlaced), format=(string)NV12, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string)alternate, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw(format:Interlaced), format=(string)I420, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string)alternate, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }; video/x-raw(format:Interlaced), format=(string)NV16, width=(int)[ 64, 32768 ], height=(int)[ 64, 32768 ], framerate=(fraction)[ 0/1, 2147483647/1 ], interlace-mode=(string)alternate, colorimetry=(string){ bt601, smpte240m, bt709, 1:3:5:1, 2:4:5:2, 2:4:5:3, 1:4:7:1, 2:4:7:1, 2:4:12:8, bt2020, 2:0:0:0 }
    0:00:00.453948168  1879      0x28c7f60 INFO               videometa gstvideometa.c:1072:gst_video_time_code_meta_api_get_type: registering
    0:00:00.454169430  1879      0x28c7f60 INFO            videodecoder gstvideodecoder.c:1637:gst_video_decoder_sink_event_default:<v4l2h264dec0> upstream tags: taglist, video-codec=(string)"H.264\ \(High\ Profile\)";
    0:00:00.454376896  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:sink> can't allocate, setting maximum to minimum
    0:00:00.456581364  1879      0x28c7f60 WARN                    v4l2 gstv4l2object.c:2359:gst_v4l2_object_get_streamparm:<v4l2h264dec0:src> VIDIOC_G_PARM failed
    0:00:00.460988894  1879      0x28c7f60 INFO                    v4l2 gstv4l2object.c:3268:gst_v4l2_object_setup_pool:<v4l2h264dec0:src> accessing buffers via mode 5
    0:00:00.461255639  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:593:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> increasing minimum buffers to 2
    0:00:00.461275685  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:606:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> reducing maximum buffers to 32
    0:00:00.461411267  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> can't allocate, setting maximum to minimum
    0:00:00.461427698  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:622:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> adding needed video meta
    0:00:00.461688652  1879      0x28c7f60 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.461952556  1879      0x28c7f60 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<capsfilter0> reuse caps
    0:00:00.462152802  1879      0x28c7f60 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.462241176  1879      0x28c7f60 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<tiovxmemalloc0> reuse caps
    0:00:00.462292499  1879      0x28c7f60 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.462353547  1879      0x28c7f60 INFO               GST_EVENT gstevent.c:892:gst_event_new_caps: creating caps event video/x-raw, format=(string)NV12, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, multiview-mode=(string)mono, multiview-flags=(GstVideoMultiviewFlagsSet)0:ffffffff:/right-view-first/left-flipped/left-flopped/right-flipped/right-flopped/half-aspect/mixed-mono, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601, framerate=(fraction)30/1
    0:00:00.462500385  1879      0x28c7f60 INFO            tiovxcontext gsttiovxcontext.c:141:gst_tiovx_context_init: Calling appInit() from GST!
    0:00:00.462591420  1879      0x28c7f60 INFO           tiovxmemalloc gsttiovxutils.c:629:gst_tiovx_get_exemplar_from_caps:<tiovxmemalloc0> creating image with width: 1920        height: 1080    format: 0x3231564e
    0:00:00.462683710  1879      0x28c7f60 INFO           tiovxmemalloc gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.462701111  1879      0x28c7f60 INFO           tiovxmemalloc gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.462889611  1879      0x28c7f60 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffffa002c130> New TIOVX buffer pool
    0:00:00.463043804  1879      0x28c7f60 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffffa002d010> New TIOVX allocator
    0:00:00.463086217  1879      0x28c7f60 INFO           tiovxmemalloc gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 15 buffers of 3110400 size
    0:00:00.463187347  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:606:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> reducing maximum buffers to 32
    0:00:00.463206103  1879      0x28c7f60 INFO          v4l2bufferpool gstv4l2bufferpool.c:617:gst_v4l2_buffer_pool_set_config:<v4l2h264dec0:pool0:src> can't allocate, setting maximum to minimum
    0:00:00.463410414  1879      0x28c7f60 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffffa002d0f0> New TIOVX allocator
    0:00:00.506841505  1879      0x28c7f60 ERROR         v4l2bufferpool gstv4l2bufferpool.c:981:gst_v4l2_buffer_pool_start:<v4l2h264dec0:pool0:src> cannot import buffers from downstream pool
    0:00:00.506901458  1879      0x28c7f60 ERROR             bufferpool gstbufferpool.c:572:gst_buffer_pool_set_active:<v4l2h264dec0:pool0:src> start failed
    0:00:00.506947235  1879      0x28c7f60 ERROR         v4l2bufferpool gstv4l2bufferpool.c:981:gst_v4l2_buffer_pool_start:<v4l2h264dec0:pool0:src> cannot import buffers from downstream pool
    0:00:00.506965091  1879      0x28c7f60 ERROR             bufferpool gstbufferpool.c:572:gst_buffer_pool_set_active:<v4l2h264dec0:pool0:src> start failed
    0:00:00.506997783  1879      0x28c7f60 WARN            v4l2videodec gstv4l2videodec.c:904:gst_v4l2_video_dec_handle_frame:<v4l2h264dec0> error: Failed to allocate required memory.
    0:00:00.507017454  1879      0x28c7f60 WARN            v4l2videodec gstv4l2videodec.c:904:gst_v4l2_video_dec_handle_frame:<v4l2h264dec0> error: Buffer pool activation failed
    0:00:00.507057976  1879      0x28c7f60 INFO        GST_ERROR_SYSTEM gstelement.c:2273:gst_element_message_full_with_details:<v4l2h264dec0> posting message: Failed to allocate required memory.
    0:00:00.507135415  1879      0x28c7f60 INFO        GST_ERROR_SYSTEM gstelement.c:2300:gst_element_message_full_with_details:<v4l2h264dec0> posted error message: Failed to allocate required memory.
    0:00:00.507170332  1879      0x28c7f60 INFO            videodecoder gstvideodecoder.c:3150:gst_video_decoder_prepare_finish_frame:<v4l2h264dec0> Guessing PTS=0:00:00.000000000 for frame... DTS=0:00:00.000000000
    0:00:00.507295524  1879      0x28c7f60 WARN               baseparse gstbaseparse.c:3684:gst_base_parse_loop:<h264parse0> error: Internal data stream error.
    0:00:00.507321560  1879      0x28c7f60 WARN               baseparse gstbaseparse.c:3684:gst_base_parse_loop:<h264parse0> error: streaming stopped, reason error (-5)
    0:00:00.507363008  1879      0x28c7f60 INFO        GST_ERROR_SYSTEM gstelement.c:2273:gst_element_message_full_with_details:<h264parse0> posting message: Internal data stream error.
    0:00:00.507395654  1879      0x28c7f60 INFO        GST_ERROR_SYSTEM gstelement.c:2300:gst_element_message_full_with_details:<h264parse0> posted error message: Internal data stream error.
    0:00:00.507482059  1879      0x28c7f60 WARN            videodecoder gstvideodecoder.c:1419:gst_video_decoder_sink_event_default:<v4l2h264dec0> error: No valid frames decoded before end of stream
    0:00:00.507501490  1879      0x28c7f60 WARN            videodecoder gstvideodecoder.c:1419:gst_video_decoder_sink_event_default:<v4l2h264dec0> error: no valid frames found
    0:00:00.507526776  1879      0x28c7f60 INFO        GST_ERROR_SYSTEM gstelement.c:2273:gst_element_message_full_with_details:<v4l2h264dec0> posting message: No valid frames decoded before end of stream
    0:00:00.507552698  1879      0x28c7f60 INFO        GST_ERROR_SYSTEM gstelement.c:2300:gst_element_message_full_with_details:<v4l2h264dec0> posted error message: No valid frames decoded before end of stream
    
    

    Regards,

    Xin

  • Hi Xin, 

    I have tested decoder functionality some days ago with the multi-cam-codec demo and got successful YUV output files. I will test again. To be clear, are there any modifications you've made to the demo code?

    Apologies per my last response, I had tested on the wrong hardware. Could you test if decoding works on the command line with the following command:

    • gst-launch-1.0 filesrc location=<h264_input_path> ! queue ! h264parse ! v4l2h264dec ! videoconvert ! video/x-raw,format=NV12 ! fakesink

    I am trying to see if this is isolated to just the multi-cam-codec demo or GStreamer in general. And to be clear you are seeing this problem on 9.2 SDK with decoding? Is encoding on 9.2 successful?

    BR,
    Sarabesh S.

  • Hi Sarabesh,

    Yes, I see this problem on 9.2 SDK with decoding. Encoding on 9.2 is successful.

    I test the following two command,They're all okay,

    gst-launch-1.0 filesrc location=/opt/vision_apps/test_data/psdkra/app_multi_cam_codec/TI_Custom_1920x1080_5secs.264 ! h264parse ! v4l2h264dec ! video/x-raw,format=NV12 ! fakesink

    gst-launch-1.0 filesrc location=/opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/TI_Custom_1920x1080_5secs.264 ! h264parse ! v4l2h264dec ! video/x-raw,format=NV12 ! filesink location=/opt/vision_apps/test_encode/output123.yuv

    The detailed log is as follows:

    root@j721e-evm:~# gst-launch-1.0 filesrc location=/opt/vision_apps/test_decode/test_data/psdkra/app_multi_cam_codec/TI_Custom_1920x1080_5secs.264 ! h264parse ! v4l2h264dec ! video/x-raw,format=NV12 ! filesink location=/opt/vision_apps/test_encode/output123.yuv
    Setting pipeline to PAUSED ...
    Pipeline is PREROLLING ...
    Redistribute latency...
    Redistribute latency...
    Pipeline is PREROLLED ...
    Setting pipeline to PLAYING ...
    New clock: GstSystemClock
    Redistribute latency...
    0:00:04.9 / 0:00:05.0 (98.9 %)
    ** (gst-launch-1.0:1533): WARNING **: 01:34:50.748: v4l2h264dec0: 1 frames 151-151 left undrained after CMD_STOP, eos sent too early: bug in decoder -- please file a bug
    Got EOS from element "pipeline0".
    Execution ended after 0:00:11.859780822
    Setting pipeline to NULL ...
    Freeing pipeline ...
    
    root@j721e-evm:~# gst-launch-1.0 filesrc location=/opt/vision_apps/test_data/psdkra/app_multi_cam_codec/TI_Custom_1920x1080_5secs.264 ! h264parse ! v4l2h264dec ! video/x-raw,format=NV12 ! fakesink          
    Setting pipeline to PAUSED ...
    Pipeline is PREROLLING ...
    Redistribute latency...
    Redistribute latency...
    Pipeline is PREROLLED ...
    Setting pipeline to PLAYING ...
    New clock: GstSystemClock
    Redistribute latency...
    0:00:04.2 / 0:00:04.9 (86.2 %)
    ** (gst-launch-1.0:2652): WARNING **: 01:37:46.255: v4l2h264dec0: 1 frames 151-151 left undrained after CMD_STOP, eos sent too early: bug in decoder -- please file a bug
    Got EOS from element "pipeline0".
    Execution ended after 0:00:00.525076485
    Setting pipeline to NULL ...
    Freeing pipeline ...
    

    Regards,
    Xin

  • Hi Xin, 

    Ok I will run some tests on 9.2 SDK to replicate the error. Thank you for your patience. I will likely respond tomorrow or early next week.

    BR,
    Sarabesh S.

  • Hi Sarabesh,

    Is the decoding problem solved? Is there any further progress?

    Regards,
    xin

  • Hello,

    Not yet, haven't gotten a chance to test this yet. Bandwidth has been limited. Will update you soon on my findings.

    Thanks,
    Sarabesh S.

  • Hi Xin, 

    Could you try with a pipeline like this: 

    • gst-launch-1.0 filesrc location=<input_stream> ! queue ! h264parse ! v4l2h264dec ! videoconvert ! video/x-raw,format=NV12 ! filesink location=<output_file>

    I was able to produce a successful decode in the 9.2 SDK

    BR,
    Sarabesh S.