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.

DM816x processor is hanging..

Hi All,

Actually i got an issue with dm8168 processor.. The issue is, we have a custom board of dm8168, in that i am trying to mix two test videos. The pipeline seems fine. but when i run the pipeline the board get hanging. also actually i mounted filesytem through NFS. is this issue because of NFS or with DSP core ..? any suggetions...? pls help me... this is my log.

root@dm816x-evm:~# gst-launch -v videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf ! rtph264pay !
 udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. videotestsrc pa
ttern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix.
Setting pipeline to PAUSED ...
/GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
/GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
/GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
/GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_1: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
/GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
Pipeline is PREROLLING ...

Many Thanks in advance.

BR

Ajay

  • Hello,


    Are you try to encode two streams and streaming, right?

    If yes, this pipeline does not seems correct.

    BR
    Margarita

  • hello ma'am, thanks for the reply...

    Actually, the pipeline is working fine. i cross checked with the ti's dm8168 reference board. Here is the pipeline.

    gst-launch -v videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf ! rtph264pay ! udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. videotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix.

    pls help me here.


    BR
    Ajay
  • Hello,

    add --gst-debug=3 and attach the full log.

    BR
    Margarita
  • Hello ma'am, here  is the log i got.

    root@dm816x-evm:~# gst-launch --gst-debug=3 -v videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf
    ! rtph264pay ! udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. v
    ideotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix.
    0:00:00.012735778  1252    0x16050 INFO                GST_INIT gstquery.c:108:_gst_query_initialize: init queries
    0:00:00.017022334  1252    0x16050 INFO                GST_INIT gstmessage.c:73:_gst_message_initialize: init messages
    0:00:00.018001482  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:350:_gst_plugin_initialize: registering 0 static plugins
    0:00:00.018733926  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:255:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.018818112  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:257:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.024792926  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1599:ensure_current_registry: reading registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
    0:00:00.110929926  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:614:gst_registry_binary_read_cache: loaded /home/root/.gstreamer-0.10/registry.arm.bin in 0.085992 seconds
    0:00:00.111271111  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1469:scan_and_update_registry: Validating plugins from registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
    0:00:00.116271890  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1219:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-0.10/libgstlibvisual.so is stale
    0:00:00.212009704  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1219:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-0.10/libgstfrei0r.so is stale
    0:00:00.233117815  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1570:scan_and_update_registry: Registry cache changed. Writing new registry cache
    0:00:00.233243519  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:364:gst_registry_binary_write_cache: Building binary registry cache image
    0:00:00.279287667  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:396:gst_registry_binary_write_cache: Writing binary registry cache
    0:00:00.510030630  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:258:gst_registry_binary_cache_finish: Wrote binary registry cache
    0:00:00.510155889  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1578:scan_and_update_registry: Registry cache written successfully
    0:00:00.510201260  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1628:ensure_current_registry: registry reading and updating done, result = 1
    0:00:00.510239556  1252    0x16050 INFO                GST_INIT gst.c:792:init_post: GLib runtime version: 2.24.1
    0:00:00.510281889  1252    0x16050 INFO                GST_INIT gst.c:794:init_post: GLib headers version: 2.24.1
    0:00:00.510524815  1252    0x16050 INFO            GST_PIPELINE gstparse.c:299:gst_parse_launch_full: parsing pipeline description 'videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf ! rtph264pay ! udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. videotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix. '
    0:00:00.526849075  1252    0x16050 INFO              videomixer videomixer.c:614:_do_init: GstChildProxy interface registered
    0:00:00.527064482  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideomixer.so" loaded
    0:00:00.527127038  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videomixer"
    0:00:00.530575482  1252    0x16050 INFO              videomixer videomixer.c:649:gst_videomixer_child_proxy_init: intializing child proxy interface
    0:00:00.530868222  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstVideoMixer@0x1f3008> adding pad 'src'
    0:00:00.531161111  1252    0x16050 INFO                 default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:00.560349815  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstffmpegcolorspace.so" loaded
    0:00:00.560461111  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "ffmpegcolorspace"
    0:00:00.564098407  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202010> adding pad 'sink'
    0:00:00.564309926  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202010> adding pad 'src'
    0:00:00.837094001  1252    0x16050 INFO                     omx gstomx_videomixer.c:2183:init_interfaces: GstChildProxy interface registered
    0:00:00.837342075  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstomx.so" loaded
    0:00:00.837466482  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "omx_h264enc"
    0:00:00.840060445  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstOmxBaseFilter@0x2070d8> adding pad 'sink'
    0:00:00.840271519  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstOmxBaseFilter@0x2070d8> adding pad 'src'
    0:00:00.931624000  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
    0:00:00.931762037  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "queue"
    0:00:00.932566185  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x20a090> adding pad 'sink'
    0:00:00.932784667  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x20a090> adding pad 'src'
    0:00:00.940039889  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgsth264parse.so" loaded
    0:00:00.940146926  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "h264parse"
    0:00:00.940876408  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstH264Parse@0x20ba00> adding pad 'sink'
    0:00:00.941129445  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstH264Parse@0x20ba00> adding pad 'src'
    0:00:00.941389741  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "gstperf"
    0:00:00.941811741  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x212000> adding pad 'sink'
    0:00:00.941955148  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x212000> adding pad 'src'
    0:00:01.008796223  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstrtp.so" loaded
    0:00:01.008916852  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "rtph264pay"
    0:00:01.009747852  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseRTPPayload@0x221020> adding pad 'src'
    0:00:01.009912445  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseRTPPayload@0x221020> adding pad 'sink'
    0:00:01.021702371  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstudp.so" loaded
    0:00:01.021814334  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "udpsink"
    0:00:01.022889556  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x2260c0> adding pad 'sink'
    0:00:01.036118112  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideotestsrc.so" loaded
    0:00:01.036229186  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videotestsrc"
    0:00:01.039581260  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x23a178> adding pad 'src'
    0:00:01.048710149  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideobox.so" loaded
    0:00:01.048814741  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videobox"
    0:00:01.052508667  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202250> adding pad 'sink'
    0:00:01.052720037  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202250> adding pad 'src'
    0:00:01.053138815  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videotestsrc"
    0:00:01.053324519  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x23a400> adding pad 'src'
    0:00:01.053487667  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videobox"
    0:00:01.053639185  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202490> adding pad 'sink'
    0:00:01.053768222  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202490> adding pad 'src'
    0:00:01.054022074  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "pipeline"
    0:00:01.054689259  1252    0x16050 INFO           GST_PARENTAGE gstbin.c:3702:gst_bin_get_by_name: [pipeline0]: looking up child element mix
    0:00:01.054808296  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videobox1:(any) to mix:mix (0/0) with caps "(nil)"
    0:00:01.054897963  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videobox1:(any) to element mix:(any)
    0:00:01.056347556  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<mix> adding pad 'sink_0'
    0:00:01.056476001  1252    0x16050 INFO                 default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:01.056624445  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videobox1 and mix in same bin, no need for ghost pads
    0:00:01.056776297  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videobox1:src and mix:sink_0
    0:00:01.057288038  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videobox1:src and mix:sink_0, successful
    0:00:01.057415741  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking mix:(any) to ffmpegcsp0:(any) (0/0) with caps "(nil)"
    0:00:01.057473260  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element mix:(any) to element ffmpegcsp0:(any)
    0:00:01.057533408  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link mix:src and ffmpegcsp0:sink
    0:00:01.058039000  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: mix and ffmpegcsp0 in same bin, no need for ghost pads
    0:00:01.058125741  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link mix:src and ffmpegcsp0:sink
    0:00:01.058577815  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked mix:src and ffmpegcsp0:sink, successful
    0:00:01.058673112  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking ffmpegcsp0:(any) to omxh264enc0:(any) (0/0) with caps "(nil)"
    0:00:01.058726149  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element ffmpegcsp0:(any) to element omxh264enc0:(any)
    0:00:01.058779445  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link ffmpegcsp0:src and omxh264enc0:sink
    0:00:01.079175519  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: ffmpegcsp0 and omxh264enc0 in same bin, no need for ghost pads
    0:00:01.079322704  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link ffmpegcsp0:src and omxh264enc0:sink
    0:00:01.099356074  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked ffmpegcsp0:src and omxh264enc0:sink, successful
    0:00:01.099504074  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking omxh264enc0:(any) to queue0:(any) (0/0) with caps "(nil)"
    0:00:01.099563852  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element omxh264enc0:(any) to element queue0:(any)
    0:00:01.099625371  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link omxh264enc0:src and queue0:sink
    0:00:01.099701593  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: omxh264enc0 and queue0 in same bin, no need for ghost pads
    0:00:01.099782667  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link omxh264enc0:src and queue0:sink
    0:00:01.099839630  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked omxh264enc0:src and queue0:sink, successful
    0:00:01.099924482  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking queue0:(any) to h264parse0:(any) (0/0) with caps "(nil)"
    0:00:01.099974223  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element queue0:(any) to element h264parse0:(any)
    0:00:01.100023778  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link queue0:src and h264parse0:sink
    0:00:01.100100186  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: queue0 and h264parse0 in same bin, no need for ghost pads
    0:00:01.100170519  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link queue0:src and h264parse0:sink
    0:00:01.100258334  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked queue0:src and h264parse0:sink, successful
    0:00:01.100345148  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking h264parse0:(any) to perf0:(any) (0/0) with caps "(nil)"
    0:00:01.100393630  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element h264parse0:(any) to element perf0:(any)
    0:00:01.100444778  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link h264parse0:src and perf0:sink
    0:00:01.100500556  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: h264parse0 and perf0 in same bin, no need for ghost pads
    0:00:01.100567519  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link h264parse0:src and perf0:sink
    0:00:01.100623371  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked h264parse0:src and perf0:sink, successful
    0:00:01.100720334  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking perf0:(any) to rtph264pay0:(any) (0/0) with caps "(nil)"
    0:00:01.100771000  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element perf0:(any) to element rtph264pay0:(any)
    0:00:01.100822630  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link perf0:src and rtph264pay0:sink
    0:00:01.100900889  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: perf0 and rtph264pay0 in same bin, no need for ghost pads
    0:00:01.100971482  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link perf0:src and rtph264pay0:sink
    0:00:01.101047222  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked perf0:src and rtph264pay0:sink, successful
    0:00:01.101131222  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking rtph264pay0:(any) to udpsink0:(any) (0/0) with caps "(nil)"
    0:00:01.101179297  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element rtph264pay0:(any) to element udpsink0:(any)
    0:00:01.101234222  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link rtph264pay0:src and udpsink0:sink
    0:00:01.101300667  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: rtph264pay0 and udpsink0 in same bin, no need for ghost pads
    0:00:01.101375556  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link rtph264pay0:src and udpsink0:sink
    0:00:01.101430926  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked rtph264pay0:src and udpsink0:sink, successful
    0:00:01.105625704  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videotestsrc0:(any) to videobox0:(any) (0/0) with caps "(nil)"
    0:00:01.105695149  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videotestsrc0:(any) to element videobox0:(any)
    0:00:01.105849519  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link videotestsrc0:src and videobox0:sink
    0:00:01.106855334  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videotestsrc0 and videobox0 in same bin, no need for ghost pads
    0:00:01.106970075  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videotestsrc0:src and videobox0:sink
    0:00:01.107782519  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videotestsrc0:src and videobox0:sink, successful
    0:00:01.107890075  1252    0x16050 INFO           GST_PARENTAGE gstbin.c:3702:gst_bin_get_by_name: [pipeline0]: looking up child element mix
    0:00:01.107970000  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videobox0:(any) to mix:mix (0/0) with caps "(nil)"
    0:00:01.108022519  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videobox0:(any) to element mix:(any)
    0:00:01.124738111  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<mix> adding pad 'sink_1'
    0:00:01.124869259  1252    0x16050 INFO                 default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:01.125027741  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videobox0 and mix in same bin, no need for ghost pads
    0:00:01.125125185  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videobox0:src and mix:sink_1
    0:00:01.154900592  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videobox0:src and mix:sink_1, successful
    0:00:01.155083185  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videotestsrc1:(any) to videobox1:(any) (0/0) with caps "(nil)"
    0:00:01.155147852  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videotestsrc1:(any) to element videobox1:(any)
    0:00:01.155387149  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link videotestsrc1:src and videobox1:sink
    0:00:01.201080889  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videotestsrc1 and videobox1 in same bin, no need for ghost pads
    0:00:01.201234556  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videotestsrc1:src and videobox1:sink
    0:00:01.246809482  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videotestsrc1:src and videobox1:sink, successful
    Setting pipeline to PAUSED ...
    0:00:01.249270593  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<udpsink0> completed state change to READY
    0:00:01.249346667  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<udpsink0> posting state-changed NULL to READY
    0:00:01.249515074  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'udpsink0' changed state to 2(READY) successfully
    0:00:01.249596334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<rtph264pay0> completed state change to READY
    0:00:01.249643593  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<rtph264pay0> posting state-changed NULL to READY
    0:00:01.249712186  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'rtph264pay0' changed state to 2(READY) successfully
    0:00:01.249775371  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<perf0> completed state change to READY
    0:00:01.249820445  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<perf0> posting state-changed NULL to READY
    0:00:01.249881778  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'perf0' changed state to 2(READY) successfully
    0:00:01.249953482  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<h264parse0> completed state change to READY
    0:00:01.250001260  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<h264parse0> posting state-changed NULL to READY
    0:00:01.250064852  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully
    0:00:01.250126000  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<queue0> completed state change to READY
    0:00:01.250169260  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<queue0> posting state-changed NULL to READY
    0:00:01.250229778  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'queue0' changed state to 2(READY) successfully
    0:00:01.250291556  1252    0x16050 INFO                     omx gstomx_base_filter.c:153:change_state:<omxh264enc0> begin: changing state NULL -> READY
    0:00:02.307487038  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<omxh264enc0> completed state change to READY
    0:00:02.307607482  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<omxh264enc0> posting state-changed NULL to READY
    0:00:02.307720667  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'omxh264enc0' changed state to 2(READY) successfully
    0:00:02.307814334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<ffmpegcsp0> completed state change to READY
    0:00:02.307862963  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<ffmpegcsp0> posting state-changed NULL to READY
    0:00:02.307930075  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'ffmpegcsp0' changed state to 2(READY) successfully
    0:00:02.308005334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<mix> completed state change to READY
    0:00:02.308051408  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<mix> posting state-changed NULL to READY
    0:00:02.308113704  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'mix' changed state to 2(READY) successfully
    0:00:02.308180112  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox0> completed state change to READY
    0:00:02.308224593  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox0> posting state-changed NULL to READY
    0:00:02.308289223  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox0' changed state to 2(READY) successfully
    0:00:02.308351482  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox1> completed state change to READY
    0:00:02.308396112  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox1> posting state-changed NULL to READY
    0:00:02.308457926  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox1' changed state to 2(READY) successfully
    0:00:02.308513297  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc0> completed state change to READY
    0:00:02.308556704  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc0> posting state-changed NULL to READY
    0:00:02.308617926  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 2(READY) successfully
    0:00:02.308672000  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc1> completed state change to READY
    0:00:02.308714963  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc1> posting state-changed NULL to READY
    0:00:02.308778037  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc1' changed state to 2(READY) successfully
    0:00:02.308882260  1252    0x16050 INFO              GST_STATES gstelement.c:2314:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PAUSED, next PAUSED
    0:00:02.309939408  1252    0x16050 INFO              GST_STATES gstelement.c:2323:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PAUSED
    0:00:02.310286741  1252    0x16050 INFO              GST_STATES gstbin.c:2498:gst_bin_change_state_func:<pipeline0> child 'udpsink0' is changing state asynchronously to PAUSED
    0:00:02.310407482  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<rtph264pay0> completed state change to PAUSED
    0:00:02.310461000  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<rtph264pay0> posting state-changed READY to PAUSED
    0:00:02.310534371  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'rtph264pay0' changed state to 3(PAUSED) successfully
    0:00:02.310631148  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<perf0> completed state change to PAUSED
    0:00:02.310680334  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<perf0> posting state-changed READY to PAUSED
    0:00:02.310745630  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'perf0' changed state to 3(PAUSED) successfully
    0:00:02.310822704  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<h264parse0> completed state change to PAUSED
    0:00:02.315653964  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<h264parse0> posting state-changed READY to PAUSED
    0:00:02.315881927  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 3(PAUSED) successfully
    0:00:02.316547889  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<queue0> completed state change to PAUSED
    0:00:02.316625778  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<queue0> posting state-changed READY to PAUSED
    0:00:02.316765075  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'queue0' changed state to 3(PAUSED) successfully
    0:00:02.316846186  1252    0x16050 INFO                     omx gstomx_base_filter.c:153:change_state:<omxh264enc0> begin: changing state READY -> PAUSED
    0:00:02.316914112  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<omxh264enc0> completed state change to PAUSED
    0:00:02.316959556  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<omxh264enc0> posting state-changed READY to PAUSED
    0:00:02.317026964  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'omxh264enc0' changed state to 3(PAUSED) successfully
    0:00:02.317110630  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<ffmpegcsp0> completed state change to PAUSED
    0:00:02.317156815  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<ffmpegcsp0> posting state-changed READY to PAUSED
    0:00:02.317219741  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'ffmpegcsp0' changed state to 3(PAUSED) successfully
    0:00:02.317324334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<mix> completed state change to PAUSED
    0:00:02.317374260  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<mix> posting state-changed READY to PAUSED
    0:00:02.317438149  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'mix' changed state to 3(PAUSED) successfully
    0:00:02.317519408  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox0> completed state change to PAUSED
    0:00:02.317566482  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox0> posting state-changed READY to PAUSED
    0:00:02.317628556  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox0' changed state to 3(PAUSED) successfully
    0:00:02.317704778  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox1> completed state change to PAUSED
    0:00:02.317750297  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox1> posting state-changed READY to PAUSED
    0:00:02.317812334  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox1' changed state to 3(PAUSED) successfully
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.369780482  1252    0x16050 INFO               GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.370250667  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc0> completed state change to PAUSED
    0:00:02.370324223  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc0> posting state-changed READY to PAUSED
    0:00:02.370407593  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 3(PAUSED) successfully
    0:00:02.380459593  1252   0x244ed8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.380721148  1252   0x244ed8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.380778926  1252   0x244ed8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.401502593  1252   0x244ed8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.401592519  1252   0x244ed8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.401646296  1252   0x244ed8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.401768000  1252   0x244ed8 INFO           basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<videobox0> reuse caps
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.415707704  1252   0x244ed8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.415792038  1252   0x244ed8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.415847704  1252   0x244ed8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.415973593  1252   0x244ed8 INFO           basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<videobox0> reuse caps
    0:00:02.416096890  1252   0x244ed8 INFO              videomixer videomixer.c:350:gst_videomixer_pad_sink_setcaps:<mix:sink_1> Setting caps 0x20c2e0
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_1: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.444239741  1252    0x16050 INFO               GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.444728444  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc1> completed state change to PAUSED
    0:00:02.444801333  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc1> posting state-changed READY to PAUSED
    0:00:02.444881778  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc1' changed state to 3(PAUSED) successfully
    Pipeline is PREROLLING ...
    0:00:02.465149852  1252   0x1e96e8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x259900
    0:00:02.465388112  1252   0x1e96e8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x259920
    0:00:02.465453630  1252   0x1e96e8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x259900
    0:00:02.485315186  1252   0x1e96e8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x243860
    0:00:02.485406482  1252   0x1e96e8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x243880
    0:00:02.485464741  1252   0x1e96e8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x243860
    /GstPipeline:pipeline0/GstVideoBox:videobox1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstVideoBox:videobox1.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.503721704  1252   0x1e96e8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x259960
    0:00:02.503810778  1252   0x1e96e8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x259980
    0:00:02.503871148  1252   0x1e96e8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x259960
    0:00:02.508404852  1252   0x1e96e8 INFO              videomixer videomixer.c:350:gst_videomixer_pad_sink_setcaps:<mix:sink_0> Setting caps 0x259960
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_0: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    0:00:02.508908482  1252   0x1e96e8 INFO              videomixer videomixer.c:1356:gst_videomixer_fill_queues:<mix> _sending play segment
    0:00:02.508971593  1252   0x1e96e8 INFO               GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.509128074  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:290:pad_event:<omxh264enc0> begin: event=newsegment
    0:00:02.509179371  1252   0x1e96e8 INFO                     omx gstomx_base_filter.c:729:pad_event:<omxh264enc0> begin: event=newsegment
    0:00:02.509413149  1252   0x1e96e8 INFO              videomixer videomixer.c:1025:gst_videomixer_setcaps:<mix> set src caps: 0x259900
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstFFMpegCsp:ffmpegcsp0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)NV12, width=(int)720, height=(int)240, framerate=(fraction)30/1, color-matrix=(string)sdtv, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstFFMpegCsp:ffmpegcsp0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    0:00:02.556132038  1252   0x1e96e8 INFO         GST_PERFORMANCE imgconvert.c:3736:img_convert: no direct path to convert colorspace from ayuv4444 -> nv12
    0:00:02.569144371  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:139:sink_setcaps:<omxh264enc0> setcaps (sink): 0x262380
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)NV12, width=(int)720, height=(int)240, framerate=(fraction)30/1, color-matrix=(string)sdtv, pixel-aspect-ratio=(fraction)1/1
    0:00:02.570756482  1252   0x1e96e8 INFO                     omx gstomx_base_filter.c:594:pad_chain:<omxh264enc0> omx: prepare
    0:00:02.570815926  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:203:omx_setup:<omxh264enc0> begin
    0:00:02.578191630  1252   0x1e96e8 INFO                     omx gstomx_h264enc.c:620:omx_setup:<omxh264enc0> begin
    0:00:02.578701852  1252   0x1e96e8 WARN                     omx gstomx_h264enc.c:636:omx_setup:<omxh264enc0> 'OMX.TI.VideoEncode.Config.NALFormat' unsupported
    0:00:02.580173704  1252   0x1e96e8 INFO                     omx gstomx_h264enc.c:670:omx_setup:<omxh264enc0> end
    0:00:02.580221889  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:278:omx_setup:<omxh264enc0> end
    0:00:02.583565963  1252   0x1e96e8 WARN                     omx gstomx_base_filter.c:871:buffer_alloc:<omxh264enc0> faking settings changed notification
    0:00:02.584542407  1252   0x1e96e8 INFO                     omx gstomx_h264enc.c:706:settings_changed_cb:<omxh264enc0> caps are: 0x262360
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:src: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    0:00:02.601345074  1252   0x1e96e8 INFO                     omx gstomx_base_filter.c:626:pad_chain:<omxh264enc0> omx: play
    /GstPipeline:pipeline0/GstQueue:queue0.GstPad:sink: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    /GstPipeline:pipeline0/GstQueue:queue0.GstPad:src: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    /GstPipeline:pipeline0/GstH264Parse:h264parse0.GstPad:sink: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    0:00:02.684919852  1252   0x1e96e8 INFO         GST_PERFORMANCE imgconvert.c:3736:img_convert: no direct path to convert colorspace from ayuv4444 -> nv12

    root@dm816x-evm:~# gst-launch --gst-debug=3 -v videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf 
    ! rtph264pay ! udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. v
    ideotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix.
    0:00:00.012735778  1252    0x16050 INFO                GST_INIT gstquery.c:108:_gst_query_initialize: init queries
    0:00:00.017022334  1252    0x16050 INFO                GST_INIT gstmessage.c:73:_gst_message_initialize: init messages
    0:00:00.018001482  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:350:_gst_plugin_initialize: registering 0 static plugins
    0:00:00.018733926  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:255:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.018818112  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:257:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.024792926  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1599:ensure_current_registry: reading registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
    0:00:00.110929926  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:614:gst_registry_binary_read_cache: loaded /home/root/.gstreamer-0.10/registry.arm.bin in 0.085992 seconds
    0:00:00.111271111  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1469:scan_and_update_registry: Validating plugins from registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
    0:00:00.116271890  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1219:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-0.10/libgstlibvisual.so is stale
    0:00:00.212009704  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1219:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-0.10/libgstfrei0r.so is stale
    0:00:00.233117815  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1570:scan_and_update_registry: Registry cache changed. Writing new registry cache
    0:00:00.233243519  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:364:gst_registry_binary_write_cache: Building binary registry cache image
    0:00:00.279287667  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:396:gst_registry_binary_write_cache: Writing binary registry cache
    0:00:00.510030630  1252    0x16050 INFO            GST_REGISTRY gstregistrybinary.c:258:gst_registry_binary_cache_finish: Wrote binary registry cache
    0:00:00.510155889  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1578:scan_and_update_registry: Registry cache written successfully
    0:00:00.510201260  1252    0x16050 INFO            GST_REGISTRY gstregistry.c:1628:ensure_current_registry: registry reading and updating done, result = 1
    0:00:00.510239556  1252    0x16050 INFO                GST_INIT gst.c:792:init_post: GLib runtime version: 2.24.1
    0:00:00.510281889  1252    0x16050 INFO                GST_INIT gst.c:794:init_post: GLib headers version: 2.24.1
    0:00:00.510524815  1252    0x16050 INFO            GST_PIPELINE gstparse.c:299:gst_parse_launch_full: parsing pipeline description 'videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf ! rtph264pay ! udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. videotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix. '
    0:00:00.526849075  1252    0x16050 INFO              videomixer videomixer.c:614:_do_init: GstChildProxy interface registered
    0:00:00.527064482  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideomixer.so" loaded
    0:00:00.527127038  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videomixer"
    0:00:00.530575482  1252    0x16050 INFO              videomixer videomixer.c:649:gst_videomixer_child_proxy_init: intializing child proxy interface
    0:00:00.530868222  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstVideoMixer@0x1f3008> adding pad 'src'
    0:00:00.531161111  1252    0x16050 INFO                 default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:00.560349815  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstffmpegcolorspace.so" loaded
    0:00:00.560461111  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "ffmpegcolorspace"
    0:00:00.564098407  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202010> adding pad 'sink'
    0:00:00.564309926  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202010> adding pad 'src'
    0:00:00.837094001  1252    0x16050 INFO                     omx gstomx_videomixer.c:2183:init_interfaces: GstChildProxy interface registered
    0:00:00.837342075  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstomx.so" loaded
    0:00:00.837466482  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "omx_h264enc"
    0:00:00.840060445  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstOmxBaseFilter@0x2070d8> adding pad 'sink'
    0:00:00.840271519  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstOmxBaseFilter@0x2070d8> adding pad 'src'
    0:00:00.931624000  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
    0:00:00.931762037  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "queue"
    0:00:00.932566185  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x20a090> adding pad 'sink'
    0:00:00.932784667  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x20a090> adding pad 'src'
    0:00:00.940039889  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgsth264parse.so" loaded
    0:00:00.940146926  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "h264parse"
    0:00:00.940876408  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstH264Parse@0x20ba00> adding pad 'sink'
    0:00:00.941129445  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstH264Parse@0x20ba00> adding pad 'src'
    0:00:00.941389741  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "gstperf"
    0:00:00.941811741  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x212000> adding pad 'sink'
    0:00:00.941955148  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x212000> adding pad 'src'
    0:00:01.008796223  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstrtp.so" loaded
    0:00:01.008916852  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "rtph264pay"
    0:00:01.009747852  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseRTPPayload@0x221020> adding pad 'src'
    0:00:01.009912445  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseRTPPayload@0x221020> adding pad 'sink'
    0:00:01.021702371  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstudp.so" loaded
    0:00:01.021814334  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "udpsink"
    0:00:01.022889556  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x2260c0> adding pad 'sink'
    0:00:01.036118112  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideotestsrc.so" loaded
    0:00:01.036229186  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videotestsrc"
    0:00:01.039581260  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x23a178> adding pad 'src'
    0:00:01.048710149  1252    0x16050 INFO      GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideobox.so" loaded
    0:00:01.048814741  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videobox"
    0:00:01.052508667  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202250> adding pad 'sink'
    0:00:01.052720037  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202250> adding pad 'src'
    0:00:01.053138815  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videotestsrc"
    0:00:01.053324519  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x23a400> adding pad 'src'
    0:00:01.053487667  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videobox"
    0:00:01.053639185  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202490> adding pad 'sink'
    0:00:01.053768222  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202490> adding pad 'src'
    0:00:01.054022074  1252    0x16050 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "pipeline"
    0:00:01.054689259  1252    0x16050 INFO           GST_PARENTAGE gstbin.c:3702:gst_bin_get_by_name: [pipeline0]: looking up child element mix
    0:00:01.054808296  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videobox1:(any) to mix:mix (0/0) with caps "(nil)"
    0:00:01.054897963  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videobox1:(any) to element mix:(any)
    0:00:01.056347556  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<mix> adding pad 'sink_0'
    0:00:01.056476001  1252    0x16050 INFO                 default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:01.056624445  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videobox1 and mix in same bin, no need for ghost pads
    0:00:01.056776297  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videobox1:src and mix:sink_0
    0:00:01.057288038  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videobox1:src and mix:sink_0, successful
    0:00:01.057415741  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking mix:(any) to ffmpegcsp0:(any) (0/0) with caps "(nil)"
    0:00:01.057473260  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element mix:(any) to element ffmpegcsp0:(any)
    0:00:01.057533408  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link mix:src and ffmpegcsp0:sink
    0:00:01.058039000  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: mix and ffmpegcsp0 in same bin, no need for ghost pads
    0:00:01.058125741  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link mix:src and ffmpegcsp0:sink
    0:00:01.058577815  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked mix:src and ffmpegcsp0:sink, successful
    0:00:01.058673112  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking ffmpegcsp0:(any) to omxh264enc0:(any) (0/0) with caps "(nil)"
    0:00:01.058726149  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element ffmpegcsp0:(any) to element omxh264enc0:(any)
    0:00:01.058779445  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link ffmpegcsp0:src and omxh264enc0:sink
    0:00:01.079175519  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: ffmpegcsp0 and omxh264enc0 in same bin, no need for ghost pads
    0:00:01.079322704  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link ffmpegcsp0:src and omxh264enc0:sink
    0:00:01.099356074  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked ffmpegcsp0:src and omxh264enc0:sink, successful
    0:00:01.099504074  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking omxh264enc0:(any) to queue0:(any) (0/0) with caps "(nil)"
    0:00:01.099563852  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element omxh264enc0:(any) to element queue0:(any)
    0:00:01.099625371  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link omxh264enc0:src and queue0:sink
    0:00:01.099701593  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: omxh264enc0 and queue0 in same bin, no need for ghost pads
    0:00:01.099782667  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link omxh264enc0:src and queue0:sink
    0:00:01.099839630  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked omxh264enc0:src and queue0:sink, successful
    0:00:01.099924482  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking queue0:(any) to h264parse0:(any) (0/0) with caps "(nil)"
    0:00:01.099974223  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element queue0:(any) to element h264parse0:(any)
    0:00:01.100023778  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link queue0:src and h264parse0:sink
    0:00:01.100100186  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: queue0 and h264parse0 in same bin, no need for ghost pads
    0:00:01.100170519  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link queue0:src and h264parse0:sink
    0:00:01.100258334  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked queue0:src and h264parse0:sink, successful
    0:00:01.100345148  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking h264parse0:(any) to perf0:(any) (0/0) with caps "(nil)"
    0:00:01.100393630  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element h264parse0:(any) to element perf0:(any)
    0:00:01.100444778  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link h264parse0:src and perf0:sink
    0:00:01.100500556  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: h264parse0 and perf0 in same bin, no need for ghost pads
    0:00:01.100567519  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link h264parse0:src and perf0:sink
    0:00:01.100623371  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked h264parse0:src and perf0:sink, successful
    0:00:01.100720334  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking perf0:(any) to rtph264pay0:(any) (0/0) with caps "(nil)"
    0:00:01.100771000  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element perf0:(any) to element rtph264pay0:(any)
    0:00:01.100822630  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link perf0:src and rtph264pay0:sink
    0:00:01.100900889  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: perf0 and rtph264pay0 in same bin, no need for ghost pads
    0:00:01.100971482  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link perf0:src and rtph264pay0:sink
    0:00:01.101047222  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked perf0:src and rtph264pay0:sink, successful
    0:00:01.101131222  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking rtph264pay0:(any) to udpsink0:(any) (0/0) with caps "(nil)"
    0:00:01.101179297  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element rtph264pay0:(any) to element udpsink0:(any)
    0:00:01.101234222  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link rtph264pay0:src and udpsink0:sink
    0:00:01.101300667  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: rtph264pay0 and udpsink0 in same bin, no need for ghost pads
    0:00:01.101375556  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link rtph264pay0:src and udpsink0:sink
    0:00:01.101430926  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked rtph264pay0:src and udpsink0:sink, successful
    0:00:01.105625704  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videotestsrc0:(any) to videobox0:(any) (0/0) with caps "(nil)"
    0:00:01.105695149  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videotestsrc0:(any) to element videobox0:(any)
    0:00:01.105849519  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link videotestsrc0:src and videobox0:sink
    0:00:01.106855334  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videotestsrc0 and videobox0 in same bin, no need for ghost pads
    0:00:01.106970075  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videotestsrc0:src and videobox0:sink
    0:00:01.107782519  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videotestsrc0:src and videobox0:sink, successful
    0:00:01.107890075  1252    0x16050 INFO           GST_PARENTAGE gstbin.c:3702:gst_bin_get_by_name: [pipeline0]: looking up child element mix
    0:00:01.107970000  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videobox0:(any) to mix:mix (0/0) with caps "(nil)"
    0:00:01.108022519  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videobox0:(any) to element mix:(any)
    0:00:01.124738111  1252    0x16050 INFO        GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<mix> adding pad 'sink_1'
    0:00:01.124869259  1252    0x16050 INFO                 default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:01.125027741  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videobox0 and mix in same bin, no need for ghost pads
    0:00:01.125125185  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videobox0:src and mix:sink_1
    0:00:01.154900592  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videobox0:src and mix:sink_1, successful
    0:00:01.155083185  1252    0x16050 INFO            GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videotestsrc1:(any) to videobox1:(any) (0/0) with caps "(nil)"
    0:00:01.155147852  1252    0x16050 INFO        GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videotestsrc1:(any) to element videobox1:(any)
    0:00:01.155387149  1252    0x16050 INFO                GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link videotestsrc1:src and videobox1:sink
    0:00:01.201080889  1252    0x16050 INFO                GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videotestsrc1 and videobox1 in same bin, no need for ghost pads
    0:00:01.201234556  1252    0x16050 INFO                GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videotestsrc1:src and videobox1:sink
    0:00:01.246809482  1252    0x16050 INFO                GST_PADS gstpad.c:2124:gst_pad_link_full: linked videotestsrc1:src and videobox1:sink, successful
    Setting pipeline to PAUSED ...
    0:00:01.249270593  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<udpsink0> completed state change to READY
    0:00:01.249346667  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<udpsink0> posting state-changed NULL to READY
    0:00:01.249515074  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'udpsink0' changed state to 2(READY) successfully
    0:00:01.249596334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<rtph264pay0> completed state change to READY
    0:00:01.249643593  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<rtph264pay0> posting state-changed NULL to READY
    0:00:01.249712186  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'rtph264pay0' changed state to 2(READY) successfully
    0:00:01.249775371  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<perf0> completed state change to READY
    0:00:01.249820445  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<perf0> posting state-changed NULL to READY
    0:00:01.249881778  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'perf0' changed state to 2(READY) successfully
    0:00:01.249953482  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<h264parse0> completed state change to READY
    0:00:01.250001260  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<h264parse0> posting state-changed NULL to READY
    0:00:01.250064852  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully
    0:00:01.250126000  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<queue0> completed state change to READY
    0:00:01.250169260  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<queue0> posting state-changed NULL to READY
    0:00:01.250229778  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'queue0' changed state to 2(READY) successfully
    0:00:01.250291556  1252    0x16050 INFO                     omx gstomx_base_filter.c:153:change_state:<omxh264enc0> begin: changing state NULL -> READY
    0:00:02.307487038  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<omxh264enc0> completed state change to READY
    0:00:02.307607482  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<omxh264enc0> posting state-changed NULL to READY
    0:00:02.307720667  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'omxh264enc0' changed state to 2(READY) successfully
    0:00:02.307814334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<ffmpegcsp0> completed state change to READY
    0:00:02.307862963  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<ffmpegcsp0> posting state-changed NULL to READY
    0:00:02.307930075  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'ffmpegcsp0' changed state to 2(READY) successfully
    0:00:02.308005334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<mix> completed state change to READY
    0:00:02.308051408  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<mix> posting state-changed NULL to READY
    0:00:02.308113704  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'mix' changed state to 2(READY) successfully
    0:00:02.308180112  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox0> completed state change to READY
    0:00:02.308224593  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox0> posting state-changed NULL to READY
    0:00:02.308289223  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox0' changed state to 2(READY) successfully
    0:00:02.308351482  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox1> completed state change to READY
    0:00:02.308396112  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox1> posting state-changed NULL to READY
    0:00:02.308457926  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox1' changed state to 2(READY) successfully
    0:00:02.308513297  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc0> completed state change to READY
    0:00:02.308556704  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc0> posting state-changed NULL to READY
    0:00:02.308617926  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 2(READY) successfully
    0:00:02.308672000  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc1> completed state change to READY
    0:00:02.308714963  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc1> posting state-changed NULL to READY
    0:00:02.308778037  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc1' changed state to 2(READY) successfully
    0:00:02.308882260  1252    0x16050 INFO              GST_STATES gstelement.c:2314:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PAUSED, next PAUSED
    0:00:02.309939408  1252    0x16050 INFO              GST_STATES gstelement.c:2323:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PAUSED
    0:00:02.310286741  1252    0x16050 INFO              GST_STATES gstbin.c:2498:gst_bin_change_state_func:<pipeline0> child 'udpsink0' is changing state asynchronously to PAUSED
    0:00:02.310407482  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<rtph264pay0> completed state change to PAUSED
    0:00:02.310461000  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<rtph264pay0> posting state-changed READY to PAUSED
    0:00:02.310534371  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'rtph264pay0' changed state to 3(PAUSED) successfully
    0:00:02.310631148  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<perf0> completed state change to PAUSED
    0:00:02.310680334  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<perf0> posting state-changed READY to PAUSED
    0:00:02.310745630  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'perf0' changed state to 3(PAUSED) successfully
    0:00:02.310822704  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<h264parse0> completed state change to PAUSED
    0:00:02.315653964  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<h264parse0> posting state-changed READY to PAUSED
    0:00:02.315881927  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 3(PAUSED) successfully
    0:00:02.316547889  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<queue0> completed state change to PAUSED
    0:00:02.316625778  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<queue0> posting state-changed READY to PAUSED
    0:00:02.316765075  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'queue0' changed state to 3(PAUSED) successfully
    0:00:02.316846186  1252    0x16050 INFO                     omx gstomx_base_filter.c:153:change_state:<omxh264enc0> begin: changing state READY -> PAUSED
    0:00:02.316914112  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<omxh264enc0> completed state change to PAUSED
    0:00:02.316959556  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<omxh264enc0> posting state-changed READY to PAUSED
    0:00:02.317026964  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'omxh264enc0' changed state to 3(PAUSED) successfully
    0:00:02.317110630  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<ffmpegcsp0> completed state change to PAUSED
    0:00:02.317156815  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<ffmpegcsp0> posting state-changed READY to PAUSED
    0:00:02.317219741  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'ffmpegcsp0' changed state to 3(PAUSED) successfully
    0:00:02.317324334  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<mix> completed state change to PAUSED
    0:00:02.317374260  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<mix> posting state-changed READY to PAUSED
    0:00:02.317438149  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'mix' changed state to 3(PAUSED) successfully
    0:00:02.317519408  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox0> completed state change to PAUSED
    0:00:02.317566482  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox0> posting state-changed READY to PAUSED
    0:00:02.317628556  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox0' changed state to 3(PAUSED) successfully
    0:00:02.317704778  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox1> completed state change to PAUSED
    0:00:02.317750297  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox1> posting state-changed READY to PAUSED
    0:00:02.317812334  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox1' changed state to 3(PAUSED) successfully
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.369780482  1252    0x16050 INFO               GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.370250667  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc0> completed state change to PAUSED
    0:00:02.370324223  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc0> posting state-changed READY to PAUSED
    0:00:02.370407593  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 3(PAUSED) successfully
    0:00:02.380459593  1252   0x244ed8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.380721148  1252   0x244ed8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.380778926  1252   0x244ed8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.401502593  1252   0x244ed8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.401592519  1252   0x244ed8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.401646296  1252   0x244ed8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.401768000  1252   0x244ed8 INFO           basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<videobox0> reuse caps
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.415707704  1252   0x244ed8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.415792038  1252   0x244ed8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.415847704  1252   0x244ed8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.415973593  1252   0x244ed8 INFO           basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<videobox0> reuse caps
    0:00:02.416096890  1252   0x244ed8 INFO              videomixer videomixer.c:350:gst_videomixer_pad_sink_setcaps:<mix:sink_1> Setting caps 0x20c2e0
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_1: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.444239741  1252    0x16050 INFO               GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.444728444  1252    0x16050 INFO              GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc1> completed state change to PAUSED
    0:00:02.444801333  1252    0x16050 INFO              GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc1> posting state-changed READY to PAUSED
    0:00:02.444881778  1252    0x16050 INFO              GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc1' changed state to 3(PAUSED) successfully
    Pipeline is PREROLLING ...
    0:00:02.465149852  1252   0x1e96e8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x259900
    0:00:02.465388112  1252   0x1e96e8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x259920
    0:00:02.465453630  1252   0x1e96e8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x259900
    0:00:02.485315186  1252   0x1e96e8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x243860
    0:00:02.485406482  1252   0x1e96e8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x243880
    0:00:02.485464741  1252   0x1e96e8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x243860
    /GstPipeline:pipeline0/GstVideoBox:videobox1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstVideoBox:videobox1.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.503721704  1252   0x1e96e8 INFO              videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x259960
    0:00:02.503810778  1252   0x1e96e8 INFO              videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x259980
    0:00:02.503871148  1252   0x1e96e8 INFO              videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x259960
    0:00:02.508404852  1252   0x1e96e8 INFO              videomixer videomixer.c:350:gst_videomixer_pad_sink_setcaps:<mix:sink_0> Setting caps 0x259960
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_0: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    0:00:02.508908482  1252   0x1e96e8 INFO              videomixer videomixer.c:1356:gst_videomixer_fill_queues:<mix> _sending play segment
    0:00:02.508971593  1252   0x1e96e8 INFO               GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.509128074  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:290:pad_event:<omxh264enc0> begin: event=newsegment
    0:00:02.509179371  1252   0x1e96e8 INFO                     omx gstomx_base_filter.c:729:pad_event:<omxh264enc0> begin: event=newsegment
    0:00:02.509413149  1252   0x1e96e8 INFO              videomixer videomixer.c:1025:gst_videomixer_setcaps:<mix> set src caps: 0x259900
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstFFMpegCsp:ffmpegcsp0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)NV12, width=(int)720, height=(int)240, framerate=(fraction)30/1, color-matrix=(string)sdtv, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstFFMpegCsp:ffmpegcsp0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    0:00:02.556132038  1252   0x1e96e8 INFO         GST_PERFORMANCE imgconvert.c:3736:img_convert: no direct path to convert colorspace from ayuv4444 -> nv12
    0:00:02.569144371  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:139:sink_setcaps:<omxh264enc0> setcaps (sink): 0x262380
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)NV12, width=(int)720, height=(int)240, framerate=(fraction)30/1, color-matrix=(string)sdtv, pixel-aspect-ratio=(fraction)1/1
    0:00:02.570756482  1252   0x1e96e8 INFO                     omx gstomx_base_filter.c:594:pad_chain:<omxh264enc0> omx: prepare
    0:00:02.570815926  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:203:omx_setup:<omxh264enc0> begin
    0:00:02.578191630  1252   0x1e96e8 INFO                     omx gstomx_h264enc.c:620:omx_setup:<omxh264enc0> begin
    0:00:02.578701852  1252   0x1e96e8 WARN                     omx gstomx_h264enc.c:636:omx_setup:<omxh264enc0> 'OMX.TI.VideoEncode.Config.NALFormat' unsupported
    0:00:02.580173704  1252   0x1e96e8 INFO                     omx gstomx_h264enc.c:670:omx_setup:<omxh264enc0> end
    0:00:02.580221889  1252   0x1e96e8 INFO                     omx gstomx_base_videoenc.c:278:omx_setup:<omxh264enc0> end
    0:00:02.583565963  1252   0x1e96e8 WARN                     omx gstomx_base_filter.c:871:buffer_alloc:<omxh264enc0> faking settings changed notification
    0:00:02.584542407  1252   0x1e96e8 INFO                     omx gstomx_h264enc.c:706:settings_changed_cb:<omxh264enc0> caps are: 0x262360
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:src: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    0:00:02.601345074  1252   0x1e96e8 INFO                     omx gstomx_base_filter.c:626:pad_chain:<omxh264enc0> omx: play
    /GstPipeline:pipeline0/GstQueue:queue0.GstPad:sink: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    /GstPipeline:pipeline0/GstQueue:queue0.GstPad:src: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    /GstPipeline:pipeline0/GstH264Parse:h264parse0.GstPad:sink: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    0:00:02.684919852  1252   0x1e96e8 INFO         GST_PERFORMANCE imgconvert.c:3736:img_convert: no direct path to convert colorspace from ayuv4444 -> nv12
    
    

  • hello ma'am, here is the log i got.

    root@dm816x-evm:~# gst-launch --gst-debug=3 -v videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf
    ! rtph264pay ! udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. v
    ideotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix.
    0:00:00.012735778 1252 0x16050 INFO GST_INIT gstquery.c:108:_gst_query_initialize: init queries
    0:00:00.017022334 1252 0x16050 INFO GST_INIT gstmessage.c:73:_gst_message_initialize: init messages
    0:00:00.018001482 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:350:_gst_plugin_initialize: registering 0 static plugins
    0:00:00.018733926 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:255:gst_plugin_register_static: registered static plugin "staticelements"
    0:00:00.018818112 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:257:gst_plugin_register_static: added static plugin "staticelements", result: 1
    0:00:00.024792926 1252 0x16050 INFO GST_REGISTRY gstregistry.c:1599:ensure_current_registry: reading registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
    0:00:00.110929926 1252 0x16050 INFO GST_REGISTRY gstregistrybinary.c:614:gst_registry_binary_read_cache: loaded /home/root/.gstreamer-0.10/registry.arm.bin in 0.085992 seconds
    0:00:00.111271111 1252 0x16050 INFO GST_REGISTRY gstregistry.c:1469:scan_and_update_registry: Validating plugins from registry cache: /home/root/.gstreamer-0.10/registry.arm.bin
    0:00:00.116271890 1252 0x16050 INFO GST_REGISTRY gstregistry.c:1219:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-0.10/libgstlibvisual.so is stale
    0:00:00.212009704 1252 0x16050 INFO GST_REGISTRY gstregistry.c:1219:gst_registry_scan_path_level:<registry0> cached info for /usr/lib/gstreamer-0.10/libgstfrei0r.so is stale
    0:00:00.233117815 1252 0x16050 INFO GST_REGISTRY gstregistry.c:1570:scan_and_update_registry: Registry cache changed. Writing new registry cache
    0:00:00.233243519 1252 0x16050 INFO GST_REGISTRY gstregistrybinary.c:364:gst_registry_binary_write_cache: Building binary registry cache image
    0:00:00.279287667 1252 0x16050 INFO GST_REGISTRY gstregistrybinary.c:396:gst_registry_binary_write_cache: Writing binary registry cache
    0:00:00.510030630 1252 0x16050 INFO GST_REGISTRY gstregistrybinary.c:258:gst_registry_binary_cache_finish: Wrote binary registry cache
    0:00:00.510155889 1252 0x16050 INFO GST_REGISTRY gstregistry.c:1578:scan_and_update_registry: Registry cache written successfully
    0:00:00.510201260 1252 0x16050 INFO GST_REGISTRY gstregistry.c:1628:ensure_current_registry: registry reading and updating done, result = 1
    0:00:00.510239556 1252 0x16050 INFO GST_INIT gst.c:792:init_post: GLib runtime version: 2.24.1
    0:00:00.510281889 1252 0x16050 INFO GST_INIT gst.c:794:init_post: GLib headers version: 2.24.1
    0:00:00.510524815 1252 0x16050 INFO GST_PIPELINE gstparse.c:299:gst_parse_launch_full: parsing pipeline description 'videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf ! rtph264pay ! udpsink port=4000 host=172.20.216.12 sync=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. videotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix. '
    0:00:00.526849075 1252 0x16050 INFO videomixer videomixer.c:614:_do_init: GstChildProxy interface registered
    0:00:00.527064482 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideomixer.so" loaded
    0:00:00.527127038 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videomixer"
    0:00:00.530575482 1252 0x16050 INFO videomixer videomixer.c:649:gst_videomixer_child_proxy_init: intializing child proxy interface
    0:00:00.530868222 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstVideoMixer@0x1f3008> adding pad 'src'
    0:00:00.531161111 1252 0x16050 INFO default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:00.560349815 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstffmpegcolorspace.so" loaded
    0:00:00.560461111 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "ffmpegcolorspace"
    0:00:00.564098407 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202010> adding pad 'sink'
    0:00:00.564309926 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202010> adding pad 'src'
    0:00:00.837094001 1252 0x16050 INFO omx gstomx_videomixer.c:2183:init_interfaces: GstChildProxy interface registered
    0:00:00.837342075 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstomx.so" loaded
    0:00:00.837466482 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "omx_h264enc"
    0:00:00.840060445 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstOmxBaseFilter@0x2070d8> adding pad 'sink'
    0:00:00.840271519 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstOmxBaseFilter@0x2070d8> adding pad 'src'
    0:00:00.931624000 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstcoreelements.so" loaded
    0:00:00.931762037 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "queue"
    0:00:00.932566185 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x20a090> adding pad 'sink'
    0:00:00.932784667 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstQueue@0x20a090> adding pad 'src'
    0:00:00.940039889 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgsth264parse.so" loaded
    0:00:00.940146926 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "h264parse"
    0:00:00.940876408 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstH264Parse@0x20ba00> adding pad 'sink'
    0:00:00.941129445 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstH264Parse@0x20ba00> adding pad 'src'
    0:00:00.941389741 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "gstperf"
    0:00:00.941811741 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x212000> adding pad 'sink'
    0:00:00.941955148 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x212000> adding pad 'src'
    0:00:01.008796223 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstrtp.so" loaded
    0:00:01.008916852 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "rtph264pay"
    0:00:01.009747852 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseRTPPayload@0x221020> adding pad 'src'
    0:00:01.009912445 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseRTPPayload@0x221020> adding pad 'sink'
    0:00:01.021702371 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstudp.so" loaded
    0:00:01.021814334 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "udpsink"
    0:00:01.022889556 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSink@0x2260c0> adding pad 'sink'
    0:00:01.036118112 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideotestsrc.so" loaded
    0:00:01.036229186 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videotestsrc"
    0:00:01.039581260 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x23a178> adding pad 'src'
    0:00:01.048710149 1252 0x16050 INFO GST_PLUGIN_LOADING gstplugin.c:859:gst_plugin_load_file: plugin "/usr/lib/gstreamer-0.10/libgstvideobox.so" loaded
    0:00:01.048814741 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videobox"
    0:00:01.052508667 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202250> adding pad 'sink'
    0:00:01.052720037 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202250> adding pad 'src'
    0:00:01.053138815 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videotestsrc"
    0:00:01.053324519 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseSrc@0x23a400> adding pad 'src'
    0:00:01.053487667 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "videobox"
    0:00:01.053639185 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202490> adding pad 'sink'
    0:00:01.053768222 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<GstBaseTransform@0x202490> adding pad 'src'
    0:00:01.054022074 1252 0x16050 INFO GST_ELEMENT_FACTORY gstelementfactory.c:371:gst_element_factory_create: creating element "pipeline"
    0:00:01.054689259 1252 0x16050 INFO GST_PARENTAGE gstbin.c:3702:gst_bin_get_by_name: [pipeline0]: looking up child element mix
    0:00:01.054808296 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videobox1:(any) to mix:mix (0/0) with caps "(nil)"
    0:00:01.054897963 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videobox1:(any) to element mix:(any)
    0:00:01.056347556 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<mix> adding pad 'sink_0'
    0:00:01.056476001 1252 0x16050 INFO default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:01.056624445 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videobox1 and mix in same bin, no need for ghost pads
    0:00:01.056776297 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videobox1:src and mix:sink_0
    0:00:01.057288038 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked videobox1:src and mix:sink_0, successful
    0:00:01.057415741 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking mix:(any) to ffmpegcsp0:(any) (0/0) with caps "(nil)"
    0:00:01.057473260 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element mix:(any) to element ffmpegcsp0:(any)
    0:00:01.057533408 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link mix:src and ffmpegcsp0:sink
    0:00:01.058039000 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: mix and ffmpegcsp0 in same bin, no need for ghost pads
    0:00:01.058125741 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link mix:src and ffmpegcsp0:sink
    0:00:01.058577815 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked mix:src and ffmpegcsp0:sink, successful
    0:00:01.058673112 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking ffmpegcsp0:(any) to omxh264enc0:(any) (0/0) with caps "(nil)"
    0:00:01.058726149 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element ffmpegcsp0:(any) to element omxh264enc0:(any)
    0:00:01.058779445 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link ffmpegcsp0:src and omxh264enc0:sink
    0:00:01.079175519 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: ffmpegcsp0 and omxh264enc0 in same bin, no need for ghost pads
    0:00:01.079322704 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link ffmpegcsp0:src and omxh264enc0:sink
    0:00:01.099356074 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked ffmpegcsp0:src and omxh264enc0:sink, successful
    0:00:01.099504074 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking omxh264enc0:(any) to queue0:(any) (0/0) with caps "(nil)"
    0:00:01.099563852 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element omxh264enc0:(any) to element queue0:(any)
    0:00:01.099625371 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link omxh264enc0:src and queue0:sink
    0:00:01.099701593 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: omxh264enc0 and queue0 in same bin, no need for ghost pads
    0:00:01.099782667 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link omxh264enc0:src and queue0:sink
    0:00:01.099839630 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked omxh264enc0:src and queue0:sink, successful
    0:00:01.099924482 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking queue0:(any) to h264parse0:(any) (0/0) with caps "(nil)"
    0:00:01.099974223 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element queue0:(any) to element h264parse0:(any)
    0:00:01.100023778 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link queue0:src and h264parse0:sink
    0:00:01.100100186 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: queue0 and h264parse0 in same bin, no need for ghost pads
    0:00:01.100170519 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link queue0:src and h264parse0:sink
    0:00:01.100258334 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked queue0:src and h264parse0:sink, successful
    0:00:01.100345148 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking h264parse0:(any) to perf0:(any) (0/0) with caps "(nil)"
    0:00:01.100393630 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element h264parse0:(any) to element perf0:(any)
    0:00:01.100444778 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link h264parse0:src and perf0:sink
    0:00:01.100500556 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: h264parse0 and perf0 in same bin, no need for ghost pads
    0:00:01.100567519 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link h264parse0:src and perf0:sink
    0:00:01.100623371 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked h264parse0:src and perf0:sink, successful
    0:00:01.100720334 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking perf0:(any) to rtph264pay0:(any) (0/0) with caps "(nil)"
    0:00:01.100771000 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element perf0:(any) to element rtph264pay0:(any)
    0:00:01.100822630 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link perf0:src and rtph264pay0:sink
    0:00:01.100900889 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: perf0 and rtph264pay0 in same bin, no need for ghost pads
    0:00:01.100971482 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link perf0:src and rtph264pay0:sink
    0:00:01.101047222 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked perf0:src and rtph264pay0:sink, successful
    0:00:01.101131222 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking rtph264pay0:(any) to udpsink0:(any) (0/0) with caps "(nil)"
    0:00:01.101179297 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element rtph264pay0:(any) to element udpsink0:(any)
    0:00:01.101234222 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link rtph264pay0:src and udpsink0:sink
    0:00:01.101300667 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: rtph264pay0 and udpsink0 in same bin, no need for ghost pads
    0:00:01.101375556 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link rtph264pay0:src and udpsink0:sink
    0:00:01.101430926 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked rtph264pay0:src and udpsink0:sink, successful
    0:00:01.105625704 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videotestsrc0:(any) to videobox0:(any) (0/0) with caps "(nil)"
    0:00:01.105695149 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videotestsrc0:(any) to element videobox0:(any)
    0:00:01.105849519 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link videotestsrc0:src and videobox0:sink
    0:00:01.106855334 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videotestsrc0 and videobox0 in same bin, no need for ghost pads
    0:00:01.106970075 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videotestsrc0:src and videobox0:sink
    0:00:01.107782519 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked videotestsrc0:src and videobox0:sink, successful
    0:00:01.107890075 1252 0x16050 INFO GST_PARENTAGE gstbin.c:3702:gst_bin_get_by_name: [pipeline0]: looking up child element mix
    0:00:01.107970000 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videobox0:(any) to mix:mix (0/0) with caps "(nil)"
    0:00:01.108022519 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videobox0:(any) to element mix:(any)
    0:00:01.124738111 1252 0x16050 INFO GST_ELEMENT_PADS gstelement.c:716:gst_element_add_pad:<mix> adding pad 'sink_1'
    0:00:01.124869259 1252 0x16050 INFO default gstchildproxy.c:209:gst_child_proxy_lookup: no param spec named port-index
    0:00:01.125027741 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videobox0 and mix in same bin, no need for ghost pads
    0:00:01.125125185 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videobox0:src and mix:sink_1
    0:00:01.154900592 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked videobox0:src and mix:sink_1, successful
    0:00:01.155083185 1252 0x16050 INFO GST_PIPELINE ./grammar.y:568:gst_parse_perform_link: linking videotestsrc1:(any) to videobox1:(any) (0/0) with caps "(nil)"
    0:00:01.155147852 1252 0x16050 INFO GST_ELEMENT_PADS gstutils.c:1568:gst_element_link_pads_full: trying to link element videotestsrc1:(any) to element videobox1:(any)
    0:00:01.155387149 1252 0x16050 INFO GST_PADS gstutils.c:1028:gst_pad_check_link: trying to link videotestsrc1:src and videobox1:sink
    0:00:01.201080889 1252 0x16050 INFO GST_PADS gstutils.c:1468:prepare_link_maybe_ghosting: videotestsrc1 and videobox1 in same bin, no need for ghost pads
    0:00:01.201234556 1252 0x16050 INFO GST_PADS gstpad.c:1941:gst_pad_link_prepare: trying to link videotestsrc1:src and videobox1:sink
    0:00:01.246809482 1252 0x16050 INFO GST_PADS gstpad.c:2124:gst_pad_link_full: linked videotestsrc1:src and videobox1:sink, successful
    Setting pipeline to PAUSED ...
    0:00:01.249270593 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<udpsink0> completed state change to READY
    0:00:01.249346667 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<udpsink0> posting state-changed NULL to READY
    0:00:01.249515074 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'udpsink0' changed state to 2(READY) successfully
    0:00:01.249596334 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<rtph264pay0> completed state change to READY
    0:00:01.249643593 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<rtph264pay0> posting state-changed NULL to READY
    0:00:01.249712186 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'rtph264pay0' changed state to 2(READY) successfully
    0:00:01.249775371 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<perf0> completed state change to READY
    0:00:01.249820445 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<perf0> posting state-changed NULL to READY
    0:00:01.249881778 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'perf0' changed state to 2(READY) successfully
    0:00:01.249953482 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<h264parse0> completed state change to READY
    0:00:01.250001260 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<h264parse0> posting state-changed NULL to READY
    0:00:01.250064852 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully
    0:00:01.250126000 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<queue0> completed state change to READY
    0:00:01.250169260 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<queue0> posting state-changed NULL to READY
    0:00:01.250229778 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'queue0' changed state to 2(READY) successfully
    0:00:01.250291556 1252 0x16050 INFO omx gstomx_base_filter.c:153:change_state:<omxh264enc0> begin: changing state NULL -> READY
    0:00:02.307487038 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<omxh264enc0> completed state change to READY
    0:00:02.307607482 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<omxh264enc0> posting state-changed NULL to READY
    0:00:02.307720667 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'omxh264enc0' changed state to 2(READY) successfully
    0:00:02.307814334 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<ffmpegcsp0> completed state change to READY
    0:00:02.307862963 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<ffmpegcsp0> posting state-changed NULL to READY
    0:00:02.307930075 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'ffmpegcsp0' changed state to 2(READY) successfully
    0:00:02.308005334 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<mix> completed state change to READY
    0:00:02.308051408 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<mix> posting state-changed NULL to READY
    0:00:02.308113704 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'mix' changed state to 2(READY) successfully
    0:00:02.308180112 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox0> completed state change to READY
    0:00:02.308224593 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox0> posting state-changed NULL to READY
    0:00:02.308289223 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox0' changed state to 2(READY) successfully
    0:00:02.308351482 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox1> completed state change to READY
    0:00:02.308396112 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox1> posting state-changed NULL to READY
    0:00:02.308457926 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox1' changed state to 2(READY) successfully
    0:00:02.308513297 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc0> completed state change to READY
    0:00:02.308556704 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc0> posting state-changed NULL to READY
    0:00:02.308617926 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 2(READY) successfully
    0:00:02.308672000 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc1> completed state change to READY
    0:00:02.308714963 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc1> posting state-changed NULL to READY
    0:00:02.308778037 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc1' changed state to 2(READY) successfully
    0:00:02.308882260 1252 0x16050 INFO GST_STATES gstelement.c:2314:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PAUSED, next PAUSED
    0:00:02.309939408 1252 0x16050 INFO GST_STATES gstelement.c:2323:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PAUSED
    0:00:02.310286741 1252 0x16050 INFO GST_STATES gstbin.c:2498:gst_bin_change_state_func:<pipeline0> child 'udpsink0' is changing state asynchronously to PAUSED
    0:00:02.310407482 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<rtph264pay0> completed state change to PAUSED
    0:00:02.310461000 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<rtph264pay0> posting state-changed READY to PAUSED
    0:00:02.310534371 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'rtph264pay0' changed state to 3(PAUSED) successfully
    0:00:02.310631148 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<perf0> completed state change to PAUSED
    0:00:02.310680334 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<perf0> posting state-changed READY to PAUSED
    0:00:02.310745630 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'perf0' changed state to 3(PAUSED) successfully
    0:00:02.310822704 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<h264parse0> completed state change to PAUSED
    0:00:02.315653964 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<h264parse0> posting state-changed READY to PAUSED
    0:00:02.315881927 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 3(PAUSED) successfully
    0:00:02.316547889 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<queue0> completed state change to PAUSED
    0:00:02.316625778 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<queue0> posting state-changed READY to PAUSED
    0:00:02.316765075 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'queue0' changed state to 3(PAUSED) successfully
    0:00:02.316846186 1252 0x16050 INFO omx gstomx_base_filter.c:153:change_state:<omxh264enc0> begin: changing state READY -> PAUSED
    0:00:02.316914112 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<omxh264enc0> completed state change to PAUSED
    0:00:02.316959556 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<omxh264enc0> posting state-changed READY to PAUSED
    0:00:02.317026964 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'omxh264enc0' changed state to 3(PAUSED) successfully
    0:00:02.317110630 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<ffmpegcsp0> completed state change to PAUSED
    0:00:02.317156815 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<ffmpegcsp0> posting state-changed READY to PAUSED
    0:00:02.317219741 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'ffmpegcsp0' changed state to 3(PAUSED) successfully
    0:00:02.317324334 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<mix> completed state change to PAUSED
    0:00:02.317374260 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<mix> posting state-changed READY to PAUSED
    0:00:02.317438149 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'mix' changed state to 3(PAUSED) successfully
    0:00:02.317519408 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox0> completed state change to PAUSED
    0:00:02.317566482 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox0> posting state-changed READY to PAUSED
    0:00:02.317628556 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox0' changed state to 3(PAUSED) successfully
    0:00:02.317704778 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videobox1> completed state change to PAUSED
    0:00:02.317750297 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videobox1> posting state-changed READY to PAUSED
    0:00:02.317812334 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videobox1' changed state to 3(PAUSED) successfully
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.369780482 1252 0x16050 INFO GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.370250667 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc0> completed state change to PAUSED
    0:00:02.370324223 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc0> posting state-changed READY to PAUSED
    0:00:02.370407593 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc0' changed state to 3(PAUSED) successfully
    0:00:02.380459593 1252 0x244ed8 INFO videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.380721148 1252 0x244ed8 INFO videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.380778926 1252 0x244ed8 INFO videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.401502593 1252 0x244ed8 INFO videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.401592519 1252 0x244ed8 INFO videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.401646296 1252 0x244ed8 INFO videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.401768000 1252 0x244ed8 INFO basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<videobox0> reuse caps
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.415707704 1252 0x244ed8 INFO videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> vscaps: 0x20c2e0
    0:00:02.415792038 1252 0x244ed8 INFO videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> acceptedCaps: 0x134e60
    0:00:02.415847704 1252 0x244ed8 INFO videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_1> accepted caps 0x20c2e0
    0:00:02.415973593 1252 0x244ed8 INFO basetransform gstbasetransform.c:1148:gst_base_transform_setcaps:<videobox0> reuse caps
    0:00:02.416096890 1252 0x244ed8 INFO videomixer videomixer.c:350:gst_videomixer_pad_sink_setcaps:<mix:sink_1> Setting caps 0x20c2e0
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_1: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.444239741 1252 0x16050 INFO GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.444728444 1252 0x16050 INFO GST_STATES gstelement.c:2341:gst_element_continue_state:<videotestsrc1> completed state change to PAUSED
    0:00:02.444801333 1252 0x16050 INFO GST_STATES gstelement.c:2354:gst_element_continue_state:<videotestsrc1> posting state-changed READY to PAUSED
    0:00:02.444881778 1252 0x16050 INFO GST_STATES gstbin.c:2492:gst_bin_change_state_func:<pipeline0> child 'videotestsrc1' changed state to 3(PAUSED) successfully
    Pipeline is PREROLLING ...
    0:00:02.465149852 1252 0x1e96e8 INFO videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x259900
    0:00:02.465388112 1252 0x1e96e8 INFO videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x259920
    0:00:02.465453630 1252 0x1e96e8 INFO videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x259900
    0:00:02.485315186 1252 0x1e96e8 INFO videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x243860
    0:00:02.485406482 1252 0x1e96e8 INFO videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x243880
    0:00:02.485464741 1252 0x1e96e8 INFO videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x243860
    /GstPipeline:pipeline0/GstVideoBox:videobox1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstVideoBox:videobox1.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    0:00:02.503721704 1252 0x1e96e8 INFO videomixer videomixer.c:481:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> vscaps: 0x259960
    0:00:02.503810778 1252 0x1e96e8 INFO videomixer videomixer.c:482:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> acceptedCaps: 0x259980
    0:00:02.503871148 1252 0x1e96e8 INFO videomixer videomixer.c:486:gst_videomixer_pad_sink_acceptcaps:<mix:sink_0> accepted caps 0x259960
    0:00:02.508404852 1252 0x1e96e8 INFO videomixer videomixer.c:350:gst_videomixer_pad_sink_setcaps:<mix:sink_0> Setting caps 0x259960
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_0: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    0:00:02.508908482 1252 0x1e96e8 INFO videomixer videomixer.c:1356:gst_videomixer_fill_queues:<mix> _sending play segment
    0:00:02.508971593 1252 0x1e96e8 INFO GST_EVENT gstevent.c:600:gst_event_new_new_segment_full: creating newsegment update 0, rate 1.000000, format GST_FORMAT_TIME, start 0:00:00.000000000, stop 99:99:99.999999999, position 0:00:00.000000000
    0:00:02.509128074 1252 0x1e96e8 INFO omx gstomx_base_videoenc.c:290:pad_event:<omxh264enc0> begin: event=newsegment
    0:00:02.509179371 1252 0x1e96e8 INFO omx gstomx_base_filter.c:729:pad_event:<omxh264enc0> begin: event=newsegment
    0:00:02.509413149 1252 0x1e96e8 INFO videomixer videomixer.c:1025:gst_videomixer_setcaps:<mix> set src caps: 0x259900
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstFFMpegCsp:ffmpegcsp0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)NV12, width=(int)720, height=(int)240, framerate=(fraction)30/1, color-matrix=(string)sdtv, pixel-aspect-ratio=(fraction)1/1
    /GstPipeline:pipeline0/GstFFMpegCsp:ffmpegcsp0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)720, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    0:00:02.556132038 1252 0x1e96e8 INFO GST_PERFORMANCE imgconvert.c:3736:img_convert: no direct path to convert colorspace from ayuv4444 -> nv12
    0:00:02.569144371 1252 0x1e96e8 INFO omx gstomx_base_videoenc.c:139:sink_setcaps:<omxh264enc0> setcaps (sink): 0x262380
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)NV12, width=(int)720, height=(int)240, framerate=(fraction)30/1, color-matrix=(string)sdtv, pixel-aspect-ratio=(fraction)1/1
    0:00:02.570756482 1252 0x1e96e8 INFO omx gstomx_base_filter.c:594:pad_chain:<omxh264enc0> omx: prepare
    0:00:02.570815926 1252 0x1e96e8 INFO omx gstomx_base_videoenc.c:203:omx_setup:<omxh264enc0> begin
    0:00:02.578191630 1252 0x1e96e8 INFO omx gstomx_h264enc.c:620:omx_setup:<omxh264enc0> begin
    0:00:02.578701852 1252 0x1e96e8 WARN omx gstomx_h264enc.c:636:omx_setup:<omxh264enc0> 'OMX.TI.VideoEncode.Config.NALFormat' unsupported
    0:00:02.580173704 1252 0x1e96e8 INFO omx gstomx_h264enc.c:670:omx_setup:<omxh264enc0> end
    0:00:02.580221889 1252 0x1e96e8 INFO omx gstomx_base_videoenc.c:278:omx_setup:<omxh264enc0> end
    0:00:02.583565963 1252 0x1e96e8 WARN omx gstomx_base_filter.c:871:buffer_alloc:<omxh264enc0> faking settings changed notification
    0:00:02.584542407 1252 0x1e96e8 INFO omx gstomx_h264enc.c:706:settings_changed_cb:<omxh264enc0> caps are: 0x262360
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:src: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    0:00:02.601345074 1252 0x1e96e8 INFO omx gstomx_base_filter.c:626:pad_chain:<omxh264enc0> omx: play
    /GstPipeline:pipeline0/GstQueue:queue0.GstPad:sink: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    /GstPipeline:pipeline0/GstQueue:queue0.GstPad:src: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    /GstPipeline:pipeline0/GstH264Parse:h264parse0.GstPad:sink: caps = video/x-h264, width=(int)720, height=(int)240, framerate=(fraction)30/1, stream-format=(string)byte-stream, alignment=(string)au
    0:00:02.684919852 1252 0x1e96e8 INFO GST_PERFORMANCE imgconvert.c:3736:img_convert: no direct path to convert colorspace from ayuv4444 -> nv12



    BR
    Ajay
  • Hello,

    There is nothing in gst log could you run the UIA as well:

    ./loggerSMDump.out 0x9e400000 0x100000 all

    and save in file this log.

    This is avilable at /usr/share/ti/ti-uia folder in filesystem.

    What is the difference between your custom board and EVM?

    I check the pipeline it is working on EVM.

    BR
    Margarita

  • Hello ma'am

    when i run ./loggerSMDump.out 0x9e400000 0x100000 all , it is not terminating automatically. it is still waiting for a long time. so i terminated the process by CTRL+C. here is the log below

    root@dm816x-evm:/usr/share/ti/ti-uia# ./loggerSMDump.out 0x9e400000 0x100000 all
    Opened loggerSM.bin to store encoded records
    N:Video P:1 #:00000 T:0000000001a6ca1b M:xdc.runtime.Main S:Enabling Status Logger
    N:VPSS P:2 #:00000 T:0000000043c57d07 M:xdc.runtime.Main S:Enabling Status Logger
    N:Video P:1 #:00001 T:0000000001a72b05 M:xdc.runtime.Main S:Enabling User1 Logs
    N:VPSS P:2 #:00001 T:0000000043c5deff M:xdc.runtime.Main S:Enabling User1 Logs
    N:Video P:1 #:00002 T:0000000001a796f3 M:xdc.runtime.Main S:Disabling User1 Logs
    N:VPSS P:2 #:00002 T:0000000043c64759 M:xdc.runtime.Main S:Disabling User1 Logs
    N:Video P:1 #:00003 T:0000000001a7f943 M:xdc.runtime.Main S:Disabling User1 Logs
    N:VPSS P:2 #:00003 T:0000000043c6a5f3 M:xdc.runtime.Main S:Disabling User1 Logs
    N:Video P:1 #:00004 T:0000000001a8586d M:xdc.runtime.Main S:Disabling User1 Logs
    N:VPSS P:2 #:00004 T:0000000043c70155 M:xdc.runtime.Main S:Disabling User1 Logs
    N:Video P:1 #:00005 T:0000000001a8ba53 M:xdc.runtime.Main S:Disabling User1 Logs
    N:VPSS P:2 #:00005 T:0000000043c75f7b M:xdc.runtime.Main S:Disabling User1 Logs
    N:Video P:1 #:00006 T:0000000001a91f07 M:xdc.runtime.Main S:Enabling Analysis Logs
    N:VPSS P:2 #:00006 T:0000000043c7bf97 M:xdc.runtime.Main S:Enabling Analysis Logs
    N:Video P:1 #:00007 T:0000000001abe8c3 M:xdc.runtime.Main S:Module<ti.omx> Entering<DomxCore_procAttach> @line<151>
    N:VPSS P:2 #:00007 T:0000000043cdea41 M:xdc.runtime.Main S:edma3init() Passed
    N:Video P:1 #:00008 T:00000000020363ad M:xdc.runtime.Main S:Module<ti.omx> @<DomxCore_procAttach> @line<177> msg<Before Ipc_attach>
    N:VPSS P:2 #:00008 T:0000000045c4d0b9 M:xdc.runtime.Main S:isI2cInitReq is 1
    N:Video P:1 #:00009 T:00000000085711c5 M:xdc.runtime.Main S:Module<ti.omx> @<DomxCore_procAttach> @line<184> msg<After Ipc_attach>
    N:VPSS P:2 #:00009 T:00000000db973ad3 M:xdc.runtime.Main S:Module<ti.omx> Entering<DomxCore_procAttach> @line<151>
    N:Video P:1 #:00010 T:000000000857a39d M:xdc.runtime.Main S:Module<ti.omx> @<DomxCore_procAttach> @line<186> msg<Ipc_attach successful>
    N:VPSS P:2 #:00010 T:00000000dc04bff3 M:xdc.runtime.Main S:Module<ti.omx> @<DomxCore_procAttach> @line<191> msg<Before Ipc_attach>
    N:Video P:1 #:00011 T:0000000008581877 M:xdc.runtime.Main S:Module<ti.omx> Leaving<DomxCore_procAttach> @line<233> with error<0:ErrorNone>
    N:VPSS P:2 #:00011 T:00000000e2107d11 M:xdc.runtime.Main S:Module<ti.omx> @<DomxCore_procAttach> @line<198> msg<After Ipc_attach>
    N:Video P:1 #:00012 T:00000000085ce6f7 M:xdc.runtime.Main S:Module<ti.omx> Entering<DomxCore_procInit> @line<250>
    N:VPSS P:2 #:00012 T:00000000e21122d3 M:xdc.runtime.Main S:Module<ti.omx> @<DomxCore_procAttach> @line<200> msg<Ipc_attach successful>
    N:Video P:1 #:00013 T:00000000085d54b1 M:xdc.runtime.Main S:Module<ti.omx> Entering<DomxCore_procMsgQInit> @line<115>
    N:VPSS P:2 #:00013 T:00000000e2119a77 M:xdc.runtime.Main S:Module<ti.omx> Leaving<DomxCore_procAttach> @line<233> with error<0:ErrorNone>
    N:Video P:1 #:00014 T:00000000085e0fc9 M:xdc.runtime.Main S:Module<ti.omx> @<OmxRpc_moduleRegisterMsgqHeap> @line<927> msg<Before MessageQ_registerHeap>
    N:VPSS P:2 #:00014 T:00000000e217115d M:xdc.runtime.Main S:Module<ti.omx> Entering<DomxCore_procInit> @line<250>
    N:Video P:1 #:00015 T:00000000085ec37b M:xdc.runtime.Main S:Module<ti.omx> @<OmxRpc_moduleRegisterMsgqHeap> @line<932> msg<After MessageQ_registerHeap>
    N:VPSS P:2 #:00015 T:00000000e21785ef M:xdc.runtime.Main S:Module<ti.omx> Entering<DomxCore_procMsgQInit> @line<115>
    N:Video P:1 #:00016 T:00000000085f430f M:xdc.runtime.Main S:Module<ti.omx> Leaving<DomxCore_procMsgQInit> @line<142> with error<0:ErrorNone>
    N:VPSS P:2 #:00016 T:00000000e2187493 M:xdc.runtime.Main S:Module<ti.omx> @<OmxRpc_moduleRegisterMsgqHeap> @line<927> msg<Before MessageQ_registerHeap>
    N:Video P:1 #:00017 T:00000000085fb8ff M:xdc.runtime.Main S:Module<ti.omx> Leaving<DomxCore_procInit> @line<346> with error<0:ErrorNone>
    N:VPSS P:2 #:00017 T:00000000e218f58b M:xdc.runtime.Main S:Module<ti.omx> @<OmxRpc_moduleRegisterMsgqHeap> @line<932> msg<After MessageQ_registerHeap>
    N:Video P:1 #:00018 T:0000000008605705 M:xdc.runtime.Main S:@ omxrpc_rcm_server_create: rcmServerName OmxRpcRcmServer_1, priority 8
    N:VPSS P:2 #:00018 T:00000000e2196f01 M:xdc.runtime.Main S:Module<ti.omx> Leaving<DomxCore_procMsgQInit> @line<142> with error<0:ErrorNone>
    N:Video P:1 #:00019 T:000000000860c90b M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<225> msg<Before RcmServer_Params_init>
    N:VPSS P:2 #:00019 T:00000000e219e0c3 M:xdc.runtime.Main S:Module<ti.omx> Leaving<DomxCore_procInit> @line<346> with error<0:ErrorNone>
    N:Video P:1 #:00020 T:0000000008614703 M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<229> msg<After RcmServer_Params_init>
    N:VPSS P:2 #:00020 T:00000000e21a7397 M:xdc.runtime.Main S:@ omxrpc_rcm_server_create: rcmServerName OmxRpcRcmServer_2, priority 8
    N:Video P:1 #:00021 T:000000000861c035 M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<232> msg<Before RcmServer_create>
    N:VPSS P:2 #:00021 T:00000000e21ae273 M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<225> msg<Before RcmServer_Params_init>
    N:Video P:1 #:00022 T:0000000008675dc7 M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<240> msg<After RcmServer_create>
    N:VPSS P:2 #:00022 T:00000000e21b639b M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<229> msg<After RcmServer_Params_init>
    N:Video P:1 #:00023 T:000000000867ea99 M:xdc.runtime.Main S:@ omxrpc_rcm_server_remote_fxn_register regFxnCategory 0
    N:VPSS P:2 #:00023 T:00000000e21bd869 M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<232> msg<Before RcmServer_create>
    N:Video P:1 #:00024 T:00000000086852ef M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcGetHandle)
    N:VPSS P:2 #:00024 T:00000000e221ccd7 M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_create> @line<240> msg<After RcmServer_create>
    N:Video P:1 #:00025 T:000000000868eb35 M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcFreeHandle)
    N:VPSS P:2 #:00025 T:00000000e2225cbf M:xdc.runtime.Main S:@ omxrpc_rcm_server_remote_fxn_register regFxnCategory 0
    N:Video P:1 #:00026 T:00000000086961bb M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcCreateProxyLite)
    N:VPSS P:2 #:00026 T:00000000e222c969 M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcGetHandle)
    N:Video P:1 #:00027 T:000000000869d657 M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcGetHeapMemStats)
    N:VPSS P:2 #:00027 T:00000000e2236b57 M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcFreeHandle)
    N:Video P:1 #:00028 T:00000000086a4da7 M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcDeleteProxyLite)
    N:VPSS P:2 #:00028 T:00000000e223f1bd M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcCreateProxyLite)
    N:Video P:1 #:00029 T:00000000086ac6af M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_start> @line<256> msg<Before RcmServer_start>
    N:VPSS P:2 #:00029 T:00000000e2247503 M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcGetHeapMemStats)
    N:Video P:1 #:00030 T:00000000086b4d6f M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_start> @line<258> msg<After RcmServer_start>
    N:VPSS P:2 #:00030 T:00000000e224f5ad M:xdc.runtime.Main S:Calling RcmServer_addSymbol(OmxRpcDeleteProxyLite)
    N:VPSS P:2 #:00031 T:00000000e2257dff M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_start> @line<256> msg<Before RcmServer_start>
    N:VPSS P:2 #:00032 T:00000000e225fddd M:xdc.runtime.Main S:Module<ti.omx> @<omxrpc_rcm_server_start> @line<258> msg<After RcmServer_start>
    ^C


    second observation is when run the same command again, i got below log. here is that log,
    root@dm816x-evm:/usr/share/ti/ti-uia# ./loggerSMDump.out 0x9e400000 0x100000 all
    Opened loggerSM.bin to store encoded records
    ^C


    but it is also not terminating automatically. I am not getting whether it is right or wrong. Pls help me resolve the issue.If you required more information pls let me know. i will provide whatever you want.

    Many thanks in advance ma'am.

    BR
    Ajay
  • Hallo Ajay,

    After execution "./loggerSMDump.out 0x9e400000 0x100000 all &" command you shall execute the pipeline.

    BR
    Margarita
  • Hello ma'am,


    Pls find the log attached here. still it is hanging means, is there any issue with video core processors...? . Pls help me to resolve this issue.

    N:Video P:1 #:00958 T:0000002e226ecfb5 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> @<OMX_BASE_CB_ReturnEventNotify> @line<158> msg<Notify client for error>
    N:VPSS  P:2 #:00707 T:0000002e26bdea95 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_PROCESS_CmdEvent> @line<631> msg<Processing OMX_CommandPortEnable>
    N:Video P:1 #:00959 T:0000002e226f552f M:xdc.runtime.Main S: hComponent: 0x9e011e10; EventHandler: 0x9e3a1dfd
    N:VPSS  P:2 #:00708 T:0000002e26be815b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_EnablePort> @line<777> 
    N:VPSS  P:2 #:00709 T:0000002e26bf0297 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_EnablePort> @line<815> with error<0:ErrorNone>
    N:Video P:1 #:00960 T:0000002e22731227 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00710 T:0000002e26c25efd M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:Video P:1 #:00962 T:0000002e2276df55 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00711 T:0000002e26c30381 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_CB_ReturnEventNotify> @line<121> msg<Notify client for port enable>
    N:Video P:1 #:00963 T:0000002e22778f45 M:xdc.runtime.Main S:OMX_TI_VIDDEC_Process::Line 2576::omxHandle 0x9e011e10::Error->Decoder returned error 0x1421
    N:VPSS  P:2 #:00712 T:0000002e26c39013 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:Video P:1 #:00961 T:0000002e22755de1 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:VPSS  P:2 #:00713 T:0000002e26c422df M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_PROCESS_CmdEvent> @line<784> with error<0:ErrorNone>
    N:Video P:1 #:00964 T:0000002e22787b7b M:xdc.runtime.Main S:OMX_TI_VIDDEC_CB_ProcessDone::Line 2929::omxHandle 0x9e011e10::Error->Decoder returned error 0x1421
    N:VPSS  P:2 #:00714 T:0000002e26c4af93 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:00965 T:0000002e227e4fe1 M:xdc.runtime.Main S:OMX_TI_VIDDEC_CB_ProcessDone::Line 2915::omxHandle 0x9e011e10::non duped buffer in freebufid error 0x1421 bufstatus 5
    N:VPSS  P:2 #:00715 T:0000002e26c54f09 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdCompleteEventHandler> @line<483> 
    N:Video P:1 #:00966 T:0000002e227f0c5d M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:VPSS  P:2 #:00716 T:0000002e26c5c4ed M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_PROCESS_CmdCompleteEvent> @line<809> 
    N:Video P:1 #:00967 T:0000002e227f8aeb M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> @<OMX_BASE_CB_ReturnEventNotify> @line<158> msg<Notify client for error>
    N:VPSS  P:2 #:00717 T:0000002e26c64c97 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_PROCESS_CmdCompleteEvent> @line<869> msg<Processing OMX_CommandPortEnable>
    N:Video P:1 #:00968 T:0000002e22800dfb M:xdc.runtime.Main S: hComponent: 0x9e011e10; EventHandler: 0x9e3a1dfd
    N:VPSS  P:2 #:00718 T:0000002e26c6de83 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_EventNotifyToClient> @line<881> 
    N:VPSS  P:2 #:00719 T:0000002e26e52099 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_EventNotifyToClient> @line<1172> with error<0:ErrorNone>
    N:Video P:1 #:00969 T:0000002e2283ae5b M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00721 T:0000002e26e814a1 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:00971 T:0000002e228770eb M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00722 T:0000002e26e8bf5d M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:00972 T:0000002e22881ebf M:xdc.runtime.Main S:OMX_TI_VIDDEC_Process::Line 2576::omxHandle 0x9e011e10::Error->Decoder returned error 0x1421
    N:VPSS  P:2 #:00720 T:0000002e26e5f2e7 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_PROCESS_CmdCompleteEvent> @line<930> with error<0:ErrorNone>
    N:Video P:1 #:00970 T:0000002e2285f8e3 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:VPSS  P:2 #:00723 T:0000002e26ea5a1f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdCompleteEventHandler> @line<496> with error<0:ErrorNone>
    N:Video P:1 #:00973 T:0000002e22890f47 M:xdc.runtime.Main S:OMX_TI_VIDDEC_CB_ProcessDone::Line 2929::omxHandle 0x9e011e10::Error->Decoder returned error 0x1421
    N:VPSS  P:2 #:00724 T:0000002e26eaf979 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:00974 T:0000002e228e5c15 M:xdc.runtime.Main S:OMX_TI_VIDDEC_CB_ProcessDone::Line 2915::omxHandle 0x9e011e10::non duped buffer in freebufid error 0x1421 bufstatus 5
    N:VPSS  P:2 #:00725 T:0000002e26ecf629 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_SetParameter> @line<890> 
    N:Video P:1 #:00975 T:0000002e228f0c2b M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:VPSS  P:2 #:00726 T:0000002e26ed9ba3 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_SetParameter> @line<1163> with error<0:ErrorNone>
    N:Video P:1 #:00976 T:0000002e228f8857 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> @<OMX_BASE_CB_ReturnEventNotify> @line<158> msg<Notify client for error>
    N:VPSS  P:2 #:00728 T:0000002e26f15cb3 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:00977 T:0000002e22900e99 M:xdc.runtime.Main S: hComponent: 0x9e011e10; EventHandler: 0x9e3a1dfd
    N:VPSS  P:2 #:00729 T:0000002e26f20b2f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:VPSS  P:2 #:00727 T:0000002e26ef6d5d M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:00978 T:0000002e2293c661 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00731 T:0000002e26f4f9b7 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:00979 T:0000002e2295ec39 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:VPSS  P:2 #:00732 T:0000002e26f5c65d M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:00980 T:0000002e2297821d M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00730 T:0000002e26f3b693 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:00981 T:0000002e22982c2f M:xdc.runtime.Main S:OMX_TI_VIDDEC_Process::Line 2576::omxHandle 0x9e011e10::Error->Decoder returned error 0x1421
    N:VPSS  P:2 #:00734 T:0000002e26f866ad M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:00982 T:0000002e2298ffad M:xdc.runtime.Main S:OMX_TI_VIDDEC_CB_ProcessDone::Line 2929::omxHandle 0x9e011e10::Error->Decoder returned error 0x1421
    N:VPSS  P:2 #:00735 T:0000002e26f8f013 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:00983 T:0000002e229ed019 M:xdc.runtime.Main S:OMX_TI_VIDDEC_CB_ProcessDone::Line 2915::omxHandle 0x9e011e10::non duped buffer in freebufid error 0x1421 bufstatus 5
    N:VPSS  P:2 #:00733 T:0000002e26f77725 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:00984 T:0000002e229f897f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:VPSS  P:2 #:00736 T:0000002e26fc605b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:00985 T:0000002e22a005dd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> @<OMX_BASE_CB_ReturnEventNotify> @line<158> msg<Notify client for error>
    N:VPSS  P:2 #:00737 T:0000002e26fd3dbf M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:00986 T:0000002e22a08819 M:xdc.runtime.Main S: hComponent: 0x9e011e10; EventHandler: 0x9e3a1dfd
    N:VPSS  P:2 #:00738 T:0000002e2700f42d M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:VPSS  P:2 #:00739 T:0000002e27019f4d M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:00987 T:0000002e22a456db M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00740 T:0000002e2705d8fb M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:00988 T:0000002e22a677f3 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDDEC> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:VPSS  P:2 #:00741 T:0000002e27068af3 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:00989 T:0000002e22a71f71 M:xdc.runtime.Main S:OMX_TI_VIDDEC_CB_ProcessDone::Line 2929::omxHandle 0x9e011e10::Error->Decoder returned error 0x1421
    N:VPSS  P:2 #:00742 T:0000002e272eaecf M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_SendCommand> @line<499> 
    N:Video P:1 #:00990 T:0000002e22b15ebd M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00743 T:0000002e272faf33 M:xdc.runtime.Main S:OMX_BASE_SendCommand:OMX_CommandStateSet, nParam1: 2
    N:Video P:1 #:00991 T:0000002e23313bb3 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00744 T:0000002e27317605 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_SendCommand> @line<669> with error<0:ErrorNone>
    N:Video P:1 #:00992 T:0000002e233e0df3 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00745 T:0000002e27355f3b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:00993 T:0000002e246a2a5d M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00746 T:0000002e2736166b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:00994 T:0000002e2476d693 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00747 T:0000002e2739a4a7 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:Video P:1 #:00995 T:0000002e25a49987 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00748 T:0000002e273b86c1 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_DIO_Init> @line<120> 
    N:Video P:1 #:00996 T:0000002e25b1ef21 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00749 T:0000002e273c0907 M:xdc.runtime.Main S:Entered: OMX_BASE_DIO_Init (0x9f258190, 0, OMX.DIO.NONTUNNEL, 0x9f257b34)
    N:Video P:1 #:00997 T:0000002e26609333 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00750 T:0000002e273d0175 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_DIO_Init> @line<172> with error<0:ErrorNone>
    N:Video P:1 #:00998 T:0000002e266df97f M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00751 T:0000002e273d909d M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_DIO_Open> @line<252> 
    N:Video P:1 #:00999 T:0000002e26922b1b M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00752 T:0000002e2741611f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_DIO_Open> @line<258> with error<0:ErrorNone>
    N:Video P:1 #:01000 T:0000002e269f4999 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00753 T:0000002e274565f1 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:Video P:1 #:01001 T:0000002e26be44b3 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00754 T:0000002e274ac263 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:Video P:1 #:01002 T:0000002e26cbd3d9 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00755 T:0000002e275005eb M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:Video P:1 #:01003 T:0000002e26ee37bb M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00756 T:0000002e275364fb M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:01004 T:0000002e26fb8565 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00757 T:0000002e275439b1 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_PROCESS_CmdEvent> @line<526> 
    N:Video P:1 #:01005 T:0000002e273122ed M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00758 T:0000002e2754ce3f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_PROCESS_CmdEvent> @line<538> msg<Processing OMX_CommandStateSet>
    N:Video P:1 #:01006 T:0000002e273e3bd7 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00759 T:0000002e27555a6b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_HandleStateTransition> @line<316> 
    N:Video P:1 #:01007 T:0000002e277cd77d M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00760 T:0000002e2755d08b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<_OMX_BASE_HandleStateTransition> @line<339> msg<Loaded to Idle Transition>
    N:Video P:1 #:01008 T:0000002e278ab541 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00761 T:0000002e275b4ead M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:VPSS  P:2 #:00762 T:0000002e275bdf4d M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_CB_ReturnEventNotify> @line<115> msg<Notify client for state transition>
    N:VPSS  P:2 #:00763 T:0000002e275c722f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:VPSS  P:2 #:00764 T:0000002e275cf781 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_HandleStateTransition> @line<483> with error<0:ErrorNone>
    N:VPSS  P:2 #:00765 T:0000002e275d7d2f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_PROCESS_CmdEvent> @line<784> with error<0:ErrorNone>
    N:VPSS  P:2 #:00766 T:0000002e275e01a3 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:VPSS  P:2 #:00767 T:0000002e275e8fd7 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdCompleteEventHandler> @line<483> 
    N:VPSS  P:2 #:00768 T:0000002e275f0295 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_PROCESS_CmdCompleteEvent> @line<809> 
    N:VPSS  P:2 #:00769 T:0000002e275f7bb1 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_PROCESS_CmdCompleteEvent> @line<821> msg<Processing OMX_CommandStateSet>
    N:VPSS  P:2 #:00770 T:0000002e2760030e M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_HandleStateTransitionComplete> @line<506> 
    N:VPSS  P:2 #:00771 T:0000002e2760b5bd M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<_OMX_BASE_HandleStateTransitionComplete> @line<535> msg<Loaded to Idle Transition>
    N:VPSS  P:2 #:00772 T:0000002e27615bdb M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_RestoreDioGroupInfo> @line<1398> 
    N:VPSS  P:2 #:00773 T:0000002e2761db9f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_RestoreDioGroupInfo> @line<1453> with error<0:ErrorNone>
    N:VPSS  P:2 #:00774 T:0000002e27625e03 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_HandleStateTransitionComplete> @line<704> with error<0:ErrorNone>
    N:VPSS  P:2 #:00775 T:0000002e2762e3a9 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_EventNotifyToClient> @line<881> 
    N:VPSS  P:2 #:00776 T:0000002e277953d5 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:VPSS  P:2 #:00777 T:0000002e277f3bd3 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:VPSS  P:2 #:00778 T:0000002e278506c7 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:VPSS  P:2 #:00779 T:0000002e278bb3f7 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:VPSS  P:2 #:00780 T:0000002e2790dcab M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_GetParameter> @line<695> 
    N:VPSS  P:2 #:00781 T:0000002e2791873f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:VPSS  P:2 #:00782 T:0000002e27957c43 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_allocbuffer
    N:VPSS  P:2 #:00783 T:0000002e27989563 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_DIO_Init> @line<120> 
    N:VPSS  P:2 #:00784 T:0000002e27992665 M:xdc.runtime.Main S:Entered: OMX_BASE_DIO_Init (0x9f258190, 16, OMX.DIO.NONTUNNEL, 0x9f257b24)
    N:Video P:1 #:01009 T:0000002e28220d2b M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00785 T:0000002e279a2c1f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_DIO_Init> @line<172> with error<0:ErrorNone>
    N:Video P:1 #:01010 T:0000002e282fdeaf M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00786 T:0000002e279ad64b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_DIO_Open> @line<252> 
    N:Video P:1 #:01011 T:0000002e2831ca17 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00787 T:0000002e27a4b157 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_DIO_Open> @line<258> with error<0:ErrorNone>
    N:Video P:1 #:01012 T:0000002e284022d7 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00788 T:0000002e27c4e3fb M:xdc.runtime.Main S:Entered Function :omxrpc_skel_allocbuffer
    N:VPSS  P:2 #:00789 T:0000002e27cad3c7 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_allocbuffer
    N:VPSS  P:2 #:00790 T:0000002e27d5698f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_SendCommand> @line<499> 
    N:VPSS  P:2 #:00791 T:0000002e27d65bed M:xdc.runtime.Main S:OMX_BASE_SendCommand:OMX_CommandStateSet, nParam1: 3
    N:VPSS  P:2 #:00792 T:0000002e27d6fb19 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_SendCommand> @line<669> with error<0:ErrorNone>
    N:VPSS  P:2 #:00793 T:0000002e27d83cd3 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_EventNotifyToClient> @line<1172> with error<0:ErrorNone>
    N:VPSS  P:2 #:00794 T:0000002e27d8d2ff M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_PROCESS_CmdCompleteEvent> @line<930> with error<0:ErrorNone>
    N:VPSS  P:2 #:00795 T:0000002e27d95b8f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdCompleteEventHandler> @line<496> with error<0:ErrorNone>
    N:VPSS  P:2 #:00796 T:0000002e27d9e81f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:VPSS  P:2 #:00797 T:0000002e27dabca9 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_PROCESS_CmdEvent> @line<526> 
    N:VPSS  P:2 #:00798 T:0000002e27dbd115 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_PROCESS_CmdEvent> @line<538> msg<Processing OMX_CommandStateSet>
    N:VPSS  P:2 #:00799 T:0000002e27dc5427 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_HandleStateTransition> @line<316> 
    N:VPSS  P:2 #:00800 T:0000002e27dcc837 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<_OMX_BASE_HandleStateTransition> @line<376> msg<Idle to Executing Transition>
    N:VPSS  P:2 #:00801 T:0000002e27dd9b71 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:VPSS  P:2 #:00802 T:0000002e27de18a9 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_CB_ReturnEventNotify> @line<115> msg<Notify client for state transition>
    N:VPSS  P:2 #:00803 T:0000002e27dea89b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:VPSS  P:2 #:00804 T:0000002e27df2c41 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_HandleStateTransition> @line<483> with error<0:ErrorNone>
    N:VPSS  P:2 #:00805 T:0000002e27dfb02b M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_PROCESS_CmdEvent> @line<784> with error<0:ErrorNone>
    N:VPSS  P:2 #:00806 T:0000002e27e030c3 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:VPSS  P:2 #:00807 T:0000002e27e0bd6f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdCompleteEventHandler> @line<483> 
    N:VPSS  P:2 #:00808 T:0000002e27e130e9 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_PROCESS_CmdCompleteEvent> @line<809> 
    N:VPSS  P:2 #:00809 T:0000002e27e1a8fb M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<OMX_BASE_PROCESS_CmdCompleteEvent> @line<821> msg<Processing OMX_CommandStateSet>
    N:VPSS  P:2 #:00810 T:0000002e27e2642f M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_HandleStateTransitionComplete> @line<506> 
    N:VPSS  P:2 #:00811 T:0000002e27e2e0ad M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> @<_OMX_BASE_HandleStateTransitionComplete> @line<614> msg<Idle to Executing Transition>
    N:VPSS  P:2 #:00812 T:0000002e27e369fc M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_HandleStateTransitionComplete> @line<704> with error<0:ErrorNone>
    N:VPSS  P:2 #:00813 T:0000002e27e3f206 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<_OMX_BASE_EventNotifyToClient> @line<881> 
    N:VPSS  P:2 #:00814 T:0000002e27ebd583 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_DIO_Control> @line<455> 
    N:VPSS  P:2 #:00815 T:0000002e27ef2073 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_DIO_Control> @line<463> with error<0:ErrorNone>
    N:VPSS  P:2 #:00816 T:0000002e27efbd19 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_DIO_Control> @line<455> 
    N:VPSS  P:2 #:00817 T:0000002e27f26465 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_DIO_Control> @line<463> with error<0:ErrorNone>
    N:Video P:1 #:01013 T:0000002e28667277 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:VPSS  P:2 #:00818 T:0000002e27f2ee19 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<_OMX_BASE_EventNotifyToClient> @line<1172> with error<0:ErrorNone>
    N:Video P:1 #:01014 T:0000002e28673d59 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:VPSS  P:2 #:00819 T:0000002e27f371d7 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_PROCESS_CmdCompleteEvent> @line<930> with error<0:ErrorNone>
    N:Video P:1 #:01015 T:0000002e288523df M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:VPSS  P:2 #:00820 T:0000002e27f3f2f9 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdCompleteEventHandler> @line<496> with error<0:ErrorNone>
    N:VPSS  P:2 #:00821 T:0000002e27f472e5 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:VPSS  P:2 #:00822 T:0000002e27f4ead5 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:01016 T:0000002e2891fb71 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:VPSS  P:2 #:00823 T:0000002e27f570c1 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:VPSS  P:2 #:00824 T:0000002e27f5e233 M:xdc.runtime.Main S:Module<OMX.TI.VPSSM3.VFPC.NF> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:sink: caps = video/x-raw-yuv, width=(int)1280, height=(int)720, format=(fourcc)NV12, framerate=(fraction)60/1
    N:Video P:1 #:01017 T:0000002e289ad0b9 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01018 T:0000002e289b9043 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01019 T:0000002e28a94377 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01020 T:0000002e28aa0881 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01021 T:0000002e28b496b3 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01022 T:0000002e28b54987 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01023 T:0000002e28bf0533 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_SendCommand> @line<499> 
    N:Video P:1 #:01024 T:0000002e28c01319 M:xdc.runtime.Main S:OMX_BASE_SendCommand:OMX_CommandPortEnable, nParam1: 0
    N:Video P:1 #:01025 T:0000002e28c0d8b5 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_SendCommand> @line<669> with error<0:ErrorNone>
    N:Video P:1 #:01026 T:0000002e28c283fd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:01027 T:0000002e28c34db1 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_PROCESS_CmdEvent> @line<526> 
    N:Video P:1 #:01028 T:0000002e28c3d627 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_PROCESS_CmdEvent> @line<631> msg<Processing OMX_CommandPortEnable>
    N:Video P:1 #:01029 T:0000002e28c48447 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<_OMX_BASE_EnablePort> @line<777> 
    N:Video P:1 #:01030 T:0000002e28c50c0f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<_OMX_BASE_EnablePort> @line<815> with error<0:ErrorNone>
    N:Video P:1 #:01031 T:0000002e28c87c39 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3856::VENC->Port Enable Begin
    N:Video P:1 #:01032 T:0000002e28c93d9d M:xdc.runtime.Main S:_OMX_TI_VIDENC_EnablePeriodicDataProcess::Line 5374::VENC->Enabled Notification based data processing
    N:Video P:1 #:01033 T:0000002e28c9c141 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3924::VENC->Port Enable End
    N:Video P:1 #:01034 T:0000002e28ca3601 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3936::VENC->Before OMX_EventCmdComplete Notify
    N:Video P:1 #:01035 T:0000002e28cab5df M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:Video P:1 #:01036 T:0000002e28cb4d83 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_CB_ReturnEventNotify> @line<121> msg<Notify client for port enable>
    N:Video P:1 #:01037 T:0000002e28cc060f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:Video P:1 #:01038 T:0000002e28cca361 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3942::VENC->OMX_EventCmdComplete Notify Done
    N:Video P:1 #:01039 T:0000002e28cd73b5 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_PROCESS_CmdEvent> @line<784> with error<0:ErrorNone>
    N:Video P:1 #:01040 T:0000002e28ce704f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:01041 T:0000002e28cf23f3 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdCompleteEventHandler> @line<483> 
    N:Video P:1 #:01042 T:0000002e28cfac3f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_PROCESS_CmdCompleteEvent> @line<809> 
    N:Video P:1 #:01043 T:0000002e28d03663 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_PROCESS_CmdCompleteEvent> @line<869> msg<Processing OMX_CommandPortEnable>
    N:Video P:1 #:01044 T:0000002e28d0d53f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<_OMX_BASE_EventNotifyToClient> @line<881> 
    N:Video P:1 #:01045 T:0000002e28d56d07 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_SendCommand> @line<499> 
    N:Video P:1 #:01046 T:0000002e28d666e9 M:xdc.runtime.Main S:OMX_BASE_SendCommand:OMX_CommandPortEnable, nParam1: 1
    N:Video P:1 #:01047 T:0000002e28d73165 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_SendCommand> @line<669> with error<0:ErrorNone>
    N:Video P:1 #:01048 T:0000002e28da9b73 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:Video P:1 #:01049 T:0000002e28dda0ed M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<_OMX_BASE_EventNotifyToClient> @line<1172> with error<0:ErrorNone>
    N:Video P:1 #:01050 T:0000002e28de5e61 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_PROCESS_CmdCompleteEvent> @line<930> with error<0:ErrorNone>
    N:Video P:1 #:01051 T:0000002e28def3ff M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CmdCompleteEventHandler> @line<496> with error<0:ErrorNone>
    N:Video P:1 #:01052 T:0000002e28dfaa3f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:01053 T:0000002e28e08f09 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_PROCESS_CmdEvent> @line<526> 
    N:Video P:1 #:01054 T:0000002e28e1297d M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_PROCESS_CmdEvent> @line<631> msg<Processing OMX_CommandPortEnable>
    N:Video P:1 #:01055 T:0000002e28e1e7e9 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<_OMX_BASE_EnablePort> @line<777> 
    N:Video P:1 #:01056 T:0000002e28e27cd7 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<_OMX_BASE_EnablePort> @line<815> with error<0:ErrorNone>
    N:Video P:1 #:01057 T:0000002e28e36def M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3856::VENC->Port Enable Begin
    N:Video P:1 #:01058 T:0000002e28e4004b M:xdc.runtime.Main S:_OMX_TI_VIDENC_EnablePeriodicDataProcess::Line 5374::VENC->Enabled Notification based data processing
    N:Video P:1 #:01059 T:0000002e28e4dba7 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3924::VENC->Port Enable End
    N:Video P:1 #:01060 T:0000002e28e55639 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3936::VENC->Before OMX_EventCmdComplete Notify
    N:Video P:1 #:01062 T:0000002e28e79a11 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:Video P:1 #:01061 T:0000002e28e5fde7 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:Video P:1 #:01063 T:0000002e28e8c5e5 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_CB_ReturnEventNotify> @line<121> msg<Notify client for port enable>
    N:Video P:1 #:01064 T:0000002e28e9757f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:Video P:1 #:01065 T:0000002e28e9fe2b M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3942::VENC->OMX_EventCmdComplete Notify Done
    N:Video P:1 #:01066 T:0000002e28ea9f1f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_PROCESS_CmdEvent> @line<784> with error<0:ErrorNone>
    N:Video P:1 #:01067 T:0000002e28eb2ee9 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:01068 T:0000002e28ebc2c5 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdCompleteEventHandler> @line<483> 
    N:Video P:1 #:01069 T:0000002e28ec795b M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_PROCESS_CmdCompleteEvent> @line<809> 
    N:Video P:1 #:01070 T:0000002e28ecf4fd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_PROCESS_CmdCompleteEvent> @line<869> msg<Processing OMX_CommandPortEnable>
    N:Video P:1 #:01071 T:0000002e28ed9033 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<_OMX_BASE_EventNotifyToClient> @line<881> 
    N:Video P:1 #:01072 T:0000002e2904bd73 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetExtensionIndex> @line<2094> 
    N:Video P:1 #:01073 T:0000002e29057dfb M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetExtensionIndex> @line<2095> with error<-2147479546:ErrorNotImplemented>
    N:Video P:1 #:01074 T:0000002e2907b1cb M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<_OMX_BASE_EventNotifyToClient> @line<1172> with error<0:ErrorNone>
    N:Video P:1 #:01075 T:0000002e290bb72d M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_PROCESS_CmdCompleteEvent> @line<930> with error<0:ErrorNone>
    N:Video P:1 #:01076 T:0000002e290c7bdd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CmdCompleteEventHandler> @line<496> with error<0:ErrorNone>
    N:Video P:1 #:01077 T:0000002e29106011 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:01078 T:0000002e29144cc7 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:01079 T:0000002e291a8191 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:01081 T:0000002e291d80dd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01082 T:0000002e291e27a1 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01080 T:0000002e291b320f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:01083 T:0000002e2924cd6f M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:Video P:1 #:01084 T:0000002e2931c8f5 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:Video P:1 #:01085 T:0000002e294771d1 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01086 T:0000002e29486243 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01087 T:0000002e294cfb2d M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01088 T:0000002e294db145 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01089 T:0000002e29534317 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01090 T:0000002e2953ed95 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01091 T:0000002e29590dcd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01092 T:0000002e295ac6d7 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01093 T:0000002e295fed85 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01094 T:0000002e2960a981 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01095 T:0000002e2964c305 M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:Video P:1 #:01096 T:0000002e2971a667 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    /GstPipeline:pipeline0/GstOmxH264Enc:omxh264enc0.GstPad:src: caps = video/x-h264, width=(int)1280, height=(int)720, framerate=(fraction)60/1, stream-format=(string)byte-stream, alignment=(string)au
    N:Video P:1 #:01097 T:0000002e2973299b M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:Video P:1 #:01098 T:0000002e297790db M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01099 T:0000002e29783fd9 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01100 T:0000002e2986eff1 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01101 T:0000002e2987a675 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01102 T:0000002e298aa6bb M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:Video P:1 #:01103 T:0000002e298c873f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_SendCommand> @line<499> 
    N:Video P:1 #:01104 T:0000002e298d7343 M:xdc.runtime.Main S:OMX_BASE_SendCommand:OMX_CommandStateSet, nParam1: 2
    N:Video P:1 #:01105 T:0000002e298e42bf M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_SendCommand> @line<669> with error<0:ErrorNone>
    N:Video P:1 #:01106 T:0000002e29919901 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01107 T:0000002e29923e5f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01108 T:0000002e29954a6d M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:Video P:1 #:01109 T:0000002e2996eac7 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_DIO_Init> @line<120> 
    N:Video P:1 #:01110 T:0000002e29976e73 M:xdc.runtime.Main S:Entered: OMX_BASE_DIO_Init (0x9dff2ab0, 0, OMX.DIO.NONTUNNEL, 0x9dff2424)
    N:Video P:1 #:01111 T:0000002e29987433 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_DIO_Init> @line<172> with error<0:ErrorNone>
    N:Video P:1 #:01112 T:0000002e29991961 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_DIO_Open> @line<252> 
    N:Video P:1 #:01113 T:0000002e299d4085 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_DIO_Open> @line<258> with error<0:ErrorNone>
    N:Video P:1 #:01114 T:0000002e29a26f6b M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:Video P:1 #:01115 T:0000002e29a7b539 M:xdc.runtime.Main S:Entered Function :omxrpc_skel_usebuffer
    N:Video P:1 #:01116 T:0000002e29ac15eb M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_GetParameter> @line<695> 
    N:Video P:1 #:01117 T:0000002e29acbad3 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_GetParameter> @line<858> with error<0:ErrorNone>
    N:Video P:1 #:01118 T:0000002e29af363b M:xdc.runtime.Main S:StartInstance: HDVICP_0 
    N:Video P:1 #:01119 T:0000002e29b0b78f M:xdc.runtime.Main S:Entered Function :omxrpc_skel_allocbuffer
    N:Video P:1 #:01120 T:0000002e29b26283 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_DIO_Init> @line<120> 
    N:Video P:1 #:01121 T:0000002e29b30807 M:xdc.runtime.Main S:Entered: OMX_BASE_DIO_Init (0x9dff2ab0, 1, OMX.DIO.NONTUNNEL, 0x9dff241c)
    N:Video P:1 #:01122 T:0000002e29b3e965 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_DIO_Init> @line<172> with error<0:ErrorNone>
    N:Video P:1 #:01123 T:0000002e29b46f1f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_DIO_Open> @line<252> 
    N:Video P:1 #:01124 T:0000002e29bd5aad M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_DIO_Open> @line<258> with error<0:ErrorNone>
    N:Video P:1 #:01125 T:0000002e29c0491f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdEventHandler> @line<434> 
    N:Video P:1 #:01126 T:0000002e29c12139 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_PROCESS_CmdEvent> @line<526> 
    N:Video P:1 #:01127 T:0000002e29c1f2ad M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_PROCESS_CmdEvent> @line<538> msg<Processing OMX_CommandStateSet>
    N:Video P:1 #:01128 T:0000002e29c286bd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<_OMX_BASE_HandleStateTransition> @line<316> 
    N:Video P:1 #:01129 T:0000002e29c3136d M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<_OMX_BASE_HandleStateTransition> @line<339> msg<Loaded to Idle Transition>
    N:Video P:1 #:01130 T:0000002e29c4029d M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3525::VENC->Loaded to Idle Transition Begin
    N:Video P:1 #:01131 T:0000002e29c49acd M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3529::VENC->Before VIDENC2_Create
    N:Video P:1 #:01132 T:0000002e29c52ab1 M:xdc.runtime.Main S:Calling VIDENC2_create for ivahd_h264enc_0
    N:Video P:1 #:01133 T:0000002e29cb5461 M:xdc.runtime.Main S:StopInstance: HDVICP_0 
    N:Video P:1 #:01134 T:0000002e29cd0f51 M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01135 T:0000002e29cd85ed M:xdc.runtime.Main S:accessDimension = 0, accessUnit = 1 sizeDim0 = 32896 sizeDim1 = 0 alignment = 32
    N:Video P:1 #:01136 T:0000002e29ce5e51 M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01137 T:0000002e29cec281 M:xdc.runtime.Main S:accessDimension = 0, accessUnit = 1 sizeDim0 = 18240 sizeDim1 = 0 alignment = 32
    N:Video P:1 #:01138 T:0000002e29cf70cd M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01139 T:0000002e29cfd271 M:xdc.runtime.Main S:accessDimension = 0, accessUnit = 1 sizeDim0 = 2960 sizeDim1 = 0 alignment = 32
    N:Video P:1 #:01140 T:0000002e29d085e1 M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01141 T:0000002e29d123a5 M:xdc.runtime.Main S:accessDimension = 0, accessUnit = 1 sizeDim0 = 36 sizeDim1 = 0 alignment = 32
    N:Video P:1 #:01142 T:0000002e29d1f025 M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01143 T:0000002e29d25b55 M:xdc.runtime.Main S:accessDimension = 1, accessUnit = 2 sizeDim0 = 1408 sizeDim1 = 784 alignment = 32
    N:Video P:1 #:01144 T:0000002e29d32309 M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01145 T:0000002e29d3879f M:xdc.runtime.Main S:accessDimension = 1, accessUnit = 3 sizeDim0 = 1408 sizeDim1 = 392 alignment = 32
    N:Video P:1 #:01146 T:0000002e29d4496b M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01147 T:0000002e29d4ab75 M:xdc.runtime.Main S:accessDimension = 1, accessUnit = 2 sizeDim0 = 1408 sizeDim1 = 784 alignment = 32
    N:Video P:1 #:01148 T:0000002e29d56a13 M:xdc.runtime.Main S:IRESMAN_TILEDMEMORY_getHandles_Plugin 285
    N:Video P:1 #:01149 T:0000002e29d5cc1d M:xdc.runtime.Main S:accessDimension = 1, accessUnit = 3 sizeDim0 = 1408 sizeDim1 = 392 alignment = 32
    N:Video P:1 #:01150 T:0000002e29d77eff M:xdc.runtime.Main S:VIDENC2_control(XDM_GETSTATUS) after VIDENC2_create returned errorcode = 0x0
    N:Video P:1 #:01151 T:0000002e29d9d893 M:xdc.runtime.Main S:VIDENC2_control(XDM_GETSTATUS) returned errorcode = 0x0
    N:Video P:1 #:01152 T:0000002e29da4d15 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3536::VENC->VIDENC2_Create Successful
    N:Video P:1 #:01153 T:0000002e29dac151 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3568::VENC->Before IvaServer_registerInstance
    N:Video P:1 #:01154 T:0000002e29db709b M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 665::Width 1280::Height 720::Resolution 3
    N:Video P:1 #:01155 T:0000002e29dc06af M:xdc.runtime.Main S:IvaScheduler_asssignStaticResource::Line 356::CodecId 0::Allocated IVAHD 1::Estimated IVAHD Load of Codec(MHz) 240::Total IVAHD load(MHz) 240
    N:Video P:1 #:01156 T:0000002e29dcabad M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 816::Scheduling Scheme 0
    N:Video P:1 #:01157 T:0000002e29dd13a1 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 818::Number of IVAHDs 3
    N:Video P:1 #:01158 T:0000002e29dd7d9b M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 820::Number of registered channels 3
    N:Video P:1 #:01159 T:0000002e29ddf0eb M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 825::IVAHD Queue 0::Number of channels 2
    N:Video P:1 #:01160 T:0000002e29de64df M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 827::IVAHD Queue 0::Number of frames 79
    N:Video P:1 #:01161 T:0000002e29dedb23 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 829::IVAHD Queue 0::Number of commands 0
    N:Video P:1 #:01162 T:0000002e29df50fb M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 831::IVAHD Queue 0::Last Codec Id 1
    N:Video P:1 #:01163 T:0000002e29dfc017 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 833::IVAHD Queue 0::Load(MHz) 90
    N:Video P:1 #:01164 T:0000002e29e05d2f M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 825::IVAHD Queue 1::Number of channels 1
    N:Video P:1 #:01166 T:0000002e29e1e2ed M:xdc.runtime.Main S:Entered Function :omxrpc_skel_allocbuffer
    N:Video P:1 #:01167 T:0000002e29e7baad M:xdc.runtime.Main S:Entered Function :omxrpc_skel_allocbuffer
    N:Video P:1 #:01165 T:0000002e29e0d4e1 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 827::IVAHD Queue 1::Number of frames 0
    N:Video P:1 #:01169 T:0000002e29eca1cd M:xdc.runtime.Main S:Entered Function :omxrpc_skel_allocbuffer
    N:Video P:1 #:01168 T:0000002e29eb24ef M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 829::IVAHD Queue 1::Number of commands 0
    N:Video P:1 #:01170 T:0000002e29ef46e5 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 831::IVAHD Queue 1::Last Codec Id 0
    N:Video P:1 #:01171 T:0000002e29efff61 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 833::IVAHD Queue 1::Load(MHz) 240
    N:Video P:1 #:01172 T:0000002e29f071a9 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 825::IVAHD Queue 2::Number of channels 0
    N:Video P:1 #:01173 T:0000002e29f0ea0b M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 827::IVAHD Queue 2::Number of frames 0
    N:Video P:1 #:01174 T:0000002e29f15ebd M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 829::IVAHD Queue 2::Number of commands 0
    N:Video P:1 #:01175 T:0000002e29f1d0cf M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 831::IVAHD Queue 2::Last Codec Id 0
    N:Video P:1 #:01176 T:0000002e29f24243 M:xdc.runtime.Main S:IvaScheduler_registerInstance::Line 833::IVAHD Queue 2::Load(MHz) 0
    N:Video P:1 #:01177 T:0000002e29f2c693 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3576::VENC->IvaServer_registerInstance Successful
    N:Video P:1 #:01178 T:0000002e29f38c5d M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3646::VENC->Loaded to Idle Transition End
    N:Video P:1 #:01179 T:0000002e29f4103b M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3936::VENC->Before OMX_EventCmdComplete Notify
    N:Video P:1 #:01180 T:0000002e29f49d65 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CB_ReturnEventNotify> @line<100> 
    N:Video P:1 #:01181 T:0000002e29f53855 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_CB_ReturnEventNotify> @line<115> msg<Notify client for state transition>
    N:Video P:1 #:01182 T:0000002e29f5eebd M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CB_ReturnEventNotify> @line<224> with error<0:ErrorNone>
    N:Video P:1 #:01183 T:0000002e29f68255 M:xdc.runtime.Main S:OMX_TI_VIDENC_CommandNotifyFromBase::Line 3942::VENC->OMX_EventCmdComplete Notify Done
    N:Video P:1 #:01184 T:0000002e29f9f809 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<_OMX_BASE_HandleStateTransition> @line<483> with error<0:ErrorNone>
    N:Video P:1 #:01185 T:0000002e29fa857b M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_PROCESS_CmdEvent> @line<784> with error<0:ErrorNone>
    N:Video P:1 #:01186 T:0000002e29fb1b6d M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_CmdEventHandler> @line<466> with error<0:ErrorNone>
    N:Video P:1 #:01187 T:0000002e29fbc8ef M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_CmdCompleteEventHandler> @line<483> 
    N:Video P:1 #:01188 T:0000002e29fc5023 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_PROCESS_CmdCompleteEvent> @line<809> 
    N:Video P:1 #:01189 T:0000002e29fce089 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<OMX_BASE_PROCESS_CmdCompleteEvent> @line<821> msg<Processing OMX_CommandStateSet>
    N:Video P:1 #:01190 T:0000002e29fd9b1f M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<_OMX_BASE_HandleStateTransitionComplete> @line<506> 
    N:Video P:1 #:01191 T:0000002e29fe2c09 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> @<_OMX_BASE_HandleStateTransitionComplete> @line<535> msg<Loaded to Idle Transition>
    N:Video P:1 #:01192 T:0000002e29ff177b M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Entering<OMX_BASE_RestoreDioGroupInfo> @line<1398> 
    N:Video P:1 #:01193 T:0000002e29ffa793 M:xdc.runtime.Main S:Module<OMX.TI.DUCATI.VIDENC> Leaving<OMX_BASE_RestoreDioGro
    
    

    Many Thanks in Advance.

    BR

    Ajay

  • Hello Ajay,

    You said that this pipeline is working on the EVM.
    What is the difference with your custom board?

    BR
    Margarita
  • Hello ma'am.

    Actually there is no much difference between ti's RDB and our custom board other than 2 changes.

    1. RAM: We are using DDR3 whose part number is MT41K256M16. its density is 2GB. This is tested and working fine. also it is compatible with ti's DDR3.

    2. ETHERNET: We are using VITESSE's VCS8502 dual port. This is tested and working fine.

    i can able to play one test video on custom board but mixing of two videos is not happening and hanging. Actually i am suspecting on VPSS module and 3 video co-processors HDVICP_0, HDVICP_1 and HDVICP_2. Please suggest me Is there any chance to test 3 video co-processors individually ? or pls tell me is there any other way to resolve this issue. ?

    Many thanks in advance.

    BR

    Ajay.

  • Hello Ajay,

    In your debug log CodecId 0 is allocate successful  "::Allocated IVAHD 1::Estimated IVAHD Load of Codec(MHz) 240::Total IVAHD load(MHz) 240

    ... VENC->IvaServer_registerInstance Successful"

    Could you try :

    gst-launch -v videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf ! fakesink silent=true  videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. videotestsrc pattern=13 ! videobox border-alpha=0 top=0 left=-400 ! mix.

    The streaming element is replaced with fakesink element or filesink element. On my side with these elements is working without an issue.

    With this pipeline you could check is the streaming part cause problem.

    Let me know.

    BR

    Margarita

  • Hello ma'am,

    I tried the pipeline you mentioned above but it is still hanging. Here is the log below. earlier itself i was tested this pipeline. I am not getting what to do further. May be the hanging issue is from the video processing sub system.

    root@dm816x-evm:~# gst-launch -v videomixer port-index=0 name=mix ! ffmpegcolorspace ! omx_h264enc ! queue ! h264parse ! gstperf ! fakesink sil
    ent=true videotestsrc pattern=18 ! videobox border-alpha=0.6 top=0 left=0 right=0 ! mix. videotestsrc pattern=13 ! videobox border-alpha=0 top
    =0 left=-400 ! mix.
    Setting pipeline to PAUSED ...
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoBox:videobox0.GstPad:sink: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoMixer:mix.GstVideoMixerPad:sink_1: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1
    /GstPipeline:pipeline0/GstVideoTestSrc:videotestsrc1.GstPad:src: caps = video/x-raw-yuv, format=(fourcc)AYUV, color-matrix=(string)sdtv, width=(int)320, height=(int)240, framerate=(fraction)30/1, pixel-aspect-ratio=(fraction)1/1
    Pipeline is PREROLLING ...

    [here it is hanging]

    One more thing i have to tell you is that actually i am mounting filesytem via nfs because we don't have any FLASH device on our board right now, we are still working on it. I am running kernel in the RAM itself through tftp and filesystem via nfs. One observation is that, i am not getting the console after filesytem loads. for that reason im doing telnet to boardip and getting console. once i run any pipeline which is related to video mixing, the board is hanging, after that i can not able to do remote login through telnet, it is failing. I don't think this might be the reason for hanging,, right..? Please give some suggestions to try out.

    Thanks in Advance.

    BR
    Ajay.
  • Hello,

    Could you try this :

    gst-launch --gst-debug=3 --verbose omx_videomixer framerate=30 port-index=0 name=mix ! omx_ctrl display-mode=OMX_DC_MODE_1080P_60 ! gstperf ! omx_videosink filesrc location=/usr/share/ti/data/videos/dm816x_1080p_demo.264 ! 'video/x-h264' ! h264parse ! omx_h264dec ! mix. filesrc location=/usr/share/ti/data/videos/dm816x_1080p_demo.264 ! 'video/x-h264' ! h264parse ! omx_h264dec ! mix.

    You shall see 2 videos on the screen.
    You could check this way is your console just hang but the board is still alive and playing the videos with videomixer element.

    BR
    Margarita
  • Hello Mr.Ajay

    You are able to solve the hanging issue? we are facing the same issue on few boards. Please let me know your valuable comments.

    Thanks&Regards,
    Shyamsundar