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.

PROCESSOR-SDK-LINUX-SK-TDA4VM: SK-TDA4VM: edgeai-gst-plugins tiovxsde error when width 1920 pixels.

Part Number: PROCESSOR-SDK-LINUX-SK-TDA4VM
Other Parts Discussed in Thread: SK-TDA4VM

I am evaluating SDE with GStreamer using the SK-TDA4VM evaluation board and PROCESSOR-SDK-LINUX-SK-TDA4VM (10.01.00.04).

I am encountering the issue described here: https://e2e.ti.com/support/processors-group/processors/f/processors-forum/1459092/tda4vm-edgeai-gst-plugins-tiovxsde-error-when-disparity-max-0.

I have also confirmed that SDE is processed correctly by changing the image width from 1920 pixels to 1280 pixels.

I also referred to the information here.
https://software-dl.ti.com/jacinto7/esd/processor-sdk-rtos-jacinto7/10_01_00_04/exports/docs/psdk_rtos/docs/user_guide/developer_notes_dmpac.html

However, this information describes a solution for VisionApps in the RTOS.

How do I reallocate memory for the DMPAC SL2 in the Linux SDK?

  • Hi ,

    It looks like you'll have to edit the code within: tiovx_sde_module.ctiovx_sde_module.h, or hwa_dmpac_sde.h.

    The edits should be done within a Yocto build.

    Best,
    Jared

  • Hi Jared,

    Thank you for your reply.

    However, with this information alone, I can't find where SL2 memory allocation is taking place.

    Also, I understand that tiovx_sde_module.c and tiovx_sde_module.h are source files included in edgeai-tiovx-modules, but are not included in the Yocto build. Could you please correct me if I'm wrong?

    Could you tell me the specific source code changes required to implement DMPAC's SL2 memory allocation?

    Best,
    Tetsuya

  • Hi ,

    Apologies, those won't help. You will need to change the source code and rebuild the firmware.

    OOB, the EdgeAI release comes with prebuilt firmware for the rprocs. You will have to edit and rebuild that firmware. Unfortunately, this isn't supported with the EdgeAI releases.

    One thing you could try though, is to download the RTOS SDK and build the SDK using variables SOC=j721e and TISDK_IMAGE=edgeai after making the necessary changes to change the original allocation (so you won't have to reallocate). 

    Best,
    Jared

  • Hi Jared,

    I understand that you would make the necessary changes to the RTOS SDK, build it, and then replace the pre-built resources in PROCESSOR-SDK-LINUX-SK-TDA4VM. Is that correct?
    (I'm checking because the HW environment I'm using is SK-TDA4VM, which doesn't support the RTOS SDK.)
    If so,
    1. Please tell me which files to change in the RTOS SDK and which components to build. That component should point to this file: "The EdgeAI release comes with prebuilt firmware for the rprocs."
    2. After replacing the pre-built resources, I think I'll need to build the PROCESSOR-SDK-LINUX-SK-TDA4VM components, but which components (for example, edgeai-gst-plugins?) need to be built?

    I'd appreciate any help.

    Best,
    Tetsuya

  • Hi ,

    I understand that you would make the necessary changes to the RTOS SDK, build it, and then replace the pre-built resources in PROCESSOR-SDK-LINUX-SK-TDA4VM. Is that correct?

    Yes.

    1. Please tell me which files to change in the RTOS SDK and which components to build. That component should point to this file: "The EdgeAI release comes with prebuilt firmware for the rprocs."

    You would need to change the defines within the init functions in:

    • pdk/packages/ti/drv/vhwa/include/vhwa_m2mSde.h
    • pdk//packages/ti/drv/vhwa/include/vhwa_m2mDof.h

    2. After replacing the pre-built resources, I think I'll need to build the PROCESSOR-SDK-LINUX-SK-TDA4VM components, but which components (for example, edgeai-gst-plugins?) need to be built?

    The EdgeAI components probably wouldn't need to be changed.

    Best,
    Jared

  • Hi Jared,

    [sdk_builder/build_flags.mak]
    Changed SOC=j721e and TISDK_IMAGE=edgeai.

    [pdk/packages/ti/drv/vhwa/include/vhwa_m2mSde.h]
    Changed SDE_DEFAULT_IMG_WIDTH to 2048U.
    *Since dof is not used, vhwa_m2mDof.h was left unchanged.

    I built using make_sdk.sh in the sdk_builder folder.
    I confirmed that the PDK drv/vhwa were built.

    What files should I copy to the target environment after building?

    Best,
    Tetsuya

  • Hi ,

    Running "linux_fs_install_sd" within the sdk_builder directory should install all of the necessary files.

    The files that matter though, are the firmwares, the files that go into /lib/firmware (or the files that are symbolically linked to those files).

    Best,
    Jared

  • After building with the RTOS SDK, I ran "make linux_fs_install_sd" to install it on the SD card.
    I tried running the GStreamer pipeline, which was working before the installation, but it doesn't work properly.
    (It displays "Pipeline is PREROLLING..." and stops.)

    I've attached the log taken when running GStreamer with "GST_DEBUG=4".
    Please let me know what the problem is and how to resolve it.

    0:00:00.000348160  1569     0x255b89f0 INFO                GST_INIT gst.c:576:init_pre: Initializing GStreamer Core Library version 1.22.12
    0:00:00.000424725  1569     0x255b89f0 INFO                GST_INIT gst.c:577:init_pre: Using library installed in /usr/lib
    0:00:00.000446625  1569     0x255b89f0 INFO                GST_INIT gst.c:595:init_pre: Linux tda4vm-sk 6.6.44-ti-01478-g541c20281af7-dirty #1 SMP PREEMPT Thu Nov 14 19:20:24 UTC 2024 aarch64
    0:00:00.000813220  1569     0x255b89f0 INFO                GST_INIT gstmessage.c:129:_priv_gst_message_initialize: init messages
    0:00:00.001623515  1569     0x255b89f0 INFO                GST_INIT gstcontext.c:86:_priv_gst_context_initialize: init contexts
    0:00:00.001942985  1569     0x255b89f0 INFO      GST_PLUGIN_LOADING gstplugin.c:324:_priv_gst_plugin_initialize: registering 0 static plugins
    0:00:00.002083600  1569     0x255b89f0 INFO      GST_PLUGIN_LOADING gstplugin.c:232:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.002097005  1569     0x255b89f0 INFO      GST_PLUGIN_LOADING gstplugin.c:234:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.002151805  1569     0x255b89f0 INFO            GST_REGISTRY gstregistry.c:1871:ensure_current_registry: registry reading and updating done
    0:00:00.006068175  1569     0x255b89f0 INFO                GST_INIT gst.c:805:init_post: GLib runtime version: 2.78.6
    0:00:00.006092485  1569     0x255b89f0 INFO                GST_INIT gst.c:807:init_post: GLib headers version: 2.78.6
    0:00:00.006099295  1569     0x255b89f0 INFO                GST_INIT gst.c:809:init_post: initialized GStreamer successfully
    0:00:00.011478430  1569     0x255b89f0 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstfrei0r.so" loaded
    0:00:00.050164240  1568      0xf9f0290 INFO            GST_REGISTRY gstregistry.c:1804:scan_and_update_registry: Registry cache changed. Writing new registry cache
    0:00:00.050209395  1568      0xf9f0290 INFO            GST_REGISTRY gstregistrybinary.c:431:priv_gst_registry_binary_write_cache: Building binary registry cache image
    0:00:00.066644795  1568      0xf9f0290 INFO            GST_REGISTRY gstregistrybinary.c:463:priv_gst_registry_binary_write_cache: Writing binary registry cache
    0:00:00.151565540  1568      0xf9f0290 INFO            GST_REGISTRY gstregistrybinary.c:314:gst_registry_binary_cache_finish: Wrote binary registry cache
    0:00:00.151614020  1568      0xf9f0290 INFO            GST_REGISTRY gstregistry.c:1813:scan_and_update_registry: Registry cache written successfully
    0:00:00.151641155  1568      0xf9f0290 INFO            GST_REGISTRY gstregistry.c:1871:ensure_current_registry: registry reading and updating done
    0:00:00.151677220  1568      0xf9f0290 INFO                GST_INIT gst.c:805:init_post: GLib runtime version: 2.78.6
    0:00:00.151690825  1568      0xf9f0290 INFO                GST_INIT gst.c:807:init_post: GLib headers version: 2.78.6
    0:00:00.151699830  1568      0xf9f0290 INFO                GST_INIT gst.c:809:init_post: initialized GStreamer successfully
    0:00:00.151823765  1568      0xf9f0290 INFO            GST_PIPELINE gstparse.c:344:gst_parse_launch_full: parsing pipeline description 'filesrc location=./Image/450-1920-1200-L.raw blocksize=2304000 ! rawvideoparse width=1920 height=1200 format=gray8 framerate=1/1 ! videocrop left=320 right=320 top=88 bottom=88 ! capsfilter caps=video/x-raw,\ width=(int)1280,\ height=(int)1024; ! sde.left_sink filesrc location=./Image/450-1920-1200-R.raw blocksize=2304000 ! rawvideoparse width=1920 height=1200 format=gray8 framerate=1/1 ! videocrop left=320 right=320 top=88 bottom=88 ! capsfilter caps=video/x-raw,\ width=(int)1280,\ height=(int)1024; ! sde.right_sink tiovxsde name=sde median-filter-enable=true ! tiovxsdeviz ! jpegenc ! filesink location=output1280x1024.jpg '
    0:00:00.153437020  1568      0xf9f0290 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.153669970  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesrc"
    0:00:00.153717100  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseSrc@0xfd5f8a0> adding pad 'src'
    0:00:00.153776495  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:237:gst_file_src_set_location: filename : ./Image/450-1920-1200-L.raw
    0:00:00.153787110  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:238:gst_file_src_set_location: uri      : file:///root/workspace/Image/450-1920-1200-L.raw
    0:00:00.172409205  1568      0xf9f0290 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstrawparse.so" loaded
    0:00:00.172888120  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "rawvideoparse"
    0:00:00.172928640  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0xfd648f0> adding pad 'sink'
    0:00:00.172952950  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0xfd648f0> adding pad 'src'
    0:00:00.177278625  1568      0xf9f0290 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideocrop.so" loaded
    0:00:00.177524720  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "videocrop"
    0:00:00.177563000  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd6adf0> adding pad 'sink'
    0:00:00.177594325  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd6adf0> adding pad 'src'
    0:00:00.177686905  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "capsfilter"
    0:00:00.177710640  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd71570> adding pad 'sink'
    0:00:00.177730305  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd71570> adding pad 'src'
    0:00:00.177750810  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.177781905  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesrc"
    0:00:00.177804150  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseSrc@0xfd71fb0> adding pad 'src'
    0:00:00.177853945  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:237:gst_file_src_set_location: filename : ./Image/450-1920-1200-R.raw
    0:00:00.177863700  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:238:gst_file_src_set_location: uri      : file:///root/workspace/Image/450-1920-1200-R.raw
    0:00:00.177904945  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "rawvideoparse"
    0:00:00.177931025  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0xfd72bb0> adding pad 'sink'
    0:00:00.177951525  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0xfd72bb0> adding pad 'src'
    0:00:00.177994210  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "videocrop"
    0:00:00.178017450  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd74b70> adding pad 'sink'
    0:00:00.178037300  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd74b70> adding pad 'src'
    0:00:00.178095325  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "capsfilter"
    0:00:00.178117630  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd75dc0> adding pad 'sink'
    0:00:00.178137550  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfd75dc0> adding pad 'src'
    0:00:00.178152140  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.384465210  1568      0xf9f0290 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.384857400  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "tiovxsde"
    0:00:00.384917505  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstAggregator@0xfd9abc0> adding pad 'src'
    0:00:00.384946860  1568      0xf9f0290 INFO            tiovxcontext gsttiovxcontext.c:141:gst_tiovx_context_init: Calling appInit() from GST!
    0:00:00.476714040  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "tiovxsdeviz"
    0:00:00.476802535  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfdef5f0> adding pad 'sink'
    0:00:00.476828580  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0xfdef5f0> adding pad 'src'
    0:00:00.493262315  1568      0xf9f0290 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstjpeg.so" loaded
    0:00:00.493494790  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "jpegenc"
    0:00:00.493532690  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstVideoEncoder@0xfdf34f0> adding pad 'sink'
    0:00:00.493556610  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstVideoEncoder@0xfdf34f0> adding pad 'src'
    0:00:00.496478070  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesink"
    0:00:00.496530730  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseSink@0xfdf6f00> adding pad 'sink'
    0:00:00.496579415  1568      0xf9f0290 INFO                filesink gstfilesink.c:321:gst_file_sink_set_location:<filesink0> filename : output1280x1024.jpg
    0:00:00.496590160  1568      0xf9f0290 INFO                filesink gstfilesink.c:322:gst_file_sink_set_location:<filesink0> uri      : file:///root/workspace/output1280x1024.jpg
    0:00:00.496612620  1568      0xf9f0290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "pipeline"
    0:00:00.496826965  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstFileSrc named filesrc0 to some pad of GstRawVideoParse named rawvideoparse0 (0/0) with caps "(NULL)"
    0:00:00.496843325  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element filesrc0:(any) to element rawvideoparse0:(any)
    0:00:00.496859975  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link filesrc0:src and rawvideoparse0:sink
    0:00:00.496917175  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: filesrc0 and rawvideoparse0 in same bin, no need for ghost pads
    0:00:00.496943080  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link filesrc0:src and rawvideoparse0:sink
    0:00:00.496991435  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked filesrc0:src and rawvideoparse0:sink, successful
    0:00:00.497000615  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.497016175  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<filesrc0:src> Received event on flushing pad. Discarding
    0:00:00.497042435  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstRawVideoParse named rawvideoparse0 to some pad of GstVideoCrop named videocrop0 (0/0) with caps "(NULL)"
    0:00:00.497053735  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element rawvideoparse0:(any) to element videocrop0:(any)
    0:00:00.497066290  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link rawvideoparse0:src and videocrop0:sink
    0:00:00.497086375  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop0:src> pad has no peer
    0:00:00.497273805  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: rawvideoparse0 and videocrop0 in same bin, no need for ghost pads
    0:00:00.497292035  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link rawvideoparse0:src and videocrop0:sink
    0:00:00.497306220  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop0:src> pad has no peer
    0:00:00.497478240  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked rawvideoparse0:src and videocrop0:sink, successful
    0:00:00.497487180  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.497494945  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<rawvideoparse0:src> Received event on flushing pad. Discarding
    0:00:00.497519665  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstVideoCrop named videocrop0 to some pad of GstCapsFilter named capsfilter0 (0/0) with caps "(NULL)"
    0:00:00.497531180  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element videocrop0:(any) to element capsfilter0:(any)
    0:00:00.497543840  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link videocrop0:src and capsfilter0:sink
    0:00:00.498544240  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter0:src> pad has no peer
    0:00:00.498579555  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: videocrop0 and capsfilter0 in same bin, no need for ghost pads
    0:00:00.498595015  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link videocrop0:src and capsfilter0:sink
    0:00:00.499596595  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter0:src> pad has no peer
    0:00:00.499646010  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked videocrop0:src and capsfilter0:sink, successful
    0:00:00.499654355  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.499662040  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<videocrop0:src> Received event on flushing pad. Discarding
    0:00:00.499679130  1568      0xf9f0290 INFO           GST_PARENTAGE gstbin.c:4385:gst_bin_get_by_name: [pipeline0]: looking up child element sde
    0:00:00.499714420  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstCapsFilter named capsfilter0 to pad  sde of GstTIOVXSde named sde (0/1) with caps "(NULL)"
    0:00:00.499738855  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element capsfilter0:(any) to element sde:left_sink
    0:00:00.499749605  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'left_sink' in element "sde"
    0:00:00.499759995  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'left_sink' in element "sde"
    0:00:00.499800535  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<sde> adding pad 'sink_0'
    0:00:00.499819235  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: capsfilter0 and sde in same bin, no need for ghost pads
    0:00:00.499835315  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link capsfilter0:src and sde:sink_0
    0:00:00.500930860  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked capsfilter0:src and sde:sink_0, successful
    0:00:00.500939725  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.500947205  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<capsfilter0:src> Received event on flushing pad. Discarding
    0:00:00.500969925  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstFileSrc named filesrc1 to some pad of GstRawVideoParse named rawvideoparse1 (0/0) with caps "(NULL)"
    0:00:00.500980960  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element filesrc1:(any) to element rawvideoparse1:(any)
    0:00:00.500993760  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link filesrc1:src and rawvideoparse1:sink
    0:00:00.501010975  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: filesrc1 and rawvideoparse1 in same bin, no need for ghost pads
    0:00:00.501025125  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link filesrc1:src and rawvideoparse1:sink
    0:00:00.501041860  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked filesrc1:src and rawvideoparse1:sink, successful
    0:00:00.501049365  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.501056895  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<filesrc1:src> Received event on flushing pad. Discarding
    0:00:00.501076590  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstRawVideoParse named rawvideoparse1 to some pad of GstVideoCrop named videocrop1 (0/0) with caps "(NULL)"
    0:00:00.501086965  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element rawvideoparse1:(any) to element videocrop1:(any)
    0:00:00.501098745  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link rawvideoparse1:src and videocrop1:sink
    0:00:00.501112840  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop1:src> pad has no peer
    0:00:00.501259015  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: rawvideoparse1 and videocrop1 in same bin, no need for ghost pads
    0:00:00.501274555  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link rawvideoparse1:src and videocrop1:sink
    0:00:00.501287845  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop1:src> pad has no peer
    0:00:00.501460215  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked rawvideoparse1:src and videocrop1:sink, successful
    0:00:00.501480440  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.501489565  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<rawvideoparse1:src> Received event on flushing pad. Discarding
    0:00:00.501510920  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstVideoCrop named videocrop1 to some pad of GstCapsFilter named capsfilter1 (0/0) with caps "(NULL)"
    0:00:00.501521770  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element videocrop1:(any) to element capsfilter1:(any)
    0:00:00.501533700  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link videocrop1:src and capsfilter1:sink
    0:00:00.502493210  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter1:src> pad has no peer
    0:00:00.502525875  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: videocrop1 and capsfilter1 in same bin, no need for ghost pads
    0:00:00.502541350  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link videocrop1:src and capsfilter1:sink
    0:00:00.503523140  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter1:src> pad has no peer
    0:00:00.503566760  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked videocrop1:src and capsfilter1:sink, successful
    0:00:00.503575210  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.503582475  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<videocrop1:src> Received event on flushing pad. Discarding
    0:00:00.503598630  1568      0xf9f0290 INFO           GST_PARENTAGE gstbin.c:4385:gst_bin_get_by_name: [pipeline0]: looking up child element sde
    0:00:00.503621830  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstCapsFilter named capsfilter1 to pad  sde of GstTIOVXSde named sde (0/1) with caps "(NULL)"
    0:00:00.503632280  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element capsfilter1:(any) to element sde:right_sink
    0:00:00.503641525  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'right_sink' in element "sde"
    0:00:00.503651120  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'right_sink' in element "sde"
    0:00:00.503687415  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<sde> adding pad 'sink_1'
    0:00:00.503703965  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: capsfilter1 and sde in same bin, no need for ghost pads
    0:00:00.503719620  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link capsfilter1:src and sde:sink_1
    0:00:00.504802040  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked capsfilter1:src and sde:sink_1, successful
    0:00:00.504811355  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.504818870  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<capsfilter1:src> Received event on flushing pad. Discarding
    0:00:00.504839705  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstTIOVXSde named sde to some pad of GstTIOVXSdeViz named tiovxsdeviz0 (0/0) with caps "(NULL)"
    0:00:00.504850045  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element sde:(any) to element tiovxsdeviz0:(any)
    0:00:00.504873990  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link sde:src and tiovxsdeviz0:sink
    0:00:00.504890435  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<tiovxsdeviz0:src> pad has no peer
    0:00:00.504937730  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: sde and tiovxsdeviz0 in same bin, no need for ghost pads
    0:00:00.504953120  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link sde:src and tiovxsdeviz0:sink
    0:00:00.504966355  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<tiovxsdeviz0:src> pad has no peer
    0:00:00.505003010  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked sde:src and tiovxsdeviz0:sink, successful
    0:00:00.505011575  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.505018895  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<sde:src> Received event on flushing pad. Discarding
    0:00:00.505049840  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstTIOVXSdeViz named tiovxsdeviz0 to some pad of GstJpegEnc named jpegenc0 (0/0) with caps "(NULL)"
    0:00:00.505060410  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element tiovxsdeviz0:(any) to element jpegenc0:(any)
    0:00:00.505072145  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link tiovxsdeviz0:src and jpegenc0:sink
    0:00:00.505142285  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<jpegenc0:src> pad has no peer
    0:00:00.505185225  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: tiovxsdeviz0 and jpegenc0 in same bin, no need for ghost pads
    0:00:00.505201145  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link tiovxsdeviz0:src and jpegenc0:sink
    0:00:00.505246090  1568      0xf9f0290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<jpegenc0:src> pad has no peer
    0:00:00.505279675  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked tiovxsdeviz0:src and jpegenc0:sink, successful
    0:00:00.505288170  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.505295290  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<tiovxsdeviz0:src> Received event on flushing pad. Discarding
    0:00:00.505318720  1568      0xf9f0290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstJpegEnc named jpegenc0 to some pad of GstFileSink named filesink0 (0/0) with caps "(NULL)"
    0:00:00.505329235  1568      0xf9f0290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element jpegenc0:(any) to element filesink0:(any)
    0:00:00.505341020  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link jpegenc0:src and filesink0:sink
    0:00:00.505359650  1568      0xf9f0290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: jpegenc0 and filesink0 in same bin, no need for ghost pads
    0:00:00.505373755  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link jpegenc0:src and filesink0:sink
    0:00:00.505390115  1568      0xf9f0290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked jpegenc0:src and filesink0:sink, successful
    0:00:00.505397500  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.505404480  1568      0xf9f0290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<jpegenc0:src> Received event on flushing pad. Discarding
    0:00:00.506172470  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesink0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506296735  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesink0> completed state change to READY
    0:00:00.506311960  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesink0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506354825  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesink0' changed state to 2(READY) successfully
    0:00:00.506372785  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<jpegenc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506385290  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<jpegenc0> completed state change to READY
    0:00:00.506395620  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<jpegenc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506410380  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'jpegenc0' changed state to 2(READY) successfully
    0:00:00.506423850  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxsdeviz0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506434240  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<tiovxsdeviz0> completed state change to READY
    0:00:00.506443615  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<tiovxsdeviz0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506457625  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'tiovxsdeviz0' changed state to 2(READY) successfully
    0:00:00.506472380  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<sde> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506484275  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<sde> completed state change to READY
    0:00:00.506493770  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<sde> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506507460  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'sde' changed state to 2(READY) successfully
    0:00:00.506520845  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506531140  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter0> completed state change to READY
    0:00:00.506540360  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506554115  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 2(READY) successfully
    0:00:00.506567600  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506577985  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter1> completed state change to READY
    0:00:00.506587370  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506623675  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter1' changed state to 2(READY) successfully
    0:00:00.506638730  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506649330  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop0> completed state change to READY
    0:00:00.506658820  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506672600  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop0' changed state to 2(READY) successfully
    0:00:00.506688315  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506698460  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop1> completed state change to READY
    0:00:00.506707970  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506721295  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop1' changed state to 2(READY) successfully
    0:00:00.506782575  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506803440  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse0> completed state change to READY
    0:00:00.506814855  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506830325  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse0' changed state to 2(READY) successfully
    0:00:00.506845725  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506856260  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse1> completed state change to READY
    0:00:00.506865710  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506880955  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse1' changed state to 2(READY) successfully
    0:00:00.506893235  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506903770  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc0> completed state change to READY
    0:00:00.506913645  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506927875  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 2(READY) successfully
    0:00:00.506940220  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.506950330  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc1> completed state change to READY
    0:00:00.506970475  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.506986235  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc1' changed state to 2(READY) successfully
    0:00:00.507008220  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2788:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PAUSED, next PAUSED
    0:00:00.507018830  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed NULL to READY (PAUSED pending)
    0:00:00.507086365  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2796:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PAUSED
    0:00:00.507121750  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesink0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.507148195  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2943:gst_bin_change_state_func:<pipeline0> child 'filesink0' is changing state asynchronously to PAUSED
    0:00:00.507163325  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<jpegenc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.507186370  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<jpegenc0> completed state change to PAUSED
    0:00:00.507197090  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<jpegenc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.507212610  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'jpegenc0' changed state to 3(PAUSED) successfully
    0:00:00.507226515  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxsdeviz0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.507245315  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<tiovxsdeviz0> completed state change to PAUSED
    0:00:00.507255945  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<tiovxsdeviz0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.507270370  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'tiovxsdeviz0' changed state to 3(PAUSED) successfully
    0:00:00.507284735  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<sde> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.507312420  1568      0xf9f0290 INFO              aggregator gstaggregator.c:2563:gst_aggregator_src_pad_activate_mode_func:<sde:src> Activating pad!
    0:00:00.507320905  1568      0xf9f0290 INFO              aggregator gstaggregator.c:1550:gst_aggregator_start_srcpad_task:<sde> Starting srcpad task
    0:00:00.507523470  1568      0xf9f0290 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0xfd9bc20 on task 0xfdfed20
    0:00:00.507541050  1568      0xf9f0290 INFO                GST_PADS gstpad.c:6357:gst_pad_start_task:<sde:src> created task 0xfdfed20
    0:00:00.507777795  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<sde> completed state change to PAUSED
    0:00:00.507800110  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<sde> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.507819715  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'sde' changed state to 3(PAUSED) successfully
    0:00:00.507840045  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.507881045  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
    0:00:00.507892655  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.507908305  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 3(PAUSED) successfully
    0:00:00.507923055  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.507941315  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter1> completed state change to PAUSED
    0:00:00.507951885  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.507966780  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter1' changed state to 3(PAUSED) successfully
    0:00:00.507981280  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.507999385  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop0> completed state change to PAUSED
    0:00:00.508009785  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.508024685  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop0' changed state to 3(PAUSED) successfully
    0:00:00.508038995  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.508056255  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop1> completed state change to PAUSED
    0:00:00.508066430  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.508080965  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop1' changed state to 3(PAUSED) successfully
    0:00:00.508094990  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.508205440  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file ./Image/450-1920-1200-L.raw
    0:00:00.509227495  1568      0xf9f0290 WARN                 basesrc gstbasesrc.c:3695:gst_base_src_start_complete:<filesrc0> pad not activated yet
    0:00:00.509917965  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file ./Image/450-1920-1200-L.raw
    0:00:00.509967290  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:998: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.510001915  1568      0xf9f0290 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0xfd64e20 on task 0xfe002c0
    0:00:00.510013680  1568      0xf9f0290 INFO                GST_PADS gstpad.c:6357:gst_pad_start_task:<rawvideoparse0:sink> created task 0xfe002c0
    0:00:00.510262410  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse0> completed state change to PAUSED
    0:00:00.510284645  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.510294240  1568 0xffff70000d30 INFO        GST_ELEMENT_PADS gstelement.c:1016:gst_element_get_static_pad: found pad rawvideoparse0:sink
    0:00:00.510327545  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse0' changed state to 3(PAUSED) successfully
    0:00:00.510350025  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.510400125  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc1> opening file ./Image/450-1920-1200-R.raw
    0:00:00.510478425  1568      0xf9f0290 WARN                 basesrc gstbasesrc.c:3695:gst_base_src_start_complete:<filesrc1> pad not activated yet
    0:00:00.510503705  1568      0xf9f0290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc1> opening file ./Image/450-1920-1200-R.raw
    0:00:00.510540535  1568      0xf9f0290 INFO               GST_EVENT gstevent.c:998: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.510566805  1568      0xf9f0290 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0xfd730e0 on task 0xfe00c90
    0:00:00.510577755  1568      0xf9f0290 INFO                GST_PADS gstpad.c:6357:gst_pad_start_task:<rawvideoparse1:sink> created task 0xfe00c90
    0:00:00.510838860  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse1> completed state change to PAUSED
    0:00:00.510877005  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.510901240  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse1' changed state to 3(PAUSED) successfully
    0:00:00.510918995  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.510937460  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc0> completed state change to PAUSED
    0:00:00.510948305  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.510963585  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 3(PAUSED) successfully
    0:00:00.510976140  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.510990040  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc1> completed state change to PAUSED
    0:00:00.511000590  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.511015085  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc1' changed state to 3(PAUSED) successfully
    0:00:00.511034375  1568      0xf9f0290 INFO                pipeline gstpipeline.c:533:gst_pipeline_change_state:<pipeline0> pipeline is not live
    0:00:00.511399775  1568 0xffff70000ef0 INFO        GST_ELEMENT_PADS gstelement.c:1016:gst_element_get_static_pad: found pad rawvideoparse1:sink
    0:00:00.614440655  1568 0xffff70000ef0 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1920, height=(int)1200, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.614440620  1568 0xffff70000d30 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1920, height=(int)1200, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.618519675  1568 0xffff70000d30 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.618519700  1568 0xffff70000ef0 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.618646655  1568 0xffff70000d30 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<capsfilter0> reuse caps
    0:00:00.618650675  1568 0xffff70000ef0 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<capsfilter1> reuse caps
    0:00:00.618674950  1568 0xffff70000d30 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.618696745  1568 0xffff70000ef0 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.618802380  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxmiso.c:858:gst_tiovx_miso_propose_allocation:<sde> Using temporary reference for configuration
    0:00:00.618838365  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxutils.c:629:gst_tiovx_get_exemplar_from_caps:<sde> creating image with width: 1280	 height: 1024	 format: 0x38303055
    0:00:00.618930730  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.618939760  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.619110505  1568 0xffff70000b70 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffff68001f00> New TIOVX buffer pool
    0:00:00.619197350  1568 0xffff70000b70 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff68002d20> New TIOVX allocator
    0:00:00.619227175  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 2 buffers of 1310720 size
    0:00:00.619269185  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxmiso.c:858:gst_tiovx_miso_propose_allocation:<sde> Using temporary reference for configuration
    0:00:00.619301935  1568 0xffff70000d30 INFO               videocrop gstvideocrop.c:507:gst_video_crop_decide_allocation:<videocrop0> we are not using passthrough
    0:00:00.619315355  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxutils.c:629:gst_tiovx_get_exemplar_from_caps:<sde> creating image with width: 1280	 height: 1024	 format: 0x38303055
    0:00:00.619359990  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.619367600  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.619404060  1568 0xffff70000d30 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff6c004e80> New TIOVX allocator
    0:00:00.619446895  1568 0xffff70000b70 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffff680035e0> New TIOVX buffer pool
    0:00:00.619484855  1568 0xffff70000b70 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff680038e0> New TIOVX allocator
    0:00:00.619504680  1568 0xffff70000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 2 buffers of 1310720 size
    0:00:00.619566900  1568 0xffff70000ef0 INFO               videocrop gstvideocrop.c:507:gst_video_crop_decide_allocation:<videocrop1> we are not using passthrough
    0:00:00.619639020  1568 0xffff70000ef0 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff60003b10> New TIOVX allocator
    0:00:00.627758250  1568 0xffff70000d30 INFO          GST_SCHEDULING gstpad.c:5084:gst_pad_get_range_unchecked:<filesrc0:src> getrange failed, flow: eos
    0:00:00.627758275  1568 0xffff70000b70 INFO                tiovxsde gsttiovxsde.c:954:gst_tiovx_sde_fixate_caps:<sde> Fixating caps
    0:00:00.627862115  1568 0xffff70000ef0 INFO          GST_SCHEDULING gstpad.c:5084:gst_pad_get_range_unchecked:<filesrc1:src> getrange failed, flow: eos
    0:00:00.627877920  1568 0xffff70000ef0 INFO          GST_SCHEDULING gstpad.c:5299:gst_pad_pull_range:<rawvideoparse1:sink> pullrange failed, flow: eos
    0:00:00.627878720  1568 0xffff70000b70 INFO              aggregator gstaggregator.c:639:gst_aggregator_push_mandatory_events:<sde> pushing stream start
    0:00:00.627957135  1568 0xffff70000b70 INFO              aggregator gstaggregator.c:650:gst_aggregator_push_mandatory_events:<sde> pushing caps: application/x-sde-tiovx, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.627977140  1568 0xffff70000b70 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event application/x-sde-tiovx, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.627997065  1568 0xffff70000ef0 INFO                    task gsttask.c:368:gst_task_func:<rawvideoparse1:sink> Task going to paused
    0:00:00.628167900  1568 0xffff70000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:506:gst_tiovx_sde_viz_init_module:<tiovxsdeviz0> Init module
    0:00:00.628614945  1568 0xffff70000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:563:gst_tiovx_sde_viz_create_graph:<tiovxsdeviz0> Create graph
    0:00:00.628636230  1568 0xffff70000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:574:gst_tiovx_sde_viz_create_graph:<tiovxsdeviz0> TIOVX Target to use: DSP-1
    0:00:00.628799530  1568 0xffff70000d30 INFO          GST_SCHEDULING gstpad.c:5299:gst_pad_pull_range:<rawvideoparse0:sink> pullrange failed, flow: eos
    0:00:00.628894285  1568 0xffff70000d30 INFO                    task gsttask.c:368:gst_task_func:<rawvideoparse0:sink> Task going to paused
    0:00:00.636477545  1568 0xffff70000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:659:gst_tiovx_sde_viz_get_node_info:<tiovxsdeviz0> Get node info from module
    0:00:00.638439450  1568 0xffff70000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:600:gst_tiovx_sde_viz_release_buffer:<tiovxsdeviz0> Release buffer
    0:00:00.639442550  1568 0xffff70000b70 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)1024, framerate=(fraction)0/1, format=(string)RGB
    0:00:00.639801335  1568 0xffff70000b70 INFO               tiovxsiso gsttiovxsiso.c:572:gst_tiovx_siso_decide_allocation:<tiovxsdeviz0> No TIOVX pool, discarding: "videobufferpool0"
    0:00:00.639867315  1568 0xffff70000b70 INFO               tiovxsiso gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.639899165  1568 0xffff70000b70 INFO               tiovxsiso gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.639941170  1568 0xffff70000b70 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffff6800e960> New TIOVX buffer pool
    0:00:00.639985505  1568 0xffff70000b70 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff6800ec60> New TIOVX allocator
    0:00:00.640007905  1568 0xffff70000b70 INFO               tiovxsiso gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 2 buffers of 3932160 size
    0:00:00.646202770  1568 0xffff70000b70 INFO                tiovxsde gsttiovxsde.c:728:gst_tiovx_sde_init_module:<sde> Init module
    0:00:00.646302805  1568 0xffff70000b70 INFO                tiovxsde gsttiovxsde.c:763:gst_tiovx_sde_init_module:<sde> Input Left & Input Right parameters: 
    	Width: 1280 
    	Height: 1024
    0:00:06.120961615  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesink0> current READY pending PAUSED, desired next READY
    0:00:06.121056655  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesink0> completed state change to READY
    0:00:06.121071400  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesink0> notifying about state-changed READY to READY (VOID_PENDING pending)
    0:00:06.121087850  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesink0' changed state to 2(READY) successfully
    0:00:06.121103450  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<jpegenc0> current PAUSED pending VOID_PENDING, desired next READY
    0:00:06.121151345  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<jpegenc0> completed state change to READY
    0:00:06.121164340  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<jpegenc0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
    0:00:06.121179950  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'jpegenc0' changed state to 2(READY) successfully
    0:00:06.121194620  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxsdeviz0> current PAUSED pending VOID_PENDING, desired next READY
    0:00:06.121245940  1568      0xf9f0290 INFO             tiovxsdeviz gsttiovxsdeviz.c:622:gst_tiovx_sde_viz_deinit_module:<tiovxsdeviz0> Deinit module
    0:00:06.122949690  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<tiovxsdeviz0> completed state change to READY
    0:00:06.122993755  1568      0xf9f0290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<tiovxsdeviz0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
    0:00:06.123019520  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'tiovxsdeviz0' changed state to 2(READY) successfully
    0:00:06.123043560  1568      0xf9f0290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<sde> current PAUSED pending VOID_PENDING, desired next READY
    0:00:06.123062845  1568      0xf9f0290 INFO              aggregator gstaggregator.c:2576:gst_aggregator_src_pad_activate_mode_func:<sde> Deactivating srcpad
    0:00:06.123072090  1568      0xf9f0290 INFO              aggregator gstaggregator.c:1530:gst_aggregator_stop_srcpad_task:<sde> Stopping srcpad task
    

    The GStreamer pipeline is as follows:

    GST_DEBUG_FILE=trace.log \
    GST_DEBUG_NO_COLOR=1 \
    GST_DEBUG=4 \
    gst-launch-1.0 \
    filesrc location=./Image/450-1920-1200-L.raw blocksize=2304000 \
    ! rawvideoparse width=1920 height=1200 format=gray8 framerate=1/1 \
    ! videocrop left=320 right=320 top=88 bottom=88 \
    ! capsfilter caps="video/x-raw, width=(int)1280, height=(int)1024;" \
    ! sde.left_sink \
    filesrc location=./Image/450-1920-1200-R.raw blocksize=2304000 \
    ! rawvideoparse width=1920 height=1200 format=gray8 framerate=1/1 \
    ! videocrop left=320 right=320 top=88 bottom=88 \
    ! capsfilter caps="video/x-raw, width=(int)1280, height=(int)1024;" \
    ! sde.right_sink \
    tiovxsde name=sde \
    median-filter-enable=true \
    ! tiovxsdeviz \
    ! jpegenc \
    ! filesink location=output1280x1024.jpg

  • Hi ,

    I've attached the log taken when running GStreamer with "GST_DEBUG=4".

    Do you have the log of when it was working to compare against?

    Is there a folder named "vision_apps_eaik"?

    Best,
    Jared

  • Hi Jared, 

    There is a folder called "vision_apps_eaik."
    I have attached the log taken when running GStreamer in an environment with only the Linux SDK. It is working properly.

    7750.trace.log

    Best,
    Tetsuya

  • Hi ,

    Instead of running the linux_fs_install_sd script, can you copy over the firmware found within vision_apps_eaik?

    Best,
    Jared

  • Hi Jared, 

    I copied the firmware from the vision_apps_eaik folder generated by building it to the /usr/lib/firmware/vision_apps_eaik folder on the target board, but it doesn't work properly.
    (The message "Pipeline is PREROLLING..." appears and the program stops.)
    The firmware I copied is as follows:
    vx_app_rtos_linux_c6x_1.out
    vx_app_rtos_linux_c6x_2.out
    vx_app_rtos_linux_c7x_1.out
    vx_app_rtos_linux_mcu2_0.out
    vx_app_rtos_linux_mcu2_1.out

    Best,
    Tetsuya

  • Hi ,

    /usr/lib/firmware/vision_apps_eaik

    Do the symbolic links for the firmwares point to this location?

    Best,
    Jared

  • Hi Jared,

    Below is the symbolic link information in the /usr/lib/firmware folder, which points to the copied files.

    lrwxrwxrwx  1 root root      62 Mar  9  2018 j7-c66_0-fw -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_c6x_1.out
    lrwxrwxrwx  1 root root      69 Mar  9  2018 j7-c66_0-fw-sec -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_c6x_1.out.signed
    lrwxrwxrwx  1 root root      62 Mar  9  2018 j7-c66_1-fw -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_c6x_2.out
    lrwxrwxrwx  1 root root      69 Mar  9  2018 j7-c66_1-fw-sec -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_c6x_2.out.signed
    lrwxrwxrwx  1 root root      62 Mar  9  2018 j7-c71_0-fw -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_c7x_1.out
    lrwxrwxrwx  1 root root      69 Mar  9  2018 j7-c71_0-fw-sec -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_c7x_1.out.signed
    lrwxrwxrwx  1 root root      63 Mar  9  2018 j7-main-r5f0_0-fw -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_mcu2_0.out
    lrwxrwxrwx  1 root root      70 Mar  9  2018 j7-main-r5f0_0-fw-sec -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_mcu2_0.out.signed
    lrwxrwxrwx  1 root root      63 Mar  9  2018 j7-main-r5f0_1-fw -> /usr/lib/firmware/vision_apps_eaik/vx_app_rtos_linux_mcu2_1.out
    

    Best,
    Tetsuya

  • Hi ,

    Can you test whether this build method/binaries work without the sde changes? Remove the changes, rebuild, and then recopy the vision_apps_eaik firmware over.

    If they work, then the issue is in the changes made, otherwise the build process itself is incorrect.

    Best,
    Jared

  • Hi Jared,

    I tried everything again.
    In conclusion, the GStreamer pipeline using the 1280x1024 pixel SDE completed successfully, but the GStreamer pipeline using the 1920x1024 pixel SDE failed.

    Here are the steps I took:
    1. Create an SD card

    cd ti-processor-sdk-linux-edgeai-j721e-evm-10_01_00_04
    sudo ./bin/create-sdcard.sh

    Select the following image to write:

    Install pre-built images from SDK
    tisdk-edgeai-image-j721e-sk.rootfs.tar.xz

    2. Run the GStreamer pipeline using the 1280x1024 pixel SDE
    The GStreamer pipeline completed successfully.

    3. Run the GStreamer pipeline using the 1920x1024 pixel SDE
    The GStreamer pipeline will fail.

    4. Extract the RTOS SDK

    tar -zxf ti-processor-sdk-rtos-j721e-evm-10_01_00_04.tar.gz

    5. Edit the RTOS SDK build script
    ./sdk_builder/make_firmware.sh

    # time make firmware -j${NUM_PROCS} 2> >(tee ${log_file})
    time make firmware -j${NUM_PROCS} SOC=j721e TISDK_IMAGE=edgeai 2> >(tee ${log_file})

    6. Build the RTOS SDK

    cd sdk_builder
    ./make_firmware.sh

    7. Dealing with build errors
    The error occurs because the directory does not exist, so create it.

    mkdir ../core-secdev-k3

    8. Build the RTOS SDK again.

    ./make_firmware.sh

    9. Copy the RTOS SDK firmware to the target board.

    scp /tmp/tivision_apps_targetfs_stage/usr/lib/firmware/vision_apps_eaik/*.out root@[target ipaddress]:/usr/lib/firmware/vision_apps_eaik/

    10. Run the GStreamer pipeline using the 1280x1024 pixel SDE.
    The GStreamer pipeline execution will complete successfully.

    11. Changing SL2 memory allocation
    ./ti-processor-sdk-rtos-j721e-evm-10_01_00_04/pdk_jacinto_10_01_00_25/packages/ti/drv/vhwa/include/vhwa_m2mSde.h

    //#define SDE_DEFAULT_IMG_WIDTH (1280U)
    #define SDE_DEFAULT_IMG_WIDTH (2048U)

    12. Rebuilding the RTOS SDK

    make firmware_scrub
    ./make_firmware.sh

    13. Copying the RTOS SDK firmware to the target board

    scp /tmp/tivision_apps_targetfs_stage/usr/lib/firmware/vision_apps_eaik/*.out root@[target ipaddress]:/usr/lib/firmware/vision_apps_eaik/

    14. Run the GStreamer pipeline using the 1280x1024 pixel SDE
    The GStreamer pipeline completed successfully.

    15. Run the GStreamer pipeline using the 1920x1024 pixel SDE
    The GStreamer pipeline will fail.

    Execution log for No. 2: trace_edge_1280.log
    Execution log for No. 3: trace_edge_1920.log
    Execution log for No. 14: trace_rtos_1280.log
    Execution log for No. 15: trace_rtos_1920.log
    I've attached the following.

    Based on the logs, it seems that No. 11, "Changing SL2 memory allocation," had no effect.
    Please tell me again how to change SL2 memory allocation.
    trace_edge_1280.logtrace_edge_1920.logtrace_rtos_1280.logtrace_rtos_1920.log
    Best,
    Tetsuya

  • Hi ,

    Did the firmware actually change? If you run a diff on the two firmware versions, did the binaries change?

    Best,
    Jared

  • Hi Jared,

    I tried steps 14 and 15 again.
    * This is the firmware with the SL2 memory allocation changes applied.
    After the firmware replacement, I power-cycled the target board and checked.
    The GStreamer pipeline did not complete with either the 1280x1024 pixel SDE or the 1920x1024 pixel SDE.
    (The message "Pipeline is PREROLLING..." appeared and execution stopped.)

    I also tried step 10 again.
    * This is the firmware before the SL2 memory allocation changes.
    After the firmware replacement, I power-cycled the target board and checked.
    As reported in my previous post,
    the GStreamer pipeline using the 1280x1024 pixel SDE completed successfully.
    I also checked the GStreamer pipeline using the 1920x1024 pixel SDE, but the same error occurred as when creating the SD card with the Linux SDK.

    From this result, I am able to build the firmware using the RTOS SDK, but when I make changes to vhwa_m2mSde.h to change the SL2 memory allocation, execution stops with the message "Pipeline is PREROLLING...".

    Best,
    Tetsuya

  • Hi ,

    Can you try changing SDE_SR_128 to SDE_SR_128 to SDE_SR_192 as well?

    Best,
    Jared

  • Hi Jared,

    I tried changing SDE_SR_128 to SDE_SR_192, but the situation did not change.
    (The message "Pipeline is PREROLLING..." appears and the program stops.)


    The steps taken are as follows:

    Editing files
    ./ti-processor-sdk-rtos-j721e-evm-10_01_00_04/pdk_jacinto_10_01_00_25/packages/ti/drv/vhwa/include/vhwa_m2mSde.h

    //#define SDE_DEFAULT_IMG_WIDTH       (1280U)
    #define SDE_DEFAULT_IMG_WIDTH       (2048U)
    #define SDE_DEFAULT_CCSF            (FVID2_CCSF_BITS12_UNPACKED16)
    #define SDE_DEFAULT_DIS_BUFF_DEPTH  (2U)
    //#define SDE_DEFAULT_SR              (SDE_SR_128)
    #define SDE_DEFAULT_SR              (SDE_SR_192)


    Rebuilding the RTOS SDK
    make firmware_scrub
    ./make_firmware.sh

    Copying the RTOS SDK firmware to the target board

    scp /tmp/tivision_apps_targetfs_stage/usr/lib/firmware/vision_apps_eaik/*.out root@[target ipaddress]:/usr/lib/firmware/vision_apps_eaik/

    Reboot the target board

    Run the GStreamer pipeline using the 1280x1024 pixel SDE

  • Hi ,

    Can you try running the following before running the GStreamer pipeline and outputting the logs?

    $ source /opt/vision_apps/vision_apps_init.sh

    Best,
    Jared

  • Hi Jared,

    As suggested, I ran (source) "vision_apps_init.sh" and then ran the GStreamer pipeline using a 1280x1024 pixel SDE.

    1. Before updating the firmware, I ran "vision_apps_init.sh" and then ran the GStreamer pipeline.
    I am attaching the output log from vision_apps_init.sh as "init_log_edge.txt".
    I am attaching the GStreamer pipeline log as "trace_edge_1280_with_remote_log_out.log".

    2. After updating the firmware, I ran "vision_apps_init.sh" and then ran the GStreamer pipeline.
    I am attaching the output log from vision_apps_init.sh as "init_log_rtos.txt".
    I am attaching the GStreamer pipeline log as "trace_rtos_1280_with_remote_log_out.log".

    After updating the firmware, the message "[MCU2_1] 24.464700 s: VHWA: ERROR: SDE SL2 Alloc Failed !!!" is output to init_log_rtos.txt, and one line of the log "IPC: Echo status" is missing.

    Best,
    Tetsuya

    root@tda4vm-sk:~/workspace/sde-test# source /opt/vision_apps/vision_apps_init.sh 
    root@tda4vm-sk:~/workspace/sde-test# [MCU2_0]      4.289954 s: CIO: Init ... Done !!!
    [MCU2_0]      4.290029 s: ### CPU Frequency = 1000000000 Hz
    [MCU2_0]      4.290067 s: CPU is running FreeRTOS
    [MCU2_0]      4.290089 s: APP: Init ... !!!
    [MCU2_0]      4.290109 s: SCICLIENT: Init ... !!!
    [MCU2_0]      4.290321 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [MCU2_0]      4.290361 s: SCICLIENT: DMSC FW revision 0xa  
    [MCU2_0]      4.290387 s: SCICLIENT: DMSC FW ABI revision 4.0
    [MCU2_0]      4.290415 s: SCICLIENT: Init ... Done !!!
    [MCU2_0]      4.290438 s: UDMA: Init ... !!!
    [MCU2_0]      4.291563 s: UDMA: Init ... Done !!!
    [MCU2_0]      4.291622 s: MEM: Init ... !!!
    [MCU2_0]      4.291657 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ d9000000 of size 15728640 bytes !!!
    [MCU2_0]      4.291712 s: MEM: Created heap (L3_MEM, id=1, flags=0x00000000) @ 3600000 of size 262144 bytes !!!
    [MCU2_0]      4.291757 s: MEM: Created heap (DDR_CACHE_WT_MEM, id=7, flags=0x00000000) @ d9f00000 of size 1048576 bytes !!!
    [MCU2_0]      4.291817 s: MEM: Init ... Done !!!
    [MCU2_0]      4.291838 s: IPC: Init ... !!!
    [MCU2_0]      4.291882 s: IPC: 6 CPUs participating in IPC !!!
    [MCU2_0]      4.291918 s: IPC: Waiting for HLOS to be ready ... !!!
    [MCU2_0]     18.652513 s: IPC: HLOS is ready !!!
    [MCU2_0]     18.657001 s: IPC: Init ... Done !!!
    [MCU2_0]     18.657063 s: APP: Syncing with 5 CPUs ... !!!
    [MCU2_0]     21.353825 s: APP: Syncing with 5 CPUs ... Done !!!
    [MCU2_0]     21.353942 s: REMOTE_SERVICE: Init ... !!!
    [MCU2_0]     21.354268 s: REMOTE_SERVICE: Init ... Done !!!
    [MCU2_0]     21.354320 s: FVID2: Init ... !!!
    [MCU2_0]     21.354394 s: FVID2: Init ... Done !!!
    [MCU2_0]     21.354429 s: VHWA: VPAC Init ... !!!
    [MCU2_0]     21.354458 s: SCICLIENT: Sciclient_pmSetModuleState module=290 state=2
    [MCU2_0]     21.354644 s: SCICLIENT: Sciclient_pmSetModuleState success
    [MCU2_0]     21.354680 s: VHWA: LDC Init ... !!!
    [MCU2_0]     21.361496 s: VHWA: LDC Init ... Done !!!
    [MCU2_0]     21.361556 s: VHWA: MSC Init ... !!!
    [MCU2_0]     21.373940 s: VHWA: MSC Init ... Done !!!
    [MCU2_0]     21.374000 s: VHWA: NF Init ... !!!
    [MCU2_0]     21.375793 s: VHWA: NF Init ... Done !!!
    [MCU2_0]     21.375853 s: VHWA: VISS Init ... !!!
    [MCU2_0]     21.385123 s: VHWA: VISS Init ... Done !!!
    [MCU2_0]     21.385183 s: VHWA: VPAC Init ... Done !!!
    [MCU2_0]     21.385227 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [MCU2_0]     21.385264 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [MCU2_0]     21.385295 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [MCU2_0]     21.386526 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target MCU2-0
    [MCU2_0]     21.386632 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target MCU2-0
    [MCU2_0]     21.386706 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target MCU2-0
    [MCU2_0]     21.386789 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target MCU2-0
    [MCU2_0]     21.386866 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target MCU2-0
    [MCU2_0]     21.386939 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target MCU2-0
    [MCU2_0]     21.387015 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target MCU2-0
    [MCU2_0]     21.387089 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target MCU2-0
    [MCU2_0]     21.387164 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target MCU2-0
    [MCU2_0]     21.387237 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target MCU2-0
    [MCU2_0]     21.387311 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target MCU2-0
    [MCU2_0]     21.387383 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target MCU2-0
    [MCU2_0]     21.387453 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target MCU2-0
    [MCU2_0]     21.387523 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target MCU2-0
    [MCU2_0]     21.387594 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.cmd_timeout_test on target MCU2-0
    [MCU2_0]     21.387666 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target MCU2-0
    [MCU2_0]     21.387870 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target MCU2-0 
    [MCU2_0]     21.388026 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_NF 
    [MCU2_0]     21.388164 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_LDC1 
    [MCU2_0]     21.388313 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_MSC1 
    [MCU2_0]     21.388454 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_MSC2 
    [MCU2_0]     21.388675 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_VISS1 
    [MCU2_0]     21.388868 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE1 
    [MCU2_0]     21.389045 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE2 
    [MCU2_0]     21.389220 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE3 
    [MCU2_0]     21.389383 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE4 
    [MCU2_0]     21.389556 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE5 
    [MCU2_0]     21.389722 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE6 
    [MCU2_0]     21.389923 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE7 
    [MCU2_0]     21.390098 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE8 
    [MCU2_0]     21.390280 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DISPLAY1 
    [MCU2_0]     21.390457 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DISPLAY2 
    [MCU2_0]     21.390624 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CSITX 
    [MCU2_0]     21.390782 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M1 
    [MCU2_0]     21.390928 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M2 
    [MCU2_0]     21.391078 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M3 
    [MCU2_0]     21.391229 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M4 
    [MCU2_0]     21.391277 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [MCU2_0]     21.391316 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [MCU2_0]     21.391343 s: APP: OpenVX Target kernel init ... !!!
    [MCU2_0]     21.406238 s: APP: OpenVX Target kernel init ... Done !!!
    [MCU2_0]     21.406290 s: VISS REMOTE SERVICE: Init ... !!!
    [MCU2_0]     21.406364 s: VISS REMOTE SERVICE: Init ... Done !!!
    [MCU2_0]     21.406394 s: UDMA Copy: Init ... !!!
    [MCU2_0]     21.407918 s: UDMA Copy: Init ... Done !!!
    [MCU2_0]     21.407976 s: APP: Init ... Done !!!
    [MCU2_0]     21.408004 s: APP: Run ... !!!
    [MCU2_0]     21.408025 s: IPC: Starting echo test ...
    [MCU2_0]     21.408261 s: APP: Run ... Done !!!
    [MCU2_0]     21.409461 s: IPC: Echo status: mpu1_0[x] mcu2_0[s] mcu2_1[.] C66X_1[P] C66X_2[.] C7X_1[.] 
    [MCU2_0]     21.409553 s: IPC: Echo status: mpu1_0[x] mcu2_0[s] mcu2_1[P] C66X_1[P] C66X_2[.] C7X_1[.] 
    [MCU2_0]     21.409628 s: IPC: Echo status: mpu1_0[x] mcu2_0[s] mcu2_1[P] C66X_1[P] C66X_2[P] C7X_1[.] 
    [MCU2_0]     21.409691 s: IPC: Echo status: mpu1_0[x] mcu2_0[s] mcu2_1[P] C66X_1[P] C66X_2[P] C7X_1[P] 
    [MCU2_1]      4.401126 s: CIO: Init ... Done !!!
    [MCU2_1]      4.401199 s: ### CPU Frequency = 1000000000 Hz
    [MCU2_1]      4.401237 s: CPU is running FreeRTOS
    [MCU2_1]      4.401259 s: APP: Init ... !!!
    [MCU2_1]      4.401278 s: SCICLIENT: Init ... !!!
    [MCU2_1]      4.401483 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [MCU2_1]      4.401521 s: SCICLIENT: DMSC FW revision 0xa  
    [MCU2_1]      4.401547 s: SCICLIENT: DMSC FW ABI revision 4.0
    [MCU2_1]      4.401571 s: SCICLIENT: Init ... Done !!!
    [MCU2_1]      4.401593 s: UDMA: Init ... !!!
    [MCU2_1]      4.402802 s: UDMA: Init ... Done !!!
    [MCU2_1]      4.402860 s: MEM: Init ... !!!
    [MCU2_1]      4.402900 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ da000000 of size 16777216 bytes !!!
    [MCU2_1]      4.402968 s: MEM: Init ... Done !!!
    [MCU2_1]      4.402998 s: IPC: Init ... !!!
    [MCU2_1]      4.403046 s: IPC: 6 CPUs participating in IPC !!!
    [MCU2_1]      4.403087 s: IPC: Waiting for HLOS to be ready ... !!!
    [MCU2_1]     18.761144 s: IPC: HLOS is ready !!!
    [MCU2_1]     18.765518 s: IPC: Init ... Done !!!
    [MCU2_1]     18.765585 s: APP: Syncing with 5 CPUs ... !!!
    [MCU2_1]     21.353825 s: APP: Syncing with 5 CPUs ... Done !!!
    [MCU2_1]     21.353967 s: REMOTE_SERVICE: Init ... !!!
    [MCU2_1]     21.354318 s: REMOTE_SERVICE: Init ... Done !!!
    [MCU2_1]     21.354397 s: FVID2: Init ... !!!
    [MCU2_1]     21.354481 s: FVID2: Init ... Done !!!
    [MCU2_1]     21.354512 s: VHWA: DMPAC: Init ... !!!
    [MCU2_1]     21.354535 s: SCICLIENT: Sciclient_pmSetModuleState module=48 state=2
    [MCU2_1]     21.354744 s: SCICLIENT: Sciclient_pmSetModuleState success
    [MCU2_1]     21.354779 s: SCICLIENT: Sciclient_pmSetModuleState module=305 state=2
    [MCU2_1]     21.354894 s: SCICLIENT: Sciclient_pmSetModuleState success
    [MCU2_1]     21.354923 s: VHWA: DOF Init ... !!!
    [MCU2_1]     21.365325 s: VHWA: DOF Init ... Done !!!
    [MCU2_1]     21.365391 s: VHWA: SDE Init ... !!!
    [MCU2_1]     21.369007 s: VHWA: SDE Init ... Done !!!
    [MCU2_1]     21.369063 s: VHWA: DMPAC: Init ... Done !!!
    [MCU2_1]     21.369105 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [MCU2_1]     21.369141 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [MCU2_1]     21.369172 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [MCU2_1]     21.370400 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target MCU2-1
    [MCU2_1]     21.370523 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target MCU2-1
    [MCU2_1]     21.370605 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target MCU2-1
    [MCU2_1]     21.370678 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target MCU2-1
    [MCU2_1]     21.370748 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target MCU2-1
    [MCU2_1]     21.370819 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target MCU2-1
    [MCU2_1]     21.370892 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target MCU2-1
    [MCU2_1]     21.370980 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target MCU2-1
    [MCU2_1]     21.371061 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target MCU2-1
    [MCU2_1]     21.371135 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target MCU2-1
    [MCU2_1]     21.371208 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target MCU2-1
    [MCU2_1]     21.371281 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target MCU2-1
    [MCU2_1]     21.371351 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target MCU2-1
    [MCU2_1]     21.371426 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target MCU2-1
    [MCU2_1]     21.371498 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.cmd_timeout_test on target MCU2-1
    [MCU2_1]     21.371572 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target MCU2-1
    [MCU2_1]     21.371784 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target MCU2-1 
    [MCU2_1]     21.371963 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DMPAC_SDE 
    [MCU2_1]     21.372125 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DMPAC_DOF 
    [MCU2_1]     21.372175 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [MCU2_1]     21.372211 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [MCU2_1]     21.372237 s: APP: OpenVX Target kernel init ... !!!
    [MCU2_1]     21.372504 s: APP: OpenVX Target kernel init ... Done !!!
    [MCU2_1]     21.372541 s: UDMA Copy: Init ... !!!
    [MCU2_1]     21.374761 s: UDMA Copy: Init ... Done !!!
    [MCU2_1]     21.374830 s: APP: Init ... Done !!!
    [MCU2_1]     21.374859 s: APP: Run ... !!!
    [MCU2_1]     21.374880 s: IPC: Starting echo test ...
    [MCU2_1]     21.375122 s: APP: Run ... Done !!!
    [MCU2_1]     21.376148 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[s] C66X_1[P] C66X_2[.] C7X_1[.] 
    [MCU2_1]     21.376244 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[s] C66X_1[P] C66X_2[P] C7X_1[.] 
    [MCU2_1]     21.376322 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[s] C66X_1[P] C66X_2[P] C7X_1[P] 
    [MCU2_1]     21.409372 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[s] C66X_1[P] C66X_2[P] C7X_1[P] 
    [C6x_1 ]      4.642294 s: CIO: Init ... Done !!!
    [C6x_1 ]      4.642319 s: ### CPU Frequency = 1350000000 Hz
    [C6x_1 ]      4.642330 s: CPU is running FreeRTOS
    [C6x_1 ]      4.642338 s: APP: Init ... !!!
    [C6x_1 ]      4.642345 s: SCICLIENT: Init ... !!!
    [C6x_1 ]      4.642526 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [C6x_1 ]      4.642538 s: SCICLIENT: DMSC FW revision 0xa  
    [C6x_1 ]      4.642547 s: SCICLIENT: DMSC FW ABI revision 4.0
    [C6x_1 ]      4.642557 s: SCICLIENT: Init ... Done !!!
    [C6x_1 ]      4.642566 s: UDMA: Init ... !!!
    [C6x_1 ]      4.643888 s: UDMA: Init ... Done !!!
    [C6x_1 ]      4.643908 s: MEM: Init ... !!!
    [C6x_1 ]      4.643921 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ dc000000 of size 16777216 bytes !!!
    [C6x_1 ]      4.643940 s: MEM: Init ... Done !!!
    [C6x_1 ]      4.643948 s: IPC: Init ... !!!
    [C6x_1 ]      4.643970 s: IPC: 6 CPUs participating in IPC !!!
    [C6x_1 ]      4.643987 s: IPC: Waiting for HLOS to be ready ... !!!
    [C6x_1 ]     21.106017 s: IPC: HLOS is ready !!!
    [C6x_1 ]     21.109608 s: IPC: Init ... Done !!!
    [C6x_1 ]     21.109639 s: APP: Syncing with 5 CPUs ... !!!
    [C6x_1 ]     21.353822 s: APP: Syncing with 5 CPUs ... Done !!!
    [C6x_1 ]     21.353835 s: REMOTE_SERVICE: Init ... !!!
    [C6x_1 ]     21.354248 s: REMOTE_SERVICE: Init ... Done !!!
    [C6x_1 ]     21.354283 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [C6x_1 ]     21.354298 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [C6x_1 ]     21.354311 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [C6x_1 ]     21.354906 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel vx_tutorial_graph.phase_rgb on target DSP-1
    [C6x_1 ]     21.354947 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target DSP-1
    [C6x_1 ]     21.354978 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target DSP-1
    [C6x_1 ]     21.355009 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target DSP-1
    [C6x_1 ]     21.355040 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target DSP-1
    [C6x_1 ]     21.355077 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target DSP-1
    [C6x_1 ]     21.355109 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target DSP-1
    [C6x_1 ]     21.355144 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target DSP-1
    [C6x_1 ]     21.355183 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target DSP-1
    [C6x_1 ]     21.355218 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target DSP-1
    [C6x_1 ]     21.355251 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target DSP-1
    [C6x_1 ]     21.355284 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target DSP-1
    [C6x_1 ]     21.355316 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target DSP-1
    [C6x_1 ]     21.355350 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-1
    [C6x_1 ]     21.355383 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target DSP-1
    [C6x_1 ]     21.355414 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-1
    [C6x_1 ]     21.355447 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target DSP-1
    [C6x_1 ]     21.355681 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [C6x_1 ]     21.355704 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [C6x_1 ]     21.355714 s: APP: OpenVX Target kernel init ... !!!
    [C6x_1 ]     21.356085 s: APP: OpenVX Target kernel init ... Done !!!
    [C6x_1 ]     21.356111 s: UDMA Copy: Init ... !!!
    [C6x_1 ]     21.360366 s: UDMA Copy: Init ... Done !!!
    [C6x_1 ]     21.360385 s: APP: Init ... Done !!!
    [C6x_1 ]     21.360394 s: APP: Run ... !!!
    [C6x_1 ]     21.360403 s: IPC: Starting echo test ...
    [C6x_1 ]     21.360918 s: APP: Run ... Done !!!
    [C6x_1 ]     21.361231 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[s] C66X_2[x] C7X_1[P] 
    [C6x_1 ]     21.361470 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[s] C66X_2[P] C7X_1[P] 
    [C6x_1 ]     21.375892 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] C66X_1[s] C66X_2[P] C7X_1[P] 
    [C6x_1 ]     21.409261 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[P] C66X_1[s] C66X_2[P] C7X_1[P] 
    [C6x_2 ]      4.785163 s: CIO: Init ... Done !!!
    [C6x_2 ]      4.785190 s: ### CPU Frequency = 1350000000 Hz
    [C6x_2 ]      4.785201 s: CPU is running FreeRTOS
    [C6x_2 ]      4.785210 s: APP: Init ... !!!
    [C6x_2 ]      4.785218 s: SCICLIENT: Init ... !!!
    [C6x_2 ]      4.785404 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [C6x_2 ]      4.785417 s: SCICLIENT: DMSC FW revision 0xa  
    [C6x_2 ]      4.785427 s: SCICLIENT: DMSC FW ABI revision 4.0
    [C6x_2 ]      4.785438 s: SCICLIENT: Init ... Done !!!
    [C6x_2 ]      4.785448 s: UDMA: Init ... !!!
    [C6x_2 ]      4.786782 s: UDMA: Init ... Done !!!
    [C6x_2 ]      4.786803 s: MEM: Init ... !!!
    [C6x_2 ]      4.786816 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ e0000000 of size 16777216 bytes !!!
    [C6x_2 ]      4.786836 s: MEM: Init ... Done !!!
    [C6x_2 ]      4.786844 s: IPC: Init ... !!!
    [C6x_2 ]      4.786868 s: IPC: 6 CPUs participating in IPC !!!
    [C6x_2 ]      4.786885 s: IPC: Waiting for HLOS to be ready ... !!!
    [C6x_2 ]     21.209980 s: IPC: HLOS is ready !!!
    [C6x_2 ]     21.213427 s: IPC: Init ... Done !!!
    [C6x_2 ]     21.213455 s: APP: Syncing with 5 CPUs ... !!!
    [C6x_2 ]     21.353823 s: APP: Syncing with 5 CPUs ... Done !!!
    [C6x_2 ]     21.353836 s: REMOTE_SERVICE: Init ... !!!
    [C6x_2 ]     21.354273 s: REMOTE_SERVICE: Init ... Done !!!
    [C6x_2 ]     21.354309 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [C6x_2 ]     21.354324 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [C6x_2 ]     21.354337 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [C6x_2 ]     21.354934 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel vx_tutorial_graph.phase_rgb on target DSP-2
    [C6x_2 ]     21.354971 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target DSP-2
    [C6x_2 ]     21.355004 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target DSP-2
    [C6x_2 ]     21.355039 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target DSP-2
    [C6x_2 ]     21.355074 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target DSP-2
    [C6x_2 ]     21.355107 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target DSP-2
    [C6x_2 ]     21.355142 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target DSP-2
    [C6x_2 ]     21.355175 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target DSP-2
    [C6x_2 ]     21.355210 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target DSP-2
    [C6x_2 ]     21.355242 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target DSP-2
    [C6x_2 ]     21.355278 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target DSP-2
    [C6x_2 ]     21.355310 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target DSP-2
    [C6x_2 ]     21.355347 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target DSP-2
    [C6x_2 ]     21.355380 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-2
    [C6x_2 ]     21.355412 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target DSP-2
    [C6x_2 ]     21.355444 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-2
    [C6x_2 ]     21.355476 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target DSP-2
    [C6x_2 ]     21.355724 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [C6x_2 ]     21.355742 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [C6x_2 ]     21.355752 s: APP: OpenVX Target kernel init ... !!!
    [C6x_2 ]     21.356127 s: APP: OpenVX Target kernel init ... Done !!!
    [C6x_2 ]     21.356153 s: UDMA Copy: Init ... !!!
    [C6x_2 ]     21.360483 s: UDMA Copy: Init ... Done !!!
    [C6x_2 ]     21.360503 s: APP: Init ... Done !!!
    [C6x_2 ]     21.360512 s: APP: Run ... !!!
    [C6x_2 ]     21.360520 s: IPC: Starting echo test ...
    [C6x_2 ]     21.361118 s: APP: Run ... Done !!!
    [C6x_2 ]     21.361469 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[.] 
    [C6x_2 ]     21.361508 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[P] 
    [C6x_2 ]     21.375916 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] C66X_1[P] C66X_2[s] C7X_1[P] 
    [C6x_2 ]     21.409281 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[P] C66X_1[P] C66X_2[s] C7X_1[P] 
    [C7x_1 ]      5.178194 s: CIO: Init ... Done !!!
    [C7x_1 ]      5.178208 s: ### CPU Frequency = 1000000000 Hz
    [C7x_1 ]      5.178221 s: CPU is running FreeRTOS
    [C7x_1 ]      5.178229 s: APP: Init ... !!!
    [C7x_1 ]      5.178237 s: SCICLIENT: Init ... !!!
    [C7x_1 ]      5.178433 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [C7x_1 ]      5.178448 s: SCICLIENT: DMSC FW revision 0xa  
    [C7x_1 ]      5.178458 s: SCICLIENT: DMSC FW ABI revision 4.0
    [C7x_1 ]      5.178470 s: SCICLIENT: Init ... Done !!!
    [C7x_1 ]      5.178479 s: UDMA: Init ... !!!
    [C7x_1 ]      5.179487 s: UDMA: Init ... Done !!!
    [C7x_1 ]      5.179500 s: MEM: Init ... !!!
    [C7x_1 ]      5.179511 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ 117000000 of size 268435456 bytes !!!
    [C7x_1 ]      5.179533 s: MEM: Init ... Done !!!
    [C7x_1 ]      5.179543 s: IPC: Init ... !!!
    [C7x_1 ]      5.179557 s: IPC: 6 CPUs participating in IPC !!!
    [C7x_1 ]      5.179571 s: IPC: Waiting for HLOS to be ready ... !!!
    [C7x_1 ]     21.351832 s: IPC: HLOS is ready !!!
    [C7x_1 ]     21.353793 s: IPC: Init ... Done !!!
    [C7x_1 ]     21.353808 s: APP: Syncing with 5 CPUs ... !!!
    [C7x_1 ]     21.353823 s: APP: Syncing with 5 CPUs ... Done !!!
    [C7x_1 ]     21.353834 s: REMOTE_SERVICE: Init ... !!!
    [C7x_1 ]     21.353969 s: REMOTE_SERVICE: Init ... Done !!!
    [C7x_1 ]     21.353992 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [C7x_1 ]     21.354008 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [C7x_1 ]     21.354023 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [C7x_1 ]     21.354209 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target DSP_C7-1
    [C7x_1 ]     21.354271 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target DSP_C7-1
    [C7x_1 ]     21.354310 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target DSP_C7-1
    [C7x_1 ]     21.354347 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target DSP_C7-1
    [C7x_1 ]     21.354383 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target DSP_C7-1
    [C7x_1 ]     21.354421 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target DSP_C7-1
    [C7x_1 ]     21.354460 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target DSP_C7-1
    [C7x_1 ]     21.354497 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target DSP_C7-1
    [C7x_1 ]     21.354535 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target DSP_C7-1
    [C7x_1 ]     21.354573 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target DSP_C7-1
    [C7x_1 ]     21.354609 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target DSP_C7-1
    [C7x_1 ]     21.354644 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target DSP_C7-1
    [C7x_1 ]     21.354680 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP_C7-1
    [C7x_1 ]     21.354716 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target DSP_C7-1
    [C7x_1 ]     21.354752 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP_C7-1
    [C7x_1 ]     21.354787 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target DSP_C7-1
    [C7x_1 ]     21.354872 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1 
    [C7x_1 ]     21.354940 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_2 
    [C7x_1 ]     21.355009 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_3 
    [C7x_1 ]     21.355077 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_4 
    [C7x_1 ]     21.355155 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_5 
    [C7x_1 ]     21.355222 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_6 
    [C7x_1 ]     21.355287 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_7 
    [C7x_1 ]     21.355356 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_8 
    [C7x_1 ]     21.355378 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [C7x_1 ]     21.355395 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [C7x_1 ]     21.355406 s: APP: OpenVX Target kernel init ... !!!
    [C7x_1 ]     21.355580 s: APP: OpenVX Target kernel init ... Done !!!
    [C7x_1 ]     21.355593 s: APP: Init ... Done !!!
    [C7x_1 ]     21.355603 s: APP: Run ... !!!
    [C7x_1 ]     21.355611 s: IPC: Starting echo test ...
    [C7x_1 ]     21.355703 s: APP: Run ... Done !!!
    [C7x_1 ]     21.361223 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[x] C7X_1[s] 
    [C7x_1 ]     21.361462 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[P] C7X_1[s] 
    [C7x_1 ]     21.375938 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] C66X_1[P] C66X_2[P] C7X_1[s] 
    [C7x_1 ]     21.409318 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[P] C66X_1[P] C66X_2[P] C7X_1[s] 
    
    
    trace_edge_1280_with_remote_log_out.log
    root@tda4vm-sk:~/workspace/sde-test# source /opt/vision_apps/vision_apps_init.sh 
    root@tda4vm-sk:~/workspace/sde-test# [MCU2_0]      4.329627 s: CIO: Init ... Done !!!
    [MCU2_0]      4.329697 s: ### CPU Frequency = 1000000000 Hz
    [MCU2_0]      4.329735 s: CPU is running FreeRTOS
    [MCU2_0]      4.329757 s: APP: Init ... !!!
    [MCU2_0]      4.329776 s: SCICLIENT: Init ... !!!
    [MCU2_0]      4.329989 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [MCU2_0]      4.330031 s: SCICLIENT: DMSC FW revision 0xa  
    [MCU2_0]      4.330058 s: SCICLIENT: DMSC FW ABI revision 4.0
    [MCU2_0]      4.330085 s: SCICLIENT: Init ... Done !!!
    [MCU2_0]      4.330108 s: UDMA: Init ... !!!
    [MCU2_0]      4.331244 s: UDMA: Init ... Done !!!
    [MCU2_0]      4.331303 s: MEM: Init ... !!!
    [MCU2_0]      4.331345 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ d9000000 of size 15728640 bytes !!!
    [MCU2_0]      4.331402 s: MEM: Created heap (L3_MEM, id=1, flags=0x00000000) @ 3600000 of size 262144 bytes !!!
    [MCU2_0]      4.331462 s: MEM: Created heap (DDR_CACHE_WT_MEM, id=7, flags=0x00000000) @ d9f00000 of size 1048576 bytes !!!
    [MCU2_0]      4.331508 s: MEM: Init ... Done !!!
    [MCU2_0]      4.331530 s: IPC: Init ... !!!
    [MCU2_0]      4.331573 s: IPC: 6 CPUs participating in IPC !!!
    [MCU2_0]      4.331609 s: IPC: Waiting for HLOS to be ready ... !!!
    [MCU2_0]     22.165230 s: IPC: HLOS is ready !!!
    [MCU2_0]     22.169812 s: IPC: Init ... Done !!!
    [MCU2_0]     22.169878 s: APP: Syncing with 5 CPUs ... !!!
    [MCU2_0]     24.449577 s: APP: Syncing with 5 CPUs ... Done !!!
    [MCU2_0]     24.449627 s: REMOTE_SERVICE: Init ... !!!
    [MCU2_0]     24.450012 s: REMOTE_SERVICE: Init ... Done !!!
    [MCU2_0]     24.450072 s: FVID2: Init ... !!!
    [MCU2_0]     24.450137 s: FVID2: Init ... Done !!!
    [MCU2_0]     24.450176 s: VHWA: VPAC Init ... !!!
    [MCU2_0]     24.450199 s: SCICLIENT: Sciclient_pmSetModuleState module=290 state=2
    [MCU2_0]     24.450391 s: SCICLIENT: Sciclient_pmSetModuleState success
    [MCU2_0]     24.450426 s: VHWA: LDC Init ... !!!
    [MCU2_0]     24.457221 s: VHWA: LDC Init ... Done !!!
    [MCU2_0]     24.457281 s: VHWA: MSC Init ... !!!
    [MCU2_0]     24.469143 s: VHWA: MSC Init ... Done !!!
    [MCU2_0]     24.469199 s: VHWA: NF Init ... !!!
    [MCU2_0]     24.470735 s: VHWA: NF Init ... Done !!!
    [MCU2_0]     24.470788 s: VHWA: VISS Init ... !!!
    [MCU2_0]     24.480089 s: VHWA: VISS Init ... Done !!!
    [MCU2_0]     24.480152 s: VHWA: VPAC Init ... Done !!!
    [MCU2_0]     24.480196 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [MCU2_0]     24.480232 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [MCU2_0]     24.480264 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [MCU2_0]     24.481540 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target MCU2-0
    [MCU2_0]     24.481649 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target MCU2-0
    [MCU2_0]     24.481728 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target MCU2-0
    [MCU2_0]     24.481800 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target MCU2-0
    [MCU2_0]     24.481872 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target MCU2-0
    [MCU2_0]     24.481946 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target MCU2-0
    [MCU2_0]     24.482023 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target MCU2-0
    [MCU2_0]     24.482099 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target MCU2-0
    [MCU2_0]     24.482172 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target MCU2-0
    [MCU2_0]     24.482245 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target MCU2-0
    [MCU2_0]     24.482319 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target MCU2-0
    [MCU2_0]     24.482391 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target MCU2-0
    [MCU2_0]     24.482474 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target MCU2-0
    [MCU2_0]     24.482548 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target MCU2-0
    [MCU2_0]     24.482624 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.cmd_timeout_test on target MCU2-0
    [MCU2_0]     24.482699 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target MCU2-0
    [MCU2_0]     24.482902 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target MCU2-0 
    [MCU2_0]     24.483063 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_NF 
    [MCU2_0]     24.483206 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_LDC1 
    [MCU2_0]     24.483346 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_MSC1 
    [MCU2_0]     24.483497 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_MSC2 
    [MCU2_0]     24.483721 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target VPAC_VISS1 
    [MCU2_0]     24.483919 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE1 
    [MCU2_0]     24.484100 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE2 
    [MCU2_0]     24.484292 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE3 
    [MCU2_0]     24.484484 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE4 
    [MCU2_0]     24.484665 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE5 
    [MCU2_0]     24.484845 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE6 
    [MCU2_0]     24.485032 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE7 
    [MCU2_0]     24.485221 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CAPTURE8 
    [MCU2_0]     24.485416 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DISPLAY1 
    [MCU2_0]     24.485615 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DISPLAY2 
    [MCU2_0]     24.485782 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target CSITX 
    [MCU2_0]     24.485934 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M1 
    [MCU2_0]     24.486085 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M2 
    [MCU2_0]     24.486238 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M3 
    [MCU2_0]     24.486383 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSS_M2M4 
    [MCU2_0]     24.486440 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [MCU2_0]     24.486480 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [MCU2_0]     24.486508 s: APP: OpenVX Target kernel init ... !!!
    [MCU2_0]     24.501686 s: APP: OpenVX Target kernel init ... Done !!!
    [MCU2_0]     24.501738 s: VISS REMOTE SERVICE: Init ... !!!
    [MCU2_0]     24.501808 s: VISS REMOTE SERVICE: Init ... Done !!!
    [MCU2_0]     24.501838 s: UDMA Copy: Init ... !!!
    [MCU2_0]     24.503413 s: UDMA Copy: Init ... Done !!!
    [MCU2_0]     24.503486 s: APP: Init ... Done !!!
    [MCU2_0]     24.503515 s: APP: Run ... !!!
    [MCU2_0]     24.503537 s: IPC: Starting echo test ...
    [MCU2_0]     24.503801 s: APP: Run ... Done !!!
    [MCU2_0]     24.504856 s: IPC: Echo status: mpu1_0[x] mcu2_0[s] mcu2_1[x] C66X_1[P] C66X_2[.] C7X_1[.] 
    [MCU2_0]     24.504946 s: IPC: Echo status: mpu1_0[x] mcu2_0[s] mcu2_1[x] C66X_1[P] C66X_2[P] C7X_1[.] 
    [MCU2_0]     24.505021 s: IPC: Echo status: mpu1_0[x] mcu2_0[s] mcu2_1[x] C66X_1[P] C66X_2[P] C7X_1[P] 
    [MCU2_1]      4.440601 s: CIO: Init ... Done !!!
    [MCU2_1]      4.440671 s: ### CPU Frequency = 1000000000 Hz
    [MCU2_1]      4.440709 s: CPU is running FreeRTOS
    [MCU2_1]      4.440734 s: APP: Init ... !!!
    [MCU2_1]      4.440755 s: SCICLIENT: Init ... !!!
    [MCU2_1]      4.440962 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [MCU2_1]      4.441003 s: SCICLIENT: DMSC FW revision 0xa  
    [MCU2_1]      4.441029 s: SCICLIENT: DMSC FW ABI revision 4.0
    [MCU2_1]      4.441054 s: SCICLIENT: Init ... Done !!!
    [MCU2_1]      4.441076 s: UDMA: Init ... !!!
    [MCU2_1]      4.442304 s: UDMA: Init ... Done !!!
    [MCU2_1]      4.442366 s: MEM: Init ... !!!
    [MCU2_1]      4.442416 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ da000000 of size 16777216 bytes !!!
    [MCU2_1]      4.442483 s: MEM: Init ... Done !!!
    [MCU2_1]      4.442508 s: IPC: Init ... !!!
    [MCU2_1]      4.442556 s: IPC: 6 CPUs participating in IPC !!!
    [MCU2_1]      4.442595 s: IPC: Waiting for HLOS to be ready ... !!!
    [MCU2_1]     22.170265 s: IPC: HLOS is ready !!!
    [MCU2_1]     22.174769 s: IPC: Init ... Done !!!
    [MCU2_1]     22.174835 s: APP: Syncing with 5 CPUs ... !!!
    [MCU2_1]     24.449576 s: APP: Syncing with 5 CPUs ... Done !!!
    [MCU2_1]     24.449696 s: REMOTE_SERVICE: Init ... !!!
    [MCU2_1]     24.450077 s: REMOTE_SERVICE: Init ... Done !!!
    [MCU2_1]     24.450146 s: FVID2: Init ... !!!
    [MCU2_1]     24.450232 s: FVID2: Init ... Done !!!
    [MCU2_1]     24.450264 s: VHWA: DMPAC: Init ... !!!
    [MCU2_1]     24.450291 s: SCICLIENT: Sciclient_pmSetModuleState module=48 state=2
    [MCU2_1]     24.450488 s: SCICLIENT: Sciclient_pmSetModuleState success
    [MCU2_1]     24.450527 s: SCICLIENT: Sciclient_pmSetModuleState module=305 state=2
    [MCU2_1]     24.450662 s: SCICLIENT: Sciclient_pmSetModuleState success
    [MCU2_1]     24.450696 s: VHWA: DOF Init ... !!!
    [MCU2_1]     24.461187 s: VHWA: DOF Init ... Done !!!
    [MCU2_1]     24.461253 s: VHWA: SDE Init ... !!!
    [MCU2_1]     24.464700 s: VHWA: ERROR: SDE SL2 Alloc Failed !!!
    [MCU2_1]     24.464764 s: VHWA: DMPAC: Init ... Done !!!
    [C6x_1 ]      4.680776 s: CIO: Init ... Done !!!
    [C6x_1 ]      4.680803 s: ### CPU Frequency = 1350000000 Hz
    [C6x_1 ]      4.680813 s: CPU is running FreeRTOS
    [C6x_1 ]      4.680822 s: APP: Init ... !!!
    [C6x_1 ]      4.680829 s: SCICLIENT: Init ... !!!
    [C6x_1 ]      4.681008 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [C6x_1 ]      4.681020 s: SCICLIENT: DMSC FW revision 0xa  
    [C6x_1 ]      4.681030 s: SCICLIENT: DMSC FW ABI revision 4.0
    [C6x_1 ]      4.681040 s: SCICLIENT: Init ... Done !!!
    [C6x_1 ]      4.681049 s: UDMA: Init ... !!!
    [C6x_1 ]      4.682408 s: UDMA: Init ... Done !!!
    [C6x_1 ]      4.682427 s: MEM: Init ... !!!
    [C6x_1 ]      4.682440 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ dc000000 of size 16777216 bytes !!!
    [C6x_1 ]      4.682459 s: MEM: Init ... Done !!!
    [C6x_1 ]      4.682468 s: IPC: Init ... !!!
    [C6x_1 ]      4.682490 s: IPC: 6 CPUs participating in IPC !!!
    [C6x_1 ]      4.682506 s: IPC: Waiting for HLOS to be ready ... !!!
    [C6x_1 ]     24.446034 s: IPC: HLOS is ready !!!
    [C6x_1 ]     24.449528 s: IPC: Init ... Done !!!
    [C6x_1 ]     24.449557 s: APP: Syncing with 5 CPUs ... !!!
    [C6x_1 ]     24.449574 s: APP: Syncing with 5 CPUs ... Done !!!
    [C6x_1 ]     24.449586 s: REMOTE_SERVICE: Init ... !!!
    [C6x_1 ]     24.450028 s: REMOTE_SERVICE: Init ... Done !!!
    [C6x_1 ]     24.450066 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [C6x_1 ]     24.450088 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [C6x_1 ]     24.450101 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [C6x_1 ]     24.450697 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel vx_tutorial_graph.phase_rgb on target DSP-1
    [C6x_1 ]     24.450733 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target DSP-1
    [C6x_1 ]     24.450765 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target DSP-1
    [C6x_1 ]     24.450793 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target DSP-1
    [C6x_1 ]     24.450823 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target DSP-1
    [C6x_1 ]     24.450854 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target DSP-1
    [C6x_1 ]     24.450887 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target DSP-1
    [C6x_1 ]     24.450918 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target DSP-1
    [C6x_1 ]     24.450948 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target DSP-1
    [C6x_1 ]     24.450977 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target DSP-1
    [C6x_1 ]     24.451008 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target DSP-1
    [C6x_1 ]     24.451038 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target DSP-1
    [C6x_1 ]     24.451067 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target DSP-1
    [C6x_1 ]     24.451099 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-1
    [C6x_1 ]     24.451128 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target DSP-1
    [C6x_1 ]     24.451158 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-1
    [C6x_1 ]     24.451188 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target DSP-1
    [C6x_1 ]     24.451419 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [C6x_1 ]     24.451441 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [C6x_1 ]     24.451453 s: APP: OpenVX Target kernel init ... !!!
    [C6x_1 ]     24.451828 s: APP: OpenVX Target kernel init ... Done !!!
    [C6x_1 ]     24.451853 s: UDMA Copy: Init ... !!!
    [C6x_1 ]     24.456220 s: UDMA Copy: Init ... Done !!!
    [C6x_1 ]     24.456239 s: APP: Init ... Done !!!
    [C6x_1 ]     24.456248 s: APP: Run ... !!!
    [C6x_1 ]     24.456257 s: IPC: Starting echo test ...
    [C6x_1 ]     24.456840 s: APP: Run ... Done !!!
    [C6x_1 ]     24.457190 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[s] C66X_2[.] C7X_1[P] 
    [C6x_1 ]     24.457223 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[s] C66X_2[P] C7X_1[P] 
    [C6x_1 ]     24.504651 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[x] C66X_1[s] C66X_2[P] C7X_1[P] 
    [C6x_2 ]      4.822816 s: CIO: Init ... Done !!!
    [C6x_2 ]      4.822844 s: ### CPU Frequency = 1350000000 Hz
    [C6x_2 ]      4.822856 s: CPU is running FreeRTOS
    [C6x_2 ]      4.822865 s: APP: Init ... !!!
    [C6x_2 ]      4.822873 s: SCICLIENT: Init ... !!!
    [C6x_2 ]      4.823054 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [C6x_2 ]      4.823067 s: SCICLIENT: DMSC FW revision 0xa  
    [C6x_2 ]      4.823077 s: SCICLIENT: DMSC FW ABI revision 4.0
    [C6x_2 ]      4.823088 s: SCICLIENT: Init ... Done !!!
    [C6x_2 ]      4.823097 s: UDMA: Init ... !!!
    [C6x_2 ]      4.824435 s: UDMA: Init ... Done !!!
    [C6x_2 ]      4.824455 s: MEM: Init ... !!!
    [C6x_2 ]      4.824469 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ e0000000 of size 16777216 bytes !!!
    [C6x_2 ]      4.824488 s: MEM: Init ... Done !!!
    [C6x_2 ]      4.824497 s: IPC: Init ... !!!
    [C6x_2 ]      4.824520 s: IPC: 6 CPUs participating in IPC !!!
    [C6x_2 ]      4.824537 s: IPC: Waiting for HLOS to be ready ... !!!
    [C6x_2 ]     24.243774 s: IPC: HLOS is ready !!!
    [C6x_2 ]     24.247362 s: IPC: Init ... Done !!!
    [C6x_2 ]     24.247394 s: APP: Syncing with 5 CPUs ... !!!
    [C6x_2 ]     24.449575 s: APP: Syncing with 5 CPUs ... Done !!!
    [C6x_2 ]     24.449588 s: REMOTE_SERVICE: Init ... !!!
    [C6x_2 ]     24.450009 s: REMOTE_SERVICE: Init ... Done !!!
    [C6x_2 ]     24.450046 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [C6x_2 ]     24.450062 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [C6x_2 ]     24.450074 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [C6x_2 ]     24.450665 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel vx_tutorial_graph.phase_rgb on target DSP-2
    [C6x_2 ]     24.450711 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target DSP-2
    [C6x_2 ]     24.450741 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target DSP-2
    [C6x_2 ]     24.450771 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target DSP-2
    [C6x_2 ]     24.450800 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target DSP-2
    [C6x_2 ]     24.450830 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target DSP-2
    [C6x_2 ]     24.450861 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target DSP-2
    [C6x_2 ]     24.450893 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target DSP-2
    [C6x_2 ]     24.450923 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target DSP-2
    [C6x_2 ]     24.450955 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target DSP-2
    [C6x_2 ]     24.450985 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target DSP-2
    [C6x_2 ]     24.451016 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target DSP-2
    [C6x_2 ]     24.451045 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target DSP-2
    [C6x_2 ]     24.451076 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-2
    [C6x_2 ]     24.451106 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target DSP-2
    [C6x_2 ]     24.451136 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP-2
    [C6x_2 ]     24.451167 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target DSP-2
    [C6x_2 ]     24.451389 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [C6x_2 ]     24.451407 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [C6x_2 ]     24.451420 s: APP: OpenVX Target kernel init ... !!!
    [C6x_2 ]     24.451804 s: APP: OpenVX Target kernel init ... Done !!!
    [C6x_2 ]     24.451828 s: UDMA Copy: Init ... !!!
    [C6x_2 ]     24.456102 s: UDMA Copy: Init ... Done !!!
    [C6x_2 ]     24.456120 s: APP: Init ... Done !!!
    [C6x_2 ]     24.456128 s: APP: Run ... !!!
    [C6x_2 ]     24.456138 s: IPC: Starting echo test ...
    [C6x_2 ]     24.456645 s: APP: Run ... Done !!!
    [C6x_2 ]     24.457023 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[.] C66X_2[s] C7X_1[P] 
    [C6x_2 ]     24.457188 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[P] 
    [C6x_2 ]     24.504679 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[P] 
    [C7x_1 ]      5.215495 s: CIO: Init ... Done !!!
    [C7x_1 ]      5.215510 s: ### CPU Frequency = 1000000000 Hz
    [C7x_1 ]      5.215523 s: CPU is running FreeRTOS
    [C7x_1 ]      5.215531 s: APP: Init ... !!!
    [C7x_1 ]      5.215539 s: SCICLIENT: Init ... !!!
    [C7x_1 ]      5.215723 s: SCICLIENT: DMSC FW version [10.1.6--v10.01.06 (Fiery Fox)]
    [C7x_1 ]      5.215738 s: SCICLIENT: DMSC FW revision 0xa  
    [C7x_1 ]      5.215748 s: SCICLIENT: DMSC FW ABI revision 4.0
    [C7x_1 ]      5.215760 s: SCICLIENT: Init ... Done !!!
    [C7x_1 ]      5.215770 s: UDMA: Init ... !!!
    [C7x_1 ]      5.216773 s: UDMA: Init ... Done !!!
    [C7x_1 ]      5.216786 s: MEM: Init ... !!!
    [C7x_1 ]      5.216797 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ 117000000 of size 268435456 bytes !!!
    [C7x_1 ]      5.216819 s: MEM: Init ... Done !!!
    [C7x_1 ]      5.216828 s: IPC: Init ... !!!
    [C7x_1 ]      5.216843 s: IPC: 6 CPUs participating in IPC !!!
    [C7x_1 ]      5.216856 s: IPC: Waiting for HLOS to be ready ... !!!
    [C7x_1 ]     24.350117 s: IPC: HLOS is ready !!!
    [C7x_1 ]     24.351990 s: IPC: Init ... Done !!!
    [C7x_1 ]     24.352005 s: APP: Syncing with 5 CPUs ... !!!
    [C7x_1 ]     24.449576 s: APP: Syncing with 5 CPUs ... Done !!!
    [C7x_1 ]     24.449592 s: REMOTE_SERVICE: Init ... !!!
    [C7x_1 ]     24.449708 s: REMOTE_SERVICE: Init ... Done !!!
    [C7x_1 ]     24.449751 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_ERROR
    [C7x_1 ]     24.449768 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_WARNING
    [C7x_1 ]     24.449783 s:  VX_ZONE_INFO: Globally Enabled VX_ZONE_INFO
    [C7x_1 ]     24.449930 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink on target DSP_C7-1
    [C7x_1 ]     24.450020 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source on target DSP_C7-1
    [C7x_1 ]     24.450060 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_sink2 on target DSP_C7-1
    [C7x_1 ]     24.450098 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_source2 on target DSP_C7-1
    [C7x_1 ]     24.450134 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.scalar_intermediate on target DSP_C7-1
    [C7x_1 ]     24.450174 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_intermediate_2 on target DSP_C7-1
    [C7x_1 ]     24.450213 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_error on target DSP_C7-1
    [C7x_1 ]     24.450250 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_source_obj_array on target DSP_C7-1
    [C7x_1 ]     24.450286 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.scalar_sink_obj_array on target DSP_C7-1
    [C7x_1 ]     24.450324 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_intermediate on target DSP_C7-1
    [C7x_1 ]     24.450360 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_source on target DSP_C7-1
    [C7x_1 ]     24.450402 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.pyramid_sink on target DSP_C7-1
    [C7x_1 ]     24.450440 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP_C7-1
    [C7x_1 ]     24.450476 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.capture.image_intermediate on target DSP_C7-1
    [C7x_1 ]     24.450513 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.test_target on target DSP_C7-1
    [C7x_1 ]     24.450548 s:  VX_ZONE_INFO: [ownAddTargetKernelInternal:162] registered kernel com.ti.test_kernels.tiovx_overhead on target DSP_C7-1
    [C7x_1 ]     24.450633 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1 
    [C7x_1 ]     24.450700 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_2 
    [C7x_1 ]     24.450770 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_3 
    [C7x_1 ]     24.450837 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_4 
    [C7x_1 ]     24.450903 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_5 
    [C7x_1 ]     24.450967 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_6 
    [C7x_1 ]     24.451031 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_7 
    [C7x_1 ]     24.451097 s:  VX_ZONE_INFO: [tivxPlatformCreateTargetId:134] Added target DSP_C7-1_PRI_8 
    [C7x_1 ]     24.451120 s:  VX_ZONE_INFO: [tivxInitLocal:126] Initialization Done !!!
    [C7x_1 ]     24.451136 s:  VX_ZONE_INFO: Globally Disabled VX_ZONE_INFO
    [C7x_1 ]     24.451148 s: APP: OpenVX Target kernel init ... !!!
    [C7x_1 ]     24.451320 s: APP: OpenVX Target kernel init ... Done !!!
    [C7x_1 ]     24.451334 s: APP: Init ... Done !!!
    [C7x_1 ]     24.451343 s: APP: Run ... !!!
    [C7x_1 ]     24.451352 s: IPC: Starting echo test ...
    [C7x_1 ]     24.451449 s: APP: Run ... Done !!!
    [C7x_1 ]     24.456995 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[.] C66X_2[P] C7X_1[s] 
    [C7x_1 ]     24.457175 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[P] C7X_1[s] 
    [C7x_1 ]     24.504706 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[x] C66X_1[P] C66X_2[P] C7X_1[s] 
    
    
    0:00:00.000352155  1554     0x2bde99f0 INFO                GST_INIT gst.c:576:init_pre: Initializing GStreamer Core Library version 1.22.12
    0:00:00.000426535  1554     0x2bde99f0 INFO                GST_INIT gst.c:577:init_pre: Using library installed in /usr/lib
    0:00:00.000447650  1554     0x2bde99f0 INFO                GST_INIT gst.c:595:init_pre: Linux tda4vm-sk 6.6.44-ti-01478-g541c20281af7-dirty #1 SMP PREEMPT Thu Nov 14 19:20:24 UTC 2024 aarch64
    0:00:00.000809715  1554     0x2bde99f0 INFO                GST_INIT gstmessage.c:129:_priv_gst_message_initialize: init messages
    0:00:00.001565400  1554     0x2bde99f0 INFO                GST_INIT gstcontext.c:86:_priv_gst_context_initialize: init contexts
    0:00:00.001865355  1554     0x2bde99f0 INFO      GST_PLUGIN_LOADING gstplugin.c:324:_priv_gst_plugin_initialize: registering 0 static plugins
    0:00:00.002003610  1554     0x2bde99f0 INFO      GST_PLUGIN_LOADING gstplugin.c:232:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.002017415  1554     0x2bde99f0 INFO      GST_PLUGIN_LOADING gstplugin.c:234:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.002071155  1554     0x2bde99f0 INFO            GST_REGISTRY gstregistry.c:1871:ensure_current_registry: registry reading and updating done
    0:00:00.005975490  1554     0x2bde99f0 INFO                GST_INIT gst.c:805:init_post: GLib runtime version: 2.78.6
    0:00:00.006006240  1554     0x2bde99f0 INFO                GST_INIT gst.c:807:init_post: GLib headers version: 2.78.6
    0:00:00.006013575  1554     0x2bde99f0 INFO                GST_INIT gst.c:809:init_post: initialized GStreamer successfully
    0:00:00.011417465  1554     0x2bde99f0 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstfrei0r.so" loaded
    0:00:00.049561325  1553     0x2da78290 INFO            GST_REGISTRY gstregistry.c:1804:scan_and_update_registry: Registry cache changed. Writing new registry cache
    0:00:00.049619895  1553     0x2da78290 INFO            GST_REGISTRY gstregistrybinary.c:431:priv_gst_registry_binary_write_cache: Building binary registry cache image
    0:00:00.066127265  1553     0x2da78290 INFO            GST_REGISTRY gstregistrybinary.c:463:priv_gst_registry_binary_write_cache: Writing binary registry cache
    0:00:00.153927585  1553     0x2da78290 INFO            GST_REGISTRY gstregistrybinary.c:314:gst_registry_binary_cache_finish: Wrote binary registry cache
    0:00:00.153975285  1553     0x2da78290 INFO            GST_REGISTRY gstregistry.c:1813:scan_and_update_registry: Registry cache written successfully
    0:00:00.154003220  1553     0x2da78290 INFO            GST_REGISTRY gstregistry.c:1871:ensure_current_registry: registry reading and updating done
    0:00:00.154039415  1553     0x2da78290 INFO                GST_INIT gst.c:805:init_post: GLib runtime version: 2.78.6
    0:00:00.154052295  1553     0x2da78290 INFO                GST_INIT gst.c:807:init_post: GLib headers version: 2.78.6
    0:00:00.154061100  1553     0x2da78290 INFO                GST_INIT gst.c:809:init_post: initialized GStreamer successfully
    0:00:00.154174475  1553     0x2da78290 INFO            GST_PIPELINE gstparse.c:344:gst_parse_launch_full: parsing pipeline description 'filesrc location=./Image/450-1920-1200-L.raw blocksize=2304000 ! rawvideoparse width=1920 height=1200 format=gray8 framerate=1/1 ! videocrop left=320 right=320 top=88 bottom=88 ! capsfilter caps=video/x-raw,\ width=(int)1280,\ height=(int)1024; ! sde.left_sink filesrc location=./Image/450-1920-1200-R.raw blocksize=2304000 ! rawvideoparse width=1920 height=1200 format=gray8 framerate=1/1 ! videocrop left=320 right=320 top=88 bottom=88 ! capsfilter caps=video/x-raw,\ width=(int)1280,\ height=(int)1024; ! sde.right_sink tiovxsde name=sde median-filter-enable=true ! tiovxsdeviz ! jpegenc ! filesink location=output1280x1024.jpg '
    0:00:00.155709295  1553     0x2da78290 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.155951600  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesrc"
    0:00:00.155998255  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseSrc@0x2ddf2c90> adding pad 'src'
    0:00:00.156059850  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:237:gst_file_src_set_location: filename : ./Image/450-1920-1200-L.raw
    0:00:00.156070700  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:238:gst_file_src_set_location: uri      : file:///root/workspace/sde-test/Image/450-1920-1200-L.raw
    0:00:00.174758670  1553     0x2da78290 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstrawparse.so" loaded
    0:00:00.175238650  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "rawvideoparse"
    0:00:00.175281645  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0x2dcd4ae0> adding pad 'sink'
    0:00:00.175304830  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0x2dcd4ae0> adding pad 'src'
    0:00:00.179660145  1553     0x2da78290 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstvideocrop.so" loaded
    0:00:00.179904135  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "videocrop"
    0:00:00.179940110  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddf8980> adding pad 'sink'
    0:00:00.179970625  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddf8980> adding pad 'src'
    0:00:00.180061825  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "capsfilter"
    0:00:00.180085395  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddfae10> adding pad 'sink'
    0:00:00.180105910  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddfae10> adding pad 'src'
    0:00:00.180126080  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.180155515  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesrc"
    0:00:00.180177990  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseSrc@0x2ddfb850> adding pad 'src'
    0:00:00.180229745  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:237:gst_file_src_set_location: filename : ./Image/450-1920-1200-R.raw
    0:00:00.180239750  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:238:gst_file_src_set_location: uri      : file:///root/workspace/sde-test/Image/450-1920-1200-R.raw
    0:00:00.180280625  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "rawvideoparse"
    0:00:00.180305810  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0x2ddfc460> adding pad 'sink'
    0:00:00.180325585  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseParse@0x2ddfc460> adding pad 'src'
    0:00:00.180366125  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "videocrop"
    0:00:00.180388840  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddfe550> adding pad 'sink'
    0:00:00.180408340  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddfe550> adding pad 'src'
    0:00:00.180467555  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "capsfilter"
    0:00:00.180490020  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddff4c0> adding pad 'sink'
    0:00:00.180509370  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2ddff4c0> adding pad 'src'
    0:00:00.180538425  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.253458305  1553     0x2da78290 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.253855825  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "tiovxsde"
    0:00:00.253917330  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstAggregator@0x2de24440> adding pad 'src'
    0:00:00.253945685  1553     0x2da78290 INFO            tiovxcontext gsttiovxcontext.c:141:gst_tiovx_context_init: Calling appInit() from GST!
    0:00:00.346321175  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "tiovxsdeviz"
    0:00:00.346407960  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2de78ee0> adding pad 'sink'
    0:00:00.346434245  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseTransform@0x2de78ee0> adding pad 'src'
    0:00:00.363841800  1553     0x2da78290 INFO      GST_PLUGIN_LOADING gstplugin.c:987:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/gstreamer-1.0/libgstjpeg.so" loaded
    0:00:00.364073365  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "jpegenc"
    0:00:00.364112280  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstVideoEncoder@0x2de7cde0> adding pad 'sink'
    0:00:00.364135270  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstVideoEncoder@0x2de7cde0> adding pad 'src'
    0:00:00.367081385  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "filesink"
    0:00:00.367117025  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<GstBaseSink@0x2de807f0> adding pad 'sink'
    0:00:00.367168985  1553     0x2da78290 INFO                filesink gstfilesink.c:321:gst_file_sink_set_location:<filesink0> filename : output1280x1024.jpg
    0:00:00.367179825  1553     0x2da78290 INFO                filesink gstfilesink.c:322:gst_file_sink_set_location:<filesink0> uri      : file:///root/workspace/sde-test/output1280x1024.jpg
    0:00:00.367202955  1553     0x2da78290 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:489:gst_element_factory_create_with_properties: creating element "pipeline"
    0:00:00.367416680  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstFileSrc named filesrc0 to some pad of GstRawVideoParse named rawvideoparse0 (0/0) with caps "(NULL)"
    0:00:00.367433450  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element filesrc0:(any) to element rawvideoparse0:(any)
    0:00:00.367449175  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link filesrc0:src and rawvideoparse0:sink
    0:00:00.367502895  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: filesrc0 and rawvideoparse0 in same bin, no need for ghost pads
    0:00:00.367527475  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link filesrc0:src and rawvideoparse0:sink
    0:00:00.367606660  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked filesrc0:src and rawvideoparse0:sink, successful
    0:00:00.367631170  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.367648185  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<filesrc0:src> Received event on flushing pad. Discarding
    0:00:00.367675140  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstRawVideoParse named rawvideoparse0 to some pad of GstVideoCrop named videocrop0 (0/0) with caps "(NULL)"
    0:00:00.367686620  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element rawvideoparse0:(any) to element videocrop0:(any)
    0:00:00.367699065  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link rawvideoparse0:src and videocrop0:sink
    0:00:00.367717260  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop0:src> pad has no peer
    0:00:00.367898225  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: rawvideoparse0 and videocrop0 in same bin, no need for ghost pads
    0:00:00.367916175  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link rawvideoparse0:src and videocrop0:sink
    0:00:00.367929980  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop0:src> pad has no peer
    0:00:00.368094650  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked rawvideoparse0:src and videocrop0:sink, successful
    0:00:00.368103245  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.368110620  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<rawvideoparse0:src> Received event on flushing pad. Discarding
    0:00:00.368135710  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstVideoCrop named videocrop0 to some pad of GstCapsFilter named capsfilter0 (0/0) with caps "(NULL)"
    0:00:00.368146605  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element videocrop0:(any) to element capsfilter0:(any)
    0:00:00.368158720  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link videocrop0:src and capsfilter0:sink
    0:00:00.369066505  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter0:src> pad has no peer
    0:00:00.369099070  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: videocrop0 and capsfilter0 in same bin, no need for ghost pads
    0:00:00.369114270  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link videocrop0:src and capsfilter0:sink
    0:00:00.370022320  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter0:src> pad has no peer
    0:00:00.370053985  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked videocrop0:src and capsfilter0:sink, successful
    0:00:00.370061785  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.370069085  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<videocrop0:src> Received event on flushing pad. Discarding
    0:00:00.370086015  1553     0x2da78290 INFO           GST_PARENTAGE gstbin.c:4385:gst_bin_get_by_name: [pipeline0]: looking up child element sde
    0:00:00.370111680  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstCapsFilter named capsfilter0 to pad  sde of GstTIOVXSde named sde (0/1) with caps "(NULL)"
    0:00:00.370136565  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element capsfilter0:(any) to element sde:left_sink
    0:00:00.370147470  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'left_sink' in element "sde"
    0:00:00.370157970  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'left_sink' in element "sde"
    0:00:00.370205890  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<sde> adding pad 'sink_0'
    0:00:00.370223810  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: capsfilter0 and sde in same bin, no need for ghost pads
    0:00:00.370238960  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link capsfilter0:src and sde:sink_0
    0:00:00.371222465  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked capsfilter0:src and sde:sink_0, successful
    0:00:00.371231395  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.371239095  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<capsfilter0:src> Received event on flushing pad. Discarding
    0:00:00.371268925  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstFileSrc named filesrc1 to some pad of GstRawVideoParse named rawvideoparse1 (0/0) with caps "(NULL)"
    0:00:00.371279490  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element filesrc1:(any) to element rawvideoparse1:(any)
    0:00:00.371291735  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link filesrc1:src and rawvideoparse1:sink
    0:00:00.371307200  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: filesrc1 and rawvideoparse1 in same bin, no need for ghost pads
    0:00:00.371321765  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link filesrc1:src and rawvideoparse1:sink
    0:00:00.371337665  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked filesrc1:src and rawvideoparse1:sink, successful
    0:00:00.371344840  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.371351810  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<filesrc1:src> Received event on flushing pad. Discarding
    0:00:00.371372415  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstRawVideoParse named rawvideoparse1 to some pad of GstVideoCrop named videocrop1 (0/0) with caps "(NULL)"
    0:00:00.371382675  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element rawvideoparse1:(any) to element videocrop1:(any)
    0:00:00.371394680  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link rawvideoparse1:src and videocrop1:sink
    0:00:00.371408430  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop1:src> pad has no peer
    0:00:00.371539940  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: rawvideoparse1 and videocrop1 in same bin, no need for ghost pads
    0:00:00.371570255  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link rawvideoparse1:src and videocrop1:sink
    0:00:00.371594990  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<videocrop1:src> pad has no peer
    0:00:00.371760390  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked rawvideoparse1:src and videocrop1:sink, successful
    0:00:00.371788470  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.371797390  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<rawvideoparse1:src> Received event on flushing pad. Discarding
    0:00:00.371819755  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstVideoCrop named videocrop1 to some pad of GstCapsFilter named capsfilter1 (0/0) with caps "(NULL)"
    0:00:00.371831035  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element videocrop1:(any) to element capsfilter1:(any)
    0:00:00.371843500  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link videocrop1:src and capsfilter1:sink
    0:00:00.372740910  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter1:src> pad has no peer
    0:00:00.372770800  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: videocrop1 and capsfilter1 in same bin, no need for ghost pads
    0:00:00.372786810  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link videocrop1:src and capsfilter1:sink
    0:00:00.373680810  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<capsfilter1:src> pad has no peer
    0:00:00.373711560  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked videocrop1:src and capsfilter1:sink, successful
    0:00:00.373719715  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.373726965  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<videocrop1:src> Received event on flushing pad. Discarding
    0:00:00.373742685  1553     0x2da78290 INFO           GST_PARENTAGE gstbin.c:4385:gst_bin_get_by_name: [pipeline0]: looking up child element sde
    0:00:00.373763995  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstCapsFilter named capsfilter1 to pad  sde of GstTIOVXSde named sde (0/1) with caps "(NULL)"
    0:00:00.373774680  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element capsfilter1:(any) to element sde:right_sink
    0:00:00.373783725  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'right_sink' in element "sde"
    0:00:00.373792985  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:1013:gst_element_get_static_pad: no such pad 'right_sink' in element "sde"
    0:00:00.373829105  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstelement.c:758:gst_element_add_pad:<sde> adding pad 'sink_1'
    0:00:00.373847130  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: capsfilter1 and sde in same bin, no need for ghost pads
    0:00:00.373862455  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link capsfilter1:src and sde:sink_1
    0:00:00.374836040  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked capsfilter1:src and sde:sink_1, successful
    0:00:00.374845140  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.374852630  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<capsfilter1:src> Received event on flushing pad. Discarding
    0:00:00.374881810  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstTIOVXSde named sde to some pad of GstTIOVXSdeViz named tiovxsdeviz0 (0/0) with caps "(NULL)"
    0:00:00.374892785  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element sde:(any) to element tiovxsdeviz0:(any)
    0:00:00.374919840  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link sde:src and tiovxsdeviz0:sink
    0:00:00.374936045  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<tiovxsdeviz0:src> pad has no peer
    0:00:00.374979485  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: sde and tiovxsdeviz0 in same bin, no need for ghost pads
    0:00:00.374995635  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link sde:src and tiovxsdeviz0:sink
    0:00:00.375008695  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<tiovxsdeviz0:src> pad has no peer
    0:00:00.375043455  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked sde:src and tiovxsdeviz0:sink, successful
    0:00:00.375051955  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.375059385  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<sde:src> Received event on flushing pad. Discarding
    0:00:00.375080610  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstTIOVXSdeViz named tiovxsdeviz0 to some pad of GstJpegEnc named jpegenc0 (0/0) with caps "(NULL)"
    0:00:00.375091010  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element tiovxsdeviz0:(any) to element jpegenc0:(any)
    0:00:00.375102945  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link tiovxsdeviz0:src and jpegenc0:sink
    0:00:00.375168735  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<jpegenc0:src> pad has no peer
    0:00:00.375211190  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: tiovxsdeviz0 and jpegenc0 in same bin, no need for ghost pads
    0:00:00.375227110  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link tiovxsdeviz0:src and jpegenc0:sink
    0:00:00.375268850  1553     0x2da78290 INFO                GST_PADS gstpad.c:4393:gst_pad_peer_query:<jpegenc0:src> pad has no peer
    0:00:00.375301865  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked tiovxsdeviz0:src and jpegenc0:sink, successful
    0:00:00.375310230  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.375317565  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<tiovxsdeviz0:src> Received event on flushing pad. Discarding
    0:00:00.375337460  1553     0x2da78290 INFO            GST_PIPELINE grammar.y:998:gst_parse_perform_link: linking some pad of GstJpegEnc named jpegenc0 to some pad of GstFileSink named filesink0 (0/0) with caps "(NULL)"
    0:00:00.375347855  1553     0x2da78290 INFO        GST_ELEMENT_PADS gstutils.c:1818:gst_element_link_pads_full: trying to link element jpegenc0:(any) to element filesink0:(any)
    0:00:00.375359460  1553     0x2da78290 INFO                GST_PADS gstutils.c:1080:gst_pad_check_link: trying to link jpegenc0:src and filesink0:sink
    0:00:00.375378105  1553     0x2da78290 INFO                GST_PADS gstutils.c:1634:prepare_link_maybe_ghosting: jpegenc0 and filesink0 in same bin, no need for ghost pads
    0:00:00.375392525  1553     0x2da78290 INFO                GST_PADS gstpad.c:2440:gst_pad_link_prepare: trying to link jpegenc0:src and filesink0:sink
    0:00:00.375408475  1553     0x2da78290 INFO                GST_PADS gstpad.c:2621:gst_pad_link_full: linked jpegenc0:src and filesink0:sink, successful
    0:00:00.375416065  1553     0x2da78290 INFO               GST_EVENT gstevent.c:1687:gst_event_new_reconfigure: creating reconfigure event
    0:00:00.375434720  1553     0x2da78290 INFO               GST_EVENT gstpad.c:6011:gst_pad_send_event_unchecked:<jpegenc0:src> Received event on flushing pad. Discarding
    0:00:00.376228765  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesink0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376387965  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesink0> completed state change to READY
    0:00:00.376403545  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesink0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376447240  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesink0' changed state to 2(READY) successfully
    0:00:00.376465185  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<jpegenc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376477515  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<jpegenc0> completed state change to READY
    0:00:00.376487315  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<jpegenc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376501940  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'jpegenc0' changed state to 2(READY) successfully
    0:00:00.376516115  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxsdeviz0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376526225  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<tiovxsdeviz0> completed state change to READY
    0:00:00.376535435  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<tiovxsdeviz0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376549550  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'tiovxsdeviz0' changed state to 2(READY) successfully
    0:00:00.376564045  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<sde> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376574920  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<sde> completed state change to READY
    0:00:00.376584095  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<sde> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376597530  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'sde' changed state to 2(READY) successfully
    0:00:00.376611195  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376621335  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter0> completed state change to READY
    0:00:00.376630835  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376645360  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 2(READY) successfully
    0:00:00.376658390  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376668040  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter1> completed state change to READY
    0:00:00.376677430  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376714205  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter1' changed state to 2(READY) successfully
    0:00:00.376728395  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376738820  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop0> completed state change to READY
    0:00:00.376748010  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376764055  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop0' changed state to 2(READY) successfully
    0:00:00.376777690  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376787755  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop1> completed state change to READY
    0:00:00.376797460  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376811585  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop1' changed state to 2(READY) successfully
    0:00:00.376825290  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376835755  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse0> completed state change to READY
    0:00:00.376845490  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376859525  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse0' changed state to 2(READY) successfully
    0:00:00.376872790  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376883050  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse1> completed state change to READY
    0:00:00.376892350  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376906100  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse1' changed state to 2(READY) successfully
    0:00:00.376918630  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376929310  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc0> completed state change to READY
    0:00:00.376938755  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.376952850  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 2(READY) successfully
    0:00:00.376965655  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc1> current NULL pending VOID_PENDING, desired next READY
    0:00:00.376975590  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc1> completed state change to READY
    0:00:00.376994030  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc1> notifying about state-changed NULL to READY (VOID_PENDING pending)
    0:00:00.377009655  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc1' changed state to 2(READY) successfully
    0:00:00.377029580  1553     0x2da78290 INFO              GST_STATES gstelement.c:2788:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PAUSED, next PAUSED
    0:00:00.377040040  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed NULL to READY (PAUSED pending)
    0:00:00.377105380  1553     0x2da78290 INFO              GST_STATES gstelement.c:2796:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PAUSED
    0:00:00.377140795  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesink0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.377166855  1553     0x2da78290 INFO              GST_STATES gstbin.c:2943:gst_bin_change_state_func:<pipeline0> child 'filesink0' is changing state asynchronously to PAUSED
    0:00:00.377181470  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<jpegenc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.377201965  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<jpegenc0> completed state change to PAUSED
    0:00:00.377212525  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<jpegenc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.377227580  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'jpegenc0' changed state to 3(PAUSED) successfully
    0:00:00.377241085  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxsdeviz0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.377259330  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<tiovxsdeviz0> completed state change to PAUSED
    0:00:00.377269495  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<tiovxsdeviz0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.377283790  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'tiovxsdeviz0' changed state to 3(PAUSED) successfully
    0:00:00.377297560  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<sde> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.377323305  1553     0x2da78290 INFO              aggregator gstaggregator.c:2563:gst_aggregator_src_pad_activate_mode_func:<sde:src> Activating pad!
    0:00:00.377332080  1553     0x2da78290 INFO              aggregator gstaggregator.c:1550:gst_aggregator_start_srcpad_task:<sde> Starting srcpad task
    0:00:00.377540275  1553     0x2da78290 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0x2de254a0 on task 0x2de88450
    0:00:00.377558370  1553     0x2da78290 INFO                GST_PADS gstpad.c:6357:gst_pad_start_task:<sde:src> created task 0x2de88450
    0:00:00.378117570  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<sde> completed state change to PAUSED
    0:00:00.378145490  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<sde> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.378166495  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'sde' changed state to 3(PAUSED) successfully
    0:00:00.378209735  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.378231705  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter0> completed state change to PAUSED
    0:00:00.378242560  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.378258020  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 3(PAUSED) successfully
    0:00:00.378272360  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<capsfilter1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.378289360  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<capsfilter1> completed state change to PAUSED
    0:00:00.378299530  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.378313840  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'capsfilter1' changed state to 3(PAUSED) successfully
    0:00:00.378327630  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.378344625  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop0> completed state change to PAUSED
    0:00:00.378354615  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.378368735  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop0' changed state to 3(PAUSED) successfully
    0:00:00.378382330  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<videocrop1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.378399705  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<videocrop1> completed state change to PAUSED
    0:00:00.378409730  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<videocrop1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.378423770  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'videocrop1' changed state to 3(PAUSED) successfully
    0:00:00.378437695  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.378548895  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file ./Image/450-1920-1200-L.raw
    0:00:00.379601185  1553     0x2da78290 WARN                 basesrc gstbasesrc.c:3695:gst_base_src_start_complete:<filesrc0> pad not activated yet
    0:00:00.380302510  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc0> opening file ./Image/450-1920-1200-L.raw
    0:00:00.380351565  1553     0x2da78290 INFO               GST_EVENT gstevent.c:998: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.380389250  1553     0x2da78290 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0x2dcd5010 on task 0x2dbe5590
    0:00:00.380401315  1553     0x2da78290 INFO                GST_PADS gstpad.c:6357:gst_pad_start_task:<rawvideoparse0:sink> created task 0x2dbe5590
    0:00:00.380676220  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse0> completed state change to PAUSED
    0:00:00.380695815  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.380707130  1553 0xffffa0000d30 INFO        GST_ELEMENT_PADS gstelement.c:1016:gst_element_get_static_pad: found pad rawvideoparse0:sink
    0:00:00.380739000  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse0' changed state to 3(PAUSED) successfully
    0:00:00.380762390  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<rawvideoparse1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.380814945  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc1> opening file ./Image/450-1920-1200-R.raw
    0:00:00.380895180  1553     0x2da78290 WARN                 basesrc gstbasesrc.c:3695:gst_base_src_start_complete:<filesrc1> pad not activated yet
    0:00:00.380919670  1553     0x2da78290 INFO                 filesrc gstfilesrc.c:465:gst_file_src_start:<filesrc1> opening file ./Image/450-1920-1200-R.raw
    0:00:00.380960175  1553     0x2da78290 INFO               GST_EVENT gstevent.c:998: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.380986720  1553     0x2da78290 INFO                    task gsttask.c:516:gst_task_set_lock: setting stream lock 0x2ddfc990 on task 0x2de8a2f0
    0:00:00.380997935  1553     0x2da78290 INFO                GST_PADS gstpad.c:6357:gst_pad_start_task:<rawvideoparse1:sink> created task 0x2de8a2f0
    0:00:00.381176615  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<rawvideoparse1> completed state change to PAUSED
    0:00:00.381199360  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<rawvideoparse1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.381222210  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'rawvideoparse1' changed state to 3(PAUSED) successfully
    0:00:00.381238720  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc0> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.381249060  1553 0xffffa0000ef0 INFO        GST_ELEMENT_PADS gstelement.c:1016:gst_element_get_static_pad: found pad rawvideoparse1:sink
    0:00:00.381257775  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc0> completed state change to PAUSED
    0:00:00.381294490  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.381311410  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc0' changed state to 3(PAUSED) successfully
    0:00:00.381324570  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesrc1> current READY pending VOID_PENDING, desired next PAUSED
    0:00:00.381340265  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesrc1> completed state change to PAUSED
    0:00:00.381350910  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesrc1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
    0:00:00.381367105  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesrc1' changed state to 3(PAUSED) successfully
    0:00:00.381406770  1553     0x2da78290 INFO                pipeline gstpipeline.c:533:gst_pipeline_change_state:<pipeline0> pipeline is not live
    0:00:00.484935750  1553 0xffffa0000d30 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1920, height=(int)1200, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.484935880  1553 0xffffa0000ef0 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1920, height=(int)1200, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.487791695  1553 0xffffa0000ef0 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.487907930  1553 0xffffa0000ef0 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<capsfilter1> reuse caps
    0:00:00.487939525  1553 0xffffa0000ef0 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.488054080  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxmiso.c:858:gst_tiovx_miso_propose_allocation:<sde> Using temporary reference for configuration
    0:00:00.488094570  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxutils.c:644:gst_tiovx_get_exemplar_from_caps:<sde> creating image with width: 1280	 height: 1024	 format: 0x38303055
    0:00:00.488209770  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.488220545  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.488440835  1553 0xffffa0000b70 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffff98001f00> New TIOVX buffer pool
    0:00:00.488564455  1553 0xffffa0000b70 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff98002d20> New TIOVX allocator
    0:00:00.488597115  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 2 buffers of 1310720 size
    0:00:00.488619195  1553 0xffffa0000d30 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.488680735  1553 0xffffa0000ef0 INFO               videocrop gstvideocrop.c:507:gst_video_crop_decide_allocation:<videocrop1> we are not using passthrough
    0:00:00.488683450  1553 0xffffa0000d30 INFO           basetransform gstbasetransform.c:1326:gst_base_transform_setcaps:<capsfilter0> reuse caps
    0:00:00.488758190  1553 0xffffa0000d30 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, format=(string)GRAY8, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.488787455  1553 0xffffa0000ef0 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff94004e80> New TIOVX allocator
    0:00:00.488844070  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxmiso.c:858:gst_tiovx_miso_propose_allocation:<sde> Using temporary reference for configuration
    0:00:00.488868480  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxutils.c:644:gst_tiovx_get_exemplar_from_caps:<sde> creating image with width: 1280	 height: 1024	 format: 0x38303055
    0:00:00.488956140  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.488968180  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.489037345  1553 0xffffa0000b70 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffff98003460> New TIOVX buffer pool
    0:00:00.489083305  1553 0xffffa0000b70 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff980038c0> New TIOVX allocator
    0:00:00.489104290  1553 0xffffa0000b70 INFO               tiovxmiso gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 2 buffers of 1310720 size
    0:00:00.489153145  1553 0xffffa0000d30 INFO               videocrop gstvideocrop.c:507:gst_video_crop_decide_allocation:<videocrop0> we are not using passthrough
    0:00:00.489216725  1553 0xffffa0000d30 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff90003b90> New TIOVX allocator
    0:00:00.493027220  1553 0xffffa0000b70 INFO                tiovxsde gsttiovxsde.c:954:gst_tiovx_sde_fixate_caps:<sde> Fixating caps
    0:00:00.493042565  1553 0xffffa0000ef0 INFO          GST_SCHEDULING gstpad.c:5084:gst_pad_get_range_unchecked:<filesrc1:src> getrange failed, flow: eos
    0:00:00.493109925  1553 0xffffa0000ef0 INFO          GST_SCHEDULING gstpad.c:5299:gst_pad_pull_range:<rawvideoparse1:sink> pullrange failed, flow: eos
    0:00:00.493124165  1553 0xffffa0000b70 INFO              aggregator gstaggregator.c:639:gst_aggregator_push_mandatory_events:<sde> pushing stream start
    0:00:00.493172535  1553 0xffffa0000b70 INFO              aggregator gstaggregator.c:650:gst_aggregator_push_mandatory_events:<sde> pushing caps: application/x-sde-tiovx, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.493190435  1553 0xffffa0000b70 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event application/x-sde-tiovx, width=(int)1280, height=(int)1024, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)1/1
    0:00:00.493209670  1553 0xffffa0000ef0 INFO                    task gsttask.c:368:gst_task_func:<rawvideoparse1:sink> Task going to paused
    0:00:00.493363245  1553 0xffffa0000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:506:gst_tiovx_sde_viz_init_module:<tiovxsdeviz0> Init module
    0:00:00.493837055  1553 0xffffa0000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:563:gst_tiovx_sde_viz_create_graph:<tiovxsdeviz0> Create graph
    0:00:00.493863890  1553 0xffffa0000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:574:gst_tiovx_sde_viz_create_graph:<tiovxsdeviz0> TIOVX Target to use: DSP-1
    0:00:00.493866940  1553 0xffffa0000d30 INFO          GST_SCHEDULING gstpad.c:5084:gst_pad_get_range_unchecked:<filesrc0:src> getrange failed, flow: eos
    0:00:00.493885970  1553 0xffffa0000d30 INFO          GST_SCHEDULING gstpad.c:5299:gst_pad_pull_range:<rawvideoparse0:sink> pullrange failed, flow: eos
    0:00:00.493972525  1553 0xffffa0000d30 INFO                    task gsttask.c:368:gst_task_func:<rawvideoparse0:sink> Task going to paused
    0:00:00.501664765  1553 0xffffa0000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:659:gst_tiovx_sde_viz_get_node_info:<tiovxsdeviz0> Get node info from module
    0:00:00.503537590  1553 0xffffa0000b70 INFO             tiovxsdeviz gsttiovxsdeviz.c:600:gst_tiovx_sde_viz_release_buffer:<tiovxsdeviz0> Release buffer
    0:00:00.504552200  1553 0xffffa0000b70 INFO               GST_EVENT gstevent.c:918:gst_event_new_caps: creating caps event video/x-raw, width=(int)1280, height=(int)1024, framerate=(fraction)0/1, format=(string)RGB
    0:00:00.504911515  1553 0xffffa0000b70 INFO               tiovxsiso gsttiovxsiso.c:572:gst_tiovx_siso_decide_allocation:<tiovxsdeviz0> No TIOVX pool, discarding: "videobufferpool0"
    0:00:00.504998745  1553 0xffffa0000b70 INFO               tiovxsiso gsttiovxbufferpoolutils.c:85:gst_tiovx_create_new_pool: Creating new pool
    0:00:00.505009660  1553 0xffffa0000b70 INFO               tiovxsiso gsttiovxbufferpoolutils.c:91:gst_tiovx_create_new_pool: Creating Image buffer pool
    0:00:00.505049080  1553 0xffffa0000b70 INFO         tiovxbufferpool gsttiovxbufferpool.c:127:gst_tiovx_buffer_pool_init:<GstTIOVXBufferPool@0xffff9800e9b0> New TIOVX buffer pool
    0:00:00.505089810  1553 0xffffa0000b70 INFO          tiovxallocator gsttiovxallocator.c:128:gst_tiovx_allocator_init:<GstTIOVXAllocator@0xffff9800ed40> New TIOVX allocator
    0:00:00.505109420  1553 0xffffa0000b70 INFO               tiovxsiso gsttiovxbufferpoolutils.c:144:gst_tiovx_add_new_pool: Adding new TIOVX pool with 2 buffers of 3932160 size
    0:00:00.506440265  1553 0xffffa0000b70 INFO                tiovxsde gsttiovxsde.c:728:gst_tiovx_sde_init_module:<sde> Init module
    0:00:00.506473160  1553 0xffffa0000b70 INFO                tiovxsde gsttiovxsde.c:763:gst_tiovx_sde_init_module:<sde> Input Left & Input Right parameters: 
    	Width: 1280 
    	Height: 1024
    0:00:03.092268865  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<filesink0> current READY pending PAUSED, desired next READY
    0:00:03.092359535  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<filesink0> completed state change to READY
    0:00:03.092373490  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<filesink0> notifying about state-changed READY to READY (VOID_PENDING pending)
    0:00:03.092389800  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'filesink0' changed state to 2(READY) successfully
    0:00:03.092404920  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<jpegenc0> current PAUSED pending VOID_PENDING, desired next READY
    0:00:03.092451360  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<jpegenc0> completed state change to READY
    0:00:03.092463215  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<jpegenc0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
    0:00:03.092479360  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'jpegenc0' changed state to 2(READY) successfully
    0:00:03.092493900  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<tiovxsdeviz0> current PAUSED pending VOID_PENDING, desired next READY
    0:00:03.092540355  1553     0x2da78290 INFO             tiovxsdeviz gsttiovxsdeviz.c:622:gst_tiovx_sde_viz_deinit_module:<tiovxsdeviz0> Deinit module
    0:00:03.094148640  1553     0x2da78290 INFO              GST_STATES gstelement.c:2816:gst_element_continue_state:<tiovxsdeviz0> completed state change to READY
    0:00:03.094179625  1553     0x2da78290 INFO              GST_STATES gstelement.c:2716:_priv_gst_element_state_changed:<tiovxsdeviz0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
    0:00:03.094204700  1553     0x2da78290 INFO              GST_STATES gstbin.c:2936:gst_bin_change_state_func:<pipeline0> child 'tiovxsdeviz0' changed state to 2(READY) successfully
    0:00:03.094227590  1553     0x2da78290 INFO              GST_STATES gstbin.c:2480:gst_bin_element_set_state:<sde> current PAUSED pending VOID_PENDING, desired next READY
    0:00:03.094246035  1553     0x2da78290 INFO              aggregator gstaggregator.c:2576:gst_aggregator_src_pad_activate_mode_func:<sde> Deactivating srcpad
    0:00:03.094254935  1553     0x2da78290 INFO              aggregator gstaggregator.c:1530:gst_aggregator_stop_srcpad_task:<sde> Stopping srcpad task
    

  • Hi Jared,

    Has there been any progress on this matter?

    Best,
    Tetsuya

  • Hi ,

    Apologies, I was out of office.

    The error message is being output due to something failing within the Vhwa_m2mSdeAllocSl2 function. Can you add messages to see where this function is failing?

    One guess I have could be that: DMPAC_SL2_SIZE  (0x80000UL) is not large enough, but prints should be able to clarify exactly.

    You can also step through the code if you have debug capabilities.

    Best,
    Jared

  • Hi Jared,

    1920x1024 SDE processing is now possible!

    I investigated the Vhwa_m2mSdeAllocSl2 function you recommended.
    As you pointed out, DMPAC_SL2_SIZE was small, and there was insufficient memory allocated for DOF and SDE.

    To address this,
    I changed ./packages/ti/csl/soc/j721e/src/cslr_soc_baseaddress.h as follows:

    //#define CSL_DMPAC0_DMPAC_TOP_DOF_INFRA_DMPAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_SIZE (0x80000ULL)
    #define CSL_DMPAC0_DMPAC_TOP_DOF_INFRA_DMPAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_SIZE (0xa0000ULL)

    Will this change adversely affect other features?

    Best,
    Tetsuya

  • Hi ,

    I don't think so. It doesn't look like the memory allocation conflicts with any other resource.

    Can you send your changes as a patch file, so I can look at the exact changes and have them for future reference? 

    Best,
    Jared

  • Hi Jared,

    We'll send you an SDK patch.
    Some of the changes may be unwanted.
    Please use it as a reference.

    diff -r -u ti-processor-sdk-rtos-j721e-evm-10_01_00_04/pdk_jacinto_10_01_00_25/packages/ti/csl/soc/j721e/src/cslr_soc_baseaddress.h ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/pdk_jacinto_10_01_00_25/packages/ti/csl/soc/j721e/src/cslr_soc_baseaddress.h
    --- ti-processor-sdk-rtos-j721e-evm-10_01_00_04/pdk_jacinto_10_01_00_25/packages/ti/csl/soc/j721e/src/cslr_soc_baseaddress.h	2024-12-13 01:22:47.000000000 +0900
    +++ ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/pdk_jacinto_10_01_00_25/packages/ti/csl/soc/j721e/src/cslr_soc_baseaddress.h	2026-01-22 23:46:52.055620144 +0900
    @@ -5549,7 +5549,8 @@
     #define CSL_VPAC0_VPAC_TOP_PAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_BASE                            (0x4f00000000ULL)
     #define CSL_VPAC0_VPAC_TOP_PAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_SIZE                            (0x80000ULL)
     #define CSL_DMPAC0_DMPAC_TOP_DOF_INFRA_DMPAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_BASE              (0x4f01000000ULL)
    -#define CSL_DMPAC0_DMPAC_TOP_DOF_INFRA_DMPAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_SIZE              (0x80000ULL)
    +//#define CSL_DMPAC0_DMPAC_TOP_DOF_INFRA_DMPAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_SIZE              (0x80000ULL)
    +#define CSL_DMPAC0_DMPAC_TOP_DOF_INFRA_DMPAC_BASE_MEM_SLV_CBASS_STRIPE_MSRAM_SLV_SIZE              (0xa0000ULL)
     #define CSL_MCU_R5FSS0_CORE0_ICACHE_BASE                                                           (0x5400000000ULL)
     #define CSL_MCU_R5FSS0_CORE0_ICACHE_SIZE                                                           (0x800000ULL)
     #define CSL_MCU_R5FSS0_CORE0_DCACHE_BASE                                                           (0x5400800000ULL)
    diff -r -u ti-processor-sdk-rtos-j721e-evm-10_01_00_04/pdk_jacinto_10_01_00_25/packages/ti/drv/vhwa/include/vhwa_m2mSde.h ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/pdk_jacinto_10_01_00_25/packages/ti/drv/vhwa/include/vhwa_m2mSde.h
    --- ti-processor-sdk-rtos-j721e-evm-10_01_00_04/pdk_jacinto_10_01_00_25/packages/ti/drv/vhwa/include/vhwa_m2mSde.h	2024-12-13 01:22:47.000000000 +0900
    +++ ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/pdk_jacinto_10_01_00_25/packages/ti/drv/vhwa/include/vhwa_m2mSde.h	2026-01-22 21:22:09.792626910 +0900
    @@ -151,10 +151,12 @@
      *
      *  @{
      */
    -#define SDE_DEFAULT_IMG_WIDTH       (1280U)
    +//#define SDE_DEFAULT_IMG_WIDTH       (1280U)
    +#define SDE_DEFAULT_IMG_WIDTH       (2048U)
     #define SDE_DEFAULT_CCSF            (FVID2_CCSF_BITS12_UNPACKED16)
     #define SDE_DEFAULT_DIS_BUFF_DEPTH  (2U)
    -#define SDE_DEFAULT_SR              (SDE_SR_128)
    +//#define SDE_DEFAULT_SR              (SDE_SR_128)
    +#define SDE_DEFAULT_SR              (SDE_SR_192)
     /** @} */
     
     /* ========================================================================== */
    diff -r -u ti-processor-sdk-rtos-j721e-evm-10_01_00_04/sdk_builder/make_firmware.sh ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/sdk_builder/make_firmware.sh
    --- ti-processor-sdk-rtos-j721e-evm-10_01_00_04/sdk_builder/make_firmware.sh	2024-12-13 01:26:42.000000000 +0900
    +++ ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/sdk_builder/make_firmware.sh	2026-01-13 20:52:17.838234440 +0900
    @@ -1,6 +1,7 @@
     NUM_PROCS=$(cat /proc/cpuinfo | grep processor | wc -l)
     log_file="/tmp/sdk_build_errors.log"
    -time make firmware -j${NUM_PROCS} 2> >(tee ${log_file})
    +# time make firmware -j${NUM_PROCS} 2> >(tee ${log_file})
    +time make firmware -j${NUM_PROCS} SOC=j721e TISDK_IMAGE=edgeai 2> >(tee ${log_file})
     if [ $? -ne 0 ]
     then
         echo ""
    diff -r -u ti-processor-sdk-rtos-j721e-evm-10_01_00_04/sdk_builder/make_sdk.sh ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/sdk_builder/make_sdk.sh
    --- ti-processor-sdk-rtos-j721e-evm-10_01_00_04/sdk_builder/make_sdk.sh	2024-12-13 01:26:42.000000000 +0900
    +++ ti-processor-sdk-rtos-j721e-evm-10_01_00_04_edit/sdk_builder/make_sdk.sh	2026-01-13 21:51:45.585306144 +0900
    @@ -1,6 +1,7 @@
     NUM_PROCS=$(cat /proc/cpuinfo | grep processor | wc -l)
     log_file="/tmp/sdk_build_errors.log"
    -time make sdk -j${NUM_PROCS} 2> >(tee ${log_file})
    +# time make sdk -j${NUM_PROCS} 2> >(tee ${log_file})
    +time make sdk -j${NUM_PROCS} SOC=j721e TISDK_IMAGE=edgeai 2> >(tee ${log_file})
     if [ $? -ne 0 ]
     then
         echo ""
    

    I will mark this issue as "resolved."
    Thank you for your cooperation.

    Best,
    Jared