• State
  • Locked Locked
  • Replies 2 replies
  • Subscribers 98 subscribers
  • Views 558 views
  • Users 0 members are here
Support feedback
Options
Options
Related

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.

VIDENC1_process failure

Ottavio Campana
Prodigy 220 points

I'm writing a program that uses TI h.264 encoder. The problem is that VIDENC1_process fails and I cannot understand why. The output I have is

15,798,475us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x4ed78, inBufs=0x41e5db38, outBufs=0x41e5ddf4, inArgs=0x41e5de00, outArgs=0x41e5dca4)
@15,798,682us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x4ed78, retVal=0xffffffff)

which is meaningless to me.

I'm using MVL 5.0, and in kernel 2.6.18 it's impossible to use USERPTR to provider memory-aligned buffers to the video driver, so after having studied some examples, I used the following code:

          memset (&in_buf, 0, sizeof (IVIDEO1_BufDescIn));
          in_buf.numBufs = 1;
          in_buf.frameWidth = 720;
          in_buf.frameHeight = 576;
          in_buf.framePitch = 720;
          in_buf.bufDesc[0].buf = buffers[buf.index].start;
          in_buf.bufDesc[0].bufSize = 576 * 720 * 2;

          status = VIDENC1_control (video_enc, XDM_GETBUFINFO, (IVIDENC1_DynamicParams*) &dynamic_video_params, &enc_status);

          XDM_BufDesc outputBufDesc;
          XDAS_Int8 * pOutputBuf[XDM_MAX_IO_BUFFERS];
          XDAS_Int32 pOutputBufSize[XDM_MAX_IO_BUFFERS];
          outputBufDesc.bufs = (XDAS_Int8 **) pOutputBuf;
          outputBufDesc.bufSizes =  pOutputBufSize;
          outputBufDesc.numBufs = enc_status.bufInfo.minNumOutBufs;
          outputBufDesc.bufs[0] = malloc (1024*1024);
          outputBufDesc.bufSizes[0] = enc_status.bufInfo.minOutBufSize[0];

          int ii;
          for (ii = 0 ; ii < (enc_status.bufInfo.minNumOutBufs -1) ; ii++)
            {
              outputBufDesc.bufs[ii+1] = outputBufDesc.bufs[ii] + enc_status.bufInfo.minOutBufSize[ii];
              outputBufDesc.bufSizes[ii+1] = enc_status.bufInfo.minOutBufSize[ii+1];
            }

          status = VIDENC1_process (video_enc, &in_buf, &outputBufDesc, (IVIDENC1_InArgs*) &in_args, (IVIDENC1_OutArgs*) &out_args);

I suspect it's an alignment problem, but I'm not sure. Can you give me a hint please?

  • 0
    TI__Genius 17205 points

    Ottavio Campana said:
    outputBufDesc.bufs[0] = malloc (1024*1024);

    I think this line will cause you problems - you can't malloc() buffers that are given to algorithms/codecs running on remote processors... these buffers need to be physically contiguous.  Often, CMEM is used to alloc these buffers (or the Codec Engine-provided Memory_contigAlloc()).

    If this "discontiguous buffer" is your issue, I'm a little surprised you didn't get more trace.  What release of Codec Engine are you using?  Did you run with CE_DEBUG=2?

    http://tiexpressdsp.com/index.php?title=CE_DEBUG

    Chris

  • 0 in reply to Chris Ring
    Prodigy 220 points

    Chris, I hade the same idea, and after posting I tried first memlign for alignment and Memory_contigAllog for contiguos memory with codec engine 2.21

    In both cases I did not have it working.

    By the way, yes, I'm always running with CE_DEBUG=2, which is useful and I was able to identify a couple of errors. I also set

    TraceUtil.attrs = TraceUtil.FULL_TRACING;

    so I don't know how I can have more infos.

    I re-ran the program, I attach the full CE log

    Ottavio

    @0,839,845us: [+4 T:0x4001eb80] OG - Global_init> This program was built with the following packages:
    @0,840,255us: [+4 T:0x4001eb80] OG -     package gnu.targets.rts470MV (/opt/mvl/opt/xdctools_3_10_03/packages/gnu/targets/rts470MV/) [1,0,0,0,1225517438755]
    @0,840,594us: [+4 T:0x4001eb80] OG -     package ti.sdo.codecs.h264enc (/opt/TI/dvsdk_2_00_00_18/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/h264enc/) [1,0,0,1245133770000]
    @0,840,765us: [+4 T:0x4001eb80] OG -     package ti.sdo.codecs.mpeg4enc (/opt/TI/dvsdk_2_00_00_18/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/mpeg4enc/) [1,0,0,1245133770000]
    @0,840,915us: [+4 T:0x4001eb80] OG -     package ti.sdo.codecs.g711enc (/opt/TI/dvsdk_2_00_00_18/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/g711enc/) [1,0,0,1245133770000]
    @0,841,058us: [+4 T:0x4001eb80] OG -     package ti.xdais.dm (/opt/mvl/opt/xdais_6_21/packages/ti/xdais/dm/) [1,0,5,0]
    @0,841,191us: [+4 T:0x4001eb80] OG -     package ti.sdo.utils.trace (/opt/mvl/opt/framework_components_2_21/packages/ti/sdo/utils/trace/) [1,0,0,1226385792502]
    @0,841,326us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.utils.xdm (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1226392459729]
    @0,841,458us: [+4 T:0x4001eb80] OG -     package ti.xdais (/opt/mvl/opt/xdais_6_21/packages/ti/xdais/) [1,2,1,0]
    @0,841,583us: [+4 T:0x4001eb80] OG -     package ti.sdo.fc.dman3 (/opt/mvl/opt/framework_components_2_21/packages/ti/sdo/fc/dman3/) [1,0,4,1226385259418]
    @0,841,712us: [+4 T:0x4001eb80] OG -     package ti.sdo.fc.acpy3 (/opt/mvl/opt/framework_components_2_21/packages/ti/sdo/fc/acpy3/) [1,0,4,1226385241964]
    @0,841,844us: [+4 T:0x4001eb80] OG -     package dsplink.gpp (/opt/mvl/opt/dsplink-1_60-prebuilt/packages/dsplink/gpp/) [5,0,0,1224878287000]
    @0,841,972us: [+4 T:0x4001eb80] OG -     package ti.sdo.linuxutils.cmem (/opt/mvl/opt/linuxutils_2_21/packages/ti/sdo/linuxutils/cmem/) [2,2,0,1226363746957]
    @0,842,106us: [+4 T:0x4001eb80] OG -     package gnu.targets (/opt/mvl/opt/xdctools_3_10_03/packages/gnu/targets/) [1,0,1,1225517427930]
    @0,842,236us: [+4 T:0x4001eb80] OG -     package ti.catalog.c470 (/opt/mvl/opt/xdctools_3_10_03/packages/ti/catalog/c470/) [1,0,1,0,0]
    @0,842,365us: [+4 T:0x4001eb80] OG -     package ti.platforms.evmDM6446 (/opt/mvl/opt/xdctools_3_10_03/packages/ti/platforms/evmDM6446/) [1,0,0,1,0]
    @0,842,495us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.osal (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/osal/) [2,0,2,1226392293109]
    @0,842,625us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.osal.linux (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/osal/linux/) [2,0,1,1226392304239]
    @0,842,759us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.ipc (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/ipc/) [2,0,1,1226392259449]
    @0,842,891us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.ipc.dsplink (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/ipc/dsplink/) [2,0,1,1226392278611]
    @0,843,026us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.alg (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/alg/) [1,0,1,1226391901169]
    @0,843,163us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/) [1,0,6,1226391900950]
    @0,843,292us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.video2 (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/video2/) [1,0,2,1226392472602]
    @0,843,424us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.video1 (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/video1/) [1,0,2,1226392469485]
    @0,843,554us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.video (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/video/) [1,0,3,1226392474395]
    @0,843,685us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.image1 (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/image1/) [1,0,1,1226392262688]
    @0,843,813us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.audio1 (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/audio1/) [1,0,1,1226391915632]
    @0,843,946us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.audio (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/audio/) [1,0,2,1226391913936]
    @0,848,597us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.speech1 (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/speech1/) [1,0,1,1226392323750]
    @0,850,093us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.speech (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/speech/) [1,0,2,1226392318106]
    @0,850,310us: [+4 T:0x4001eb80] OG -     package ti.sdo.codecs.h264enc.ce (/opt/TI/dvsdk_2_00_00_18/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1245133770000]
    @0,850,469us: [+4 T:0x4001eb80] OG -     package ti.sdo.codecs.mpeg4enc.ce (/opt/TI/dvsdk_2_00_00_18/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/mpeg4enc/ce/) [1,0,0,1245133770000]
    @0,850,616us: [+4 T:0x4001eb80] OG -     package ti.sdo.codecs.g711enc.ce (/opt/TI/dvsdk_2_00_00_18/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/g711enc/ce/) [1,0,0,1245133770000]
    @0,850,757us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.bioslog (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/bioslog/) [1,0,1,1226391918789]
    @0,850,894us: [+4 T:0x4001eb80] OG -     package ti.sdo.ce.utils.trace (/opt/mvl/opt/codec_engine_2_21/packages/ti/sdo/ce/utils/trace/) [1,0,1,1226392452934]
    @0,851,029us: [+4 T:0x4001eb80] OG -     package worker_acquire (/opt/mvl/root/albert/src/programs/agent/workers/worker_acquire/) []
    @0,851,993us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Sem_create> count: 0
    @0,852,239us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x45150]
    @0,852,402us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Sem_create> count: 0
    @0,852,541us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x45178]
    @0,852,687us: [+0 T:0x4001eb80] OT - Thread_create> Enter (fxn=0x160e8, attrs=0x0)
    @0,853,493us: [+0 T:0x4001eb80] OT - Thread_create> Exit (task=0x45048)
    @0,853,861us: [+0 T:0x4001eb80] ti.sdo.ce.alg - ALG_init> Enter
    @0,854,051us: [+0 T:0x4001eb80] ti.sdo.ce.alg - ALG_init> Exit
    @0,854,398us: [+6 T:0x4001eb80] CE - Engine_init> CE debugging on (CE_DEBUG=2; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
    @0,854,792us: [+0 T:0x4001eb80] CS - Server_init()
    @0,854,965us: [+0 T:0x4001eb80] CS - Server_init> Global_useLinkArbiter = 0
    @0,855,348us: [+0 T:0x4001eb80] CE - Engine_open> Enter('encode', 0x0, 0xbeb76b74)
    @0,855,566us: [+0 T:0x4001eb80] CE - rserverOpen('encodeCombo.x64P'), count = 0
    @0,855,795us: [+0 T:0x4001eb80] OP - Processor_create> Enter(imageName='encodeCombo.x64P', linkCfg='(null)', attrs=0xbeb76b28)
    @0,859,090us: [+0 T:0x4001eb80] OP - doCmd> Enter (cmdId=1, proc=0x4eb60)
    @0,859,309us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x45150]
    @0,859,600us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x45150]
    @0,859,776us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x45178] timeout[0xffffffff]
    @0,861,508us: [+1 T:0x40de1490] OP - daemon> thread created.
    @0,862,819us: [+0 T:0x40de1490] OP - getCmd_d> Enter (proc=0x40de0de8)
    @0,864,149us: [+0 T:0x40de1490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x45150] timeout[0xffffffff]
    @0,865,500us: [+0 T:0x40de1490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x45150] status[0]
    @0,866,834us: [+0 T:0x40de1490] OP - getCmd_d> Exit (result=1)
    @0,868,186us: [+0 T:0x40de1490] OP - Processor_create_d> Enter(proc=0x4eb60)
    @0,869,517us: [+2 T:0x40de1490] OP - Processor_create_d> Initializing DSP PROC...
    @0,870,996us: [+2 T:0x40de1490] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'encodeCombo.x64P']
    @0,872,391us: [+2 T:0x40de1490] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fa00000, sizeInBytes=0x400000, shared=1, syncd=0
    @0,873,849us: [+2 T:0x40de1490] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000, sizeInBytes=0x100000, shared=1, syncd=0
    @0,875,276us: [+2 T:0x40de1490] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x8ff00000, sizeInBytes=0x80, shared=1, syncd=0
    @0,876,703us: [+2 T:0x40de1490] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x88000000, sizeInBytes=0x7a00000, shared=0, syncd=0
    @0,878,128us: [+2 T:0x40de1490] OP - Processor_create_d> DOPOWERCONTROL was=0; now=0
    @0,883,078us: [+2 T:0x40de1490] OP - Processor_create_d> Attaching to DSP PROC...
    @0,894,290us: [+2 T:0x40de1490] OP - Processor_create_d> Opening MSGQ pool...
    @0,896,285us: [+2 T:0x40de1490] OP - Processor_create_d> Loading encodeCombo.x64P on DSP (1 args)...
    @1,080,461us: [+2 T:0x40de1490] OP - Processor_create_d> Starting DSP PROC...
    @1,135,183us: [+2 T:0x40de1490] OP - Processor_create_d> Opening remote transport...
    @1,137,410us: [+2 T:0x40de1490] OP - Processor_create_d> return (1)
    @1,138,744us: [+0 T:0x40de1490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x45178]
    @1,140,548us: [+0 T:0x4001eb80] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x45178] status[0]
    @1,140,759us: [+0 T:0x4001eb80] OP - doCmd> Exit (result=1)
    @1,140,900us: [+0 T:0x4001eb80] OP - Processor_create> return (0x4eb60)
    @1,141,035us: [+0 T:0x4001eb80] CE - rserverOpen('encodeCombo.x64P'): 0x445d0 done.
    @1,143,275us: [+0 T:0x40de1490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x45178]
    @1,144,624us: [+0 T:0x40de1490] OP - getCmd_d> Enter (proc=0x40de0de8)
    @1,145,949us: [+0 T:0x40de1490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x45150] timeout[0xffffffff]
    @1,147,660us: [+0 T:0x4001eb80] CE - checkServer(0x4ed48)
    @1,149,249us: [+0 T:0x4001eb80] CE - rmsInit> RMS initialized(0x4ed48); CE_DEBUG on, setting DSP trace mask to *+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3
    @1,149,494us: [+0 T:0x4001eb80] CE - Engine_setTrace> Enter(engine=0x4ed48, mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
    @1,149,697us: [+1 T:0x4001eb80] CE - Engine_setTrace> Requesting DSP set trace ...
    @1,151,975us: [+0 T:0x4001eb80] CE - Engine_setTrace> return(0)
    [DSP] @0,034,744tk: [+0 T:0x8fa424cc] OG - Global_setSpecialTrace> enter(mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
    [DSP] @0,034,874tk: [+4 T:0x8fa424cc] OG - Global_setSpecialTrace> This program was built with the following packages:
    [DSP] @0,034,940tk: [+4 T:0x8fa424cc] OG -     package ti.targets.rts6000 (/db/rtree/install/trees/products/xdcprod-j57/product/Linux/xdctools_3_10_03/packages/ti/targets/rts6000/) [1,0,0,0,1225517497925]
    [DSP] @0,035,047tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.codecs.h264enc (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/DEMO_common/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/h264enc/) [1,0,0,1236033798000]
    [DSP] @0,035,165tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.codecs.mpeg4enc (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/DEMO_common/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/mpeg4enc/) [1,0,0,1236033835000]
    [DSP] @0,035,285tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.codecs.g711enc (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/DEMO_common/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/g711enc/) [1,0,0,1236033781000]
    [DSP] @0,035,409tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.fc.dman3 (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/framework_components_2_21/packages/ti/sdo/fc/dman3/) [1,0,4,1226385259418]
    [DSP] @0,035,519tk: [+4 T:0x8fa424cc] OG -     package ti.rtdx (/db/vtree/library/trees/sabios/sabios-j05/product/Linux/bios_5_33_02/packages/ti/rtdx/) [2,0,0,4,1219531643983]
    [DSP] @0,035,612tk: [+4 T:0x8fa424cc] OG -     package ti.psl (/db/vtree/library/trees/sabios/sabios-j05/product/Linux/bios_5_33_02/packages/ti/psl/) [5,0,0,0,0]
    [DSP] @0,035,699tk: [+4 T:0x8fa424cc] OG -     package ti.bios (/db/vtree/library/trees/sabios/sabios-j05/product/Linux/bios_5_33_02/packages/ti/bios/) [5,2,5,5,1224515922292]
    [DSP] @0,035,792tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.fc.dskt2 (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/framework_components_2_21/packages/ti/sdo/fc/dskt2/) [1,0,4,1226385319086]
    [DSP] @0,035,902tk: [+4 T:0x8fa424cc] OG -     package ti.xdais.dm (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/xdais_6_22_01/packages/ti/xdais/dm/) [1,0,5,1231972806824]
    [DSP] @0,036,003tk: [+4 T:0x8fa424cc] OG -     package ti.xdais (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/xdais_6_22_01/packages/ti/xdais/) [1,2,1,1231972799069]
    [DSP] @0,036,100tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.node (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/node/) [1,0,0,1226392295481]
    [DSP] @0,036,206tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1226392278316]
    [DSP] @0,036,322tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.utils.trace (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/framework_components_2_21/packages/ti/sdo/utils/trace/) [1,0,0,1226385792502]
    [DSP] @0,036,435tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.utils.xdm (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1226392459729]
    [DSP] @0,036,546tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.fc.acpy3 (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/framework_components_2_21/packages/ti/sdo/fc/acpy3/) [1,0,4,1226385241964]
    [DSP] @0,036,656tk: [+4 T:0x8fa424cc] OG -     package dsplink.dsp (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/dsplink-1_60-prebuilt/packages/dsplink/dsp/) [1,4,0,1224878295000]
    [DSP] @0,036,758tk: [+4 T:0x8fa424cc] OG -     package ti.bios.utils (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/biosutils_1_01_00/packages/ti/bios/utils/) [2,0,1,0,0]
    [DSP] @0,036,858tk: [+4 T:0x8fa424cc] OG -     package ti.catalog.c6000 (/db/rtree/install/trees/products/xdcprod-j57/product/Linux/xdctools_3_10_03/packages/ti/catalog/c6000/) [1,0,0,0,0]
    [DSP] @0,036,957tk: [+4 T:0x8fa424cc] OG -     package ti.platforms.evmDM6446 (/db/vtree/library/trees/sabios/sabios-j05/product/Linux/bios_5_33_02/packages/ti/platforms/evmDM6446/) [1,0,0,1,0]
    [DSP] @0,037,059tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.osal (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/osal/) [2,0,2,1226392293109]
    [DSP] @0,037,164tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.osal.bios (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/osal/bios/) [2,0,1,1226392296194]
    [DSP] @0,037,276tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.ipc (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/ipc/) [2,0,1,1226392259449]
    [DSP] @0,037,381tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.ipc.bios (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1226392264443]
    [DSP] @0,037,490tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.alg (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/alg/) [1,0,1,1226391901169]
    [DSP] @0,037,595tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/) [1,0,6,1226391900950]
    [DSP] @0,037,699tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.bioslog (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/bioslog/) [1,0,1,1226391918789]
    [DSP] @0,037,807tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.video1 (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/video1/) [1,0,2,1226392469485]
    [DSP] @0,037,915tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.codecs.h264enc.ce (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/DEMO_common/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1236033803000]
    [DSP] @0,038,036tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.codecs.mpeg4enc.ce (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/DEMO_common/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/mpeg4enc/ce/) [1,0,0,1236033839000]
    [DSP] @0,038,158tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.ce.speech1 (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/MFP20/codec_engine_2_21/packages/ti/sdo/ce/speech1/) [1,0,1,1226392323750]
    [DSP] @0,038,266tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.codecs.g711enc.ce (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/DEMO_common/dm6446_dvsdk_combos_2_03/packages/ti/sdo/codecs/g711enc/ce/) [1,0,0,1236033785000]
    [DSP] @0,038,388tk: [+4 T:0x8fa424cc] OG -     package ti.sdo.servers.encode (/db/atree/library/trees/linuxdemos/linuxdemos-d24x/imports/DEMO_common/dm6446_dvsdk_combos_2_03/packages/ti/sdo/servers/encode/) []
    [DSP] @0,038,497tk: [+0 T:0x8fa424cc] OG - Global_setSpecialTrace> return
    @1,189,707us: [+0 T:0x4001eb80] CE - Engine_fwriteTrace> returning count [7152]
    @1,190,263us: [+0 T:0x4001eb80] CE - Engine_open> return(322888)
    @1,190,557us: [+0 T:0x4001eb80] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x4ed48, name='h264enc', params=0x43574)
    @1,190,780us: [+0 T:0x4001eb80] CV - VISA_create(0x4ed48, 'h264enc', 0x43574, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
    @1,190,943us: [+0 T:0x4001eb80] CV - VISA_create2(0x4ed48, 'h264enc', 0x43574, 0x40, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
    @1,191,125us: [+0 T:0x4001eb80] CE - Engine_createNode(0x4ed48, 'h264enc', 2496, 0x43574, 0x40, 0xbeb76ad4)
    @1,191,285us: [+0 T:0x4001eb80] CE - Engine> allocNode Enter(engine=0x4ed48, impId='h264enc')
    @1,191,460us: [+0 T:0x4001eb80] CE - Engine> allocNode(). Calling Comm_create(gppfromnode_10564_1, 0x4c588, NULL)
    @1,204,990us: [+4 T:0x4001eb80] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x4e7b8, algName='h264enc', rmsNode=0x8fa46f88, algHandle=0x8fa47070)
    [DSP] @0,132,455tk: [+0 T:0x8fa424cc] OM - Memory_alloc> Enter(size=0x18)
    [DSP] @0,132,502tk: [+0 T:0x8fa424cc] OM - Memory_alloc> return (0x8fa46f88)
    [DSP] @0,132,552tk: [+0 T:0x8fa424cc] OM - Memory_alloc> Enter(size=0xa)
    [DSP] @0,132,596tk: [+0 T:0x8fa424cc] OM - Memory_alloc> return (0x8fa46fa0)
    [DSP] @0,132,652tk: [+0 T:0x8fa424cc] OM - Memory_alloc> Enter(size=0x20)
    [DSP] @0,132,698tk: [+0 T:0x8fa424cc] OM - Memory_alloc> return (0x8fa46fb0)
    [DSP] @0,132,748tk: [+0 T:0x8fa424cc] OM - Memory_alloc> Enter(size=0x24)
    [DSP] @0,132,803tk: [+0 T:0x8fa424cc] OM - Memory_alloc> return (0x8fa46fd0)
    [DSP] @0,132,873tk: [+0 T:0x8fa424cc] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x0, name='h264enc', params=0x8fe05cc0)
    [DSP] @0,132,960tk: [+0 T:0x8fa424cc] CV - VISA_create(0x0, 'h264enc', 0x8fe05cc0, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
    [DSP] @0,133,035tk: [+0 T:0x8fa424cc] CV - VISA_create2(0x0, 'h264enc', 0x8fe05cc0, 0x40, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
    [DSP] @0,133,129tk: [+0 T:0x8fa424cc] CE - Engine_open> Enter('local', 0x8fa461cc, 0x9c0)
    [DSP] @0,133,188tk: [+0 T:0x8fa424cc] OM - Memory_alloc> Enter(size=0x2c)
    [DSP] @0,133,236tk: [+0 T:0x8fa424cc] OM - Memory_alloc> return (0x8fa47040)
    [DSP] @0,133,292tk: [+0 T:0x8fa424cc] CE - Engine_open> return(-1885048768)
    [DSP] @0,133,353tk: [+0 T:0x8fa424cc] OM - Memory_alloc> Enter(size=0x30)
    [DSP] @0,133,398tk: [+0 T:0x8fa424cc] OM - Memory_alloc> return (0x8fa47070)
    [DSP] @0,133,453tk: [+0 T:0x8fa424cc] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fac4fb8, idma3Fxns=0x8fac4fe4, iresFxns=0x0, params=0x8fe05cc0, attrs=0x8fa462e0)
    [DSP] @0,133,562tk: [+0 T:0x8fa424cc] OM - Memory_alloc> Enter(size=0x10)
    [DSP] @0,133,608tk: [+0 T:0x8fa424cc] OM - Memory_alloc> return (0x8fa470a0)
    [DSP] @0,160,471tk: [+0 T:0x8fa424cc] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8fa470a0)
    [DSP] @0,160,544tk: [+5 T:0x8fa424cc] CV - VISA_create> local codec created (name='h264enc', handle=0x8fa470a0)
    [DSP] @0,160,620tk: [+0 T:0x8fa424cc] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x8fa47070)
    [DSP] @0,160,687tk: [+4 T:0x8fa424cc] OT - Thread_create > name: "h264enc#0", pri:  -1, stack size:  16384, stack seg: 0
    @1,212,694us: [+0 T:0x4001eb80] CE - Engine_fwriteTrace> returning count [2218]
    @1,212,867us: [+2 T:0x4001eb80] CE - Engine_createNode> Returning 0x4c580
    @1,213,117us: [+5 T:0x4001eb80] CV - VISA_create> remote codec created (name='h264enc', localQueueID=0x10001, remoteQueueID=0x0002)
    @1,213,310us: [+0 T:0x4001eb80] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x4ed78)
    @16,162,842us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x4ed78, id=1, dynParams=0x435b4 (size=0x78), status=0x41e5dc14 (size=0x9c)
    @16,164,289us: [+5 T:0x41e5e490] CV - VISA_allocMsg> Allocating message for messageId=0x00020027
    @16,165,642us: [+0 T:0x41e5e490] CV - VISA_call(visa=0x4ed78, msg=0x415efc80): messageId=0x00020027, command=0x1
    [DSP] @34,878,995tk: [+5 T:0x8fa4750c] CN - NODE> 0x8fa46fb0(h264enc#0) call(algHandle=0x8fa47070, msg=0x8fe06c80); messageId=0x00020027
    [DSP] @34,879,100tk: [+0 T:0x8fa4750c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fa47070, id=1, dynParams=0x8fe06cb4 (size=0x78), status=0x8fe06d2c (size=0x9c)
    [DSP] @34,879,217tk: [+5 T:0x8fa4750c] CV - VISA_enter(visa=0x8fa47070): algHandle = 0x8fa470a0
    [DSP] @34,879,286tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fa470a0)
    [DSP] @34,879,436tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
    [DSP] @34,879,544tk: [+5 T:0x8fa4750c] CV - VISA_exit(visa=0x8fa47070): algHandle = 0x8fa470a0
    [DSP] @34,879,619tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fa470a0)
    [DSP] @34,879,687tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
    [DSP] @34,879,742tk: [+0 T:0x8fa4750c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fa47070, retVal=0x0)
    [DSP] @34,879,819tk: [+5 T:0x8fa4750c] CN - NODE> returned from call(algHandle=0x8fa47070, msg=0x8fe06c80); messageId=0x00020027
    @16,182,030us: [+0 T:0x41e5e490] CE - Engine_fwriteTrace> returning count [1154]
    @16,183,367us: [+0 T:0x41e5e490] CV - VISA_call Completed: messageId=0x00020027, command=0x1, return(status=0)
    @16,184,743us: [+5 T:0x41e5e490] CV - VISA_freeMsg(0x4ed78, 0x415efc80): Freeing message with messageId=0x00020027
    @16,186,115us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x4ed78, retVal=0x0)
    @16,188,709us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x4ed78, id=5, dynParams=0x435b4 (size=0x78), status=0x41e5dc14 (size=0x9c)
    @16,190,242us: [+5 T:0x41e5e490] CV - VISA_allocMsg> Allocating message for messageId=0x00020028
    @16,191,615us: [+0 T:0x41e5e490] CV - VISA_call(visa=0x4ed78, msg=0x415efc80): messageId=0x00020028, command=0x1
    [DSP] @34,939,274tk: [+5 T:0x8fa4750c] CN - NODE> 0x8fa46fb0(h264enc#0) call(algHandle=0x8fa47070, msg=0x8fe06c80); messageId=0x00020028
    [DSP] @34,939,364tk: [+0 T:0x8fa4750c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fa47070, id=5, dynParams=0x8fe06cb4 (size=0x78), status=0x8fe06d2c (size=0x9c)
    [DSP] @34,939,474tk: [+5 T:0x8fa4750c] CV - VISA_enter(visa=0x8fa47070): algHandle = 0x8fa470a0
    [DSP] @34,939,537tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fa470a0)
    [DSP] @34,939,606tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
    [DSP] @34,939,662tk: [+5 T:0x8fa4750c] CV - VISA_exit(visa=0x8fa47070): algHandle = 0x8fa470a0
    [DSP] @34,939,724tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fa470a0)
    [DSP] @34,939,788tk: [+0 T:0x8fa4750c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
    [DSP] @34,939,841tk: [+0 T:0x8fa4750c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fa47070, retVal=0x0)
    [DSP] @34,939,910tk: [+5 T:0x8fa4750c] CN - NODE> returned from call(algHandle=0x8fa47070, msg=0x8fe06c80); messageId=0x00020028
    @16,207,724us: [+0 T:0x41e5e490] CE - Engine_fwriteTrace> returning count [1154]
    @16,209,086us: [+0 T:0x41e5e490] CV - VISA_call Completed: messageId=0x00020028, command=0x1, return(status=0)
    @16,210,583us: [+5 T:0x41e5e490] CV - VISA_freeMsg(0x4ed78, 0x415efc80): Freeing message with messageId=0x00020028
    @16,211,947us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x4ed78, retVal=0x0)
    @16,213,326us: [+6 T:0x41e5e490] OM - Memory_contigAlloc> Warning: non-default alignment not supported for pool-based allocations, using default 0xffffffff.
    @16,215,102us: [+4 T:0x41e5e490] OM - Memory_contigAlloc> CMEM_alloc(1048576) = 0x41e5f000.
    @16,216,474us: [+4 T:0x41e5e490] OM - Memory_contigAlloc> CMEM_getPhys(0x41e5f000) = 0x8776a000.
    @16,219,042us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x4ed78, inBufs=0x41e5db44, outBufs=0x44e94, inArgs=0x41e5de00, outArgs=0x41e5dcb0)
    @16,220,599us: [+0 T:0x41e5e490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x4ed78, retVal=0xffffffff)