using encodedecode to modify the video_copy always error!!

Hi,

The video_copy application expects certain codecs present in video_copy.x64P which are different from the codecs in loopbackCombo.x64P.

What are you trying to achieve, perhaps there is a better way to go about this?

Thanks, Niclas

thank you for your reply
I just want do some video processed tests like <video sobel> or <Grayscale> on the DSP
so I need the video input and CE to the DSP to process
then diaplay on my minitor,I use the example encodedecode to modify the video_copy,its always error like that

I donot know video_copy  use the VIDENC_create() to create a codec
 and the encodedecode use the Venc1_create() to create a codec
can you tell me what i can do ,thank you

my dvsdk version is dvsdk_2_00_00_22  and use the ti's DVEVM

thanks

 

Is your algorithm an XDAIS algorithm? See this wiki topic http://wiki.davincidsp.com/index.php/XDAIS_sample_algorithm and http://wiki.davincidsp.com/index.php/XDAIS_FAQ.

If you algorithm is an XDAIS algorithm, you need to decide whether this algorithm really is a video encoder (or at least behave like one). If so you can use the VIDENC1 interface for your algorithm, see this topic on the semantics of a video encoder at: http://wiki.davincidsp.com/index.php/XDM_1.x_Semantics#IVIDENC1.

If sounds like it might be easier for you to wrap this algorithm in our generic IUNIVERSAL interface, see this wiki topic: http://wiki.davincidsp.com/index.php/Getting_started_with_IUNIVERSAL.

I would recommend you use a smaller application to test your video encoder than the encodedecode demo. If you choose to go with your algorithm as video encoders you can look at the DMAI app "video_encode_io1" which is your DVSDK is located at: dvsdk_2_00_00_22/dmai_1_20_00_06/packages/ti/sdo/dmai/apps/video_encode_io1.

Gut feeling is that you are better off with IUNIVERSAL though, and the above IUNIVERSAL wiki topic has a link to some sample applications you can start from.

Regards, Niclas

thank you ！

but I guess there is little bit of misunderstanding becourse of my poor english,I just only want to use encodedecode example to run  the video_copy's server,

if it's success then I can do some video process test  like <video sobel> or <Grayscale> and so on ...

my question is encodedecode running the video_copy's server can be built but cannot be run, I edit the codec name of the encodedecode using video_copy server's  codec name
and change the encodedecode.cfg with video_copy.x64P.

but run the encodedecode with the video_copy.x64P always error!!
like is :
=================================================
root@192.168.0.15:/opt/dvevm# ./encodedecode
Encodedecode demo started.
Error: Failed to create video encoder: videnc_copy
root@192.168.0.15:/opt/dvevm#
=========================================

Can you set CE_DEBUG=3 and attach the output?  Might help us understand what you're trying to do, how far you get until an error is encountered.

http://tiexpressdsp.com/index.php/CE_DEBUG

Chris

thank you Chris.
as you say ,I set the CE_DEBUG=3 and run my apps,the console print like is :
 
@3,347,527us: [+7 T:0x42fe9490 S:0x42fe8bcc] ti.sdo.dmai - [Venc1] Cannot pass null for engine, codec name, params or dynamic params

I promise the codec name I set in the app the same with the codec and servers
I donot know how to set the params and dynamic params so I use "NULL" in the Venc1_create() function     -----------      hVe1 = Venc1_create(hEngine, envp->videoEncoder,
                            NULL, NULL);

can you tell me how to set the params and why set that? thank you !!
======================================================================================
 this my all steps:
  

MontaVista(R) Linux(R) Professional Edition 5.0.0 (0801921)

192.168.0.15 login: root
Last login: Sun Feb  1 12:06:59 2004 on console
Linux 192.168.0.15 2.6.18_pro500-davinci_evm-arm_v5t_le #1 PREEMPT Wed May 20 01:14:17 IST 2009 armv5tejl GNU/Linux

Welcome to MontaVista(R) Linux(R) Professional Edition 5.0.0 (0801921).

root@192.168.0.15:~# cd /opt/dvevm/;ls
app.out   dmai1.x470MV  in.dat              ocvc_dm6446.ko
build     dsplinkk.ko   loadmodules.sh      out.dat
cmemk.ko  encode        loopbackCombo.x64P  unloadmodules.sh
data      encodedecode  lpm_dm6446.ko       video_copy.x64P
root@192.168.0.15:/opt/dvevm# ./loadmodules.sh
CMEMK module: built on Apr 20 2009 at 16:28:10
  Reference Linux version 2.6.18
  File /db/atree/library/trees/ce/ce-m06x/imports/ti/sdo/linuxutils/cmem/src/module/cmemk.c
ioremap_nocache(0x87600000, 10485760)=0xc8000000
allocated heap buffer 0xc8000000 of size 0x2c000
cmem initialized 5 pools between 0x87600000 and 0x88000000
dsplinkk: no version for "struct_module" found: kernel tainted.
DSPLINK Module (1.61.03) created on Date: Apr 16 2009 Time: 18:22:23
root@192.168.0.15:/opt/dvevm# ./encodedecode
Encodedecode demo started.
Error: Failed to create video encoder: videnc_copy
root@192.168.0.15:/opt/dvevm# CE_DEBUG=3 ./encodedecode
Encodedecode demo started.
@0,376,490us: [+4 T:0x4001f930 S:0xbedb5aec] OG - Global_init> This program was built with the following packages:
@0,377,022us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package gnu.targets.rts470MV (/home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/packages/gnu/targets/rts470MV/) [1,0,0,0,1225517438755]
@0,377,310us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.global (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464]
@0,377,470us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.xdais.dm (/home/gzj/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/dm/) [1,0,5,1236972452910]
@0,377,616us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.utils.trace (/home/gzj/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890]
@0,377,762us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.utils.xdm (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490]
@0,377,911us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package dsplink.gpp (/home/gzj/dvsdk_2_00_00_22/dsplink-1_61_03-prebuilt/packages/dsplink/gpp/) [5,0,0,1239931267000]
@0,378,056us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.linuxutils.cmem (/home/gzj/dvsdk_2_00_00_22/linuxutils_2_23_01/packages/ti/sdo/linuxutils/cmem/) [2,2,0,1240253001679]
@0,378,209us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.xdais (/home/gzj/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/) [1,2,1,1236972427008]
@0,378,350us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.node (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858]
@0,378,495us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.fc.global (/home/gzj/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/global/) [1,0,0,1240266696499]
@0,378,642us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.fc.dman3 (/home/gzj/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662]
@0,378,847us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.fc.memutils (/home/gzj/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007]
@0,379,001us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.fc.acpy3 (/home/gzj/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108]
@0,379,153us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package gnu.targets (/home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/packages/gnu/targets/) [1,0,1,1225517427930]
@0,379,297us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.catalog.c470 (/home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/packages/ti/catalog/c470/) [1,0,1,0,0]
@0,379,436us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.platforms.evmDM6446 (/home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/packages/ti/platforms/evmDM6446/) [1,0,0,1,0]
@0,379,581us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.osal (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,1240276730877]
@0,379,724us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.osal.linux (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/linux/) [2,0,1,1240276736840]
@0,379,866us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.ipc (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961]
@0,380,174us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.ipc.dsplink (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/) [2,0,1,1240276714152]
@0,380,333us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.alg (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798]
@0,380,479us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491]
@0,380,624us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.video (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video/) [1,0,3,1240276930771]
@0,749,896us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package codecs.viddec_copy (/home/gzj/gzjDVEVM/video_copy_encodedecode/codecs/viddec_copy/) [1,0,0,1269220815000]
@0,750,183us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package codecs.videnc_copy (/home/gzj/gzjDVEVM/video_copy_encodedecode/codecs/videnc_copy/) [1,0,0,1269066695000]
@0,750,341us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.speech (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/speech/) [1,0,2,1240276762193]
@0,750,490us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.speech1 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/speech1/) [1,0,1,1240276763928]
@0,750,634us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.audio (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/audio/) [1,0,2,1240276296374]
@0,750,813us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.audio1 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/audio1/) [1,0,1,1240276296900]
@0,750,963us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.video1 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video1/) [1,0,2,1240276935900]
@0,751,108us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.video2 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video2/) [1,0,2,1240276933444]
@0,751,285us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.image (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/image/) [1,0,3,1240276700525]
@0,751,436us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.image1 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/image1/) [1,0,1,1240276698808]
@0,751,579us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.dmai (/home/gzj/dvsdk_2_00_00_22/dmai_1_20_00_06/packages/ti/sdo/dmai/) [1,0,0,1267498553000]
@0,751,721us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.simplewidget (/home/gzj/gzjDVEVM/video_copy_encodedecode/packages/ti/sdo/simplewidget/) []
@0,751,863us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.bioslog (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/bioslog/) [1,0,1,1240276303166]
@0,752,005us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package ti.sdo.ce.utils.trace (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/trace/) [1,0,1,1240276915917]
@0,752,159us: [+4 T:0x4001f930 S:0xbedb5aec] OG -     package encodedecode_config (/home/gzj/gzjDVEVM/video_copy_encodedecode/apps/encodedecode/encodedecode_config/) []
@0,752,383us: [+0 T:0x4001f930 S:0xbedb5af4] OG - Global_atexit> enter (fxn=0x2f670)
@0,752,560us: [+0 T:0x4001f930 S:0xbedb5af4] OG - Global_atexit> enter (fxn=0x2eabc)
@0,752,812us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> Enter(0x18)
@0,752,983us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> return (0x5f0f0)
@0,753,460us: [+0 T:0x4001f930 S:0xbedb5ae4] OG - Global_atexit> enter (fxn=0x2c9ec)
@0,753,735us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> Enter(0x18)
@0,753,909us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> return (0x5f140)
@0,754,085us: [+0 T:0x4001f930 S:0xbedb5adc] OG - Global_atexit> enter (fxn=0x2b898)
@0,754,354us: [+0 T:0x4001f930 S:0xbedb5ae4] OG - Global_atexit> enter (fxn=0x2e120)
@0,754,629us: [+0 T:0x4001f930 S:0xbedb5adc] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,754,791us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> Enter(0x14)
@0,754,943us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> return (0x5f1c0)
@0,755,120us: [+0 T:0x4001f930 S:0xbedb5adc] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x5f1c0]
@0,755,272us: [+0 T:0x4001f930 S:0xbedb5adc] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@1,095,486us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> Enter(0x14)
@1,095,673us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> return (0x5f1d8)
@1,095,820us: [+0 T:0x4001f930 S:0xbedb5adc] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x5f1d8]
@1,095,970us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> Enter(0x18)
@1,096,116us: [+0 T:0x4001f930 S:0xbedb5ac4] OM - Memory_alloc> return (0x5f1f0)
@1,096,264us: [+0 T:0x4001f930 S:0xbedb5abc] OT - Thread_create> Enter (fxn=0x2a070, attrs=0x0)
@1,096,407us: [+0 T:0x4001f930 S:0xbedb5aa4] OM - Memory_alloc> Enter(0x64)
@1,096,550us: [+0 T:0x4001f930 S:0xbedb5aa4] OM - Memory_alloc> return (0x5f210)
@1,097,443us: [+0 T:0x4001f930 S:0xbedb5abc] OT - Thread_create> Exit (task=0x5f210)
@1,097,651us: [+0 T:0x4001f930 S:0xbedb5af4] OG - Global_atexit> enter (fxn=0x29a60)
@1,097,840us: [+0 T:0x4001f930 S:0xbedb5af4] OG - Global_atexit> enter (fxn=0x2bde4)
@1,098,124us: [+0 T:0x4001f930 S:0xbedb5adc] ti.sdo.ce.alg - ALG_init> Enter
@1,098,317us: [+0 T:0x4001f930 S:0xbedb5acc] OG - Global_atexit> enter (fxn=0x296ac)
@1,098,478us: [+0 T:0x4001f930 S:0xbedb5afc] ti.sdo.ce.alg - ALG_init> Exit
@1,098,618us: [+0 T:0x4001f930 S:0xbedb5af4] OG - Global_atexit> enter (fxn=0x28ad8)
@1,098,787us: [+0 T:0x4001f930 S:0xbedb5acc] OM - Memory_alloc> Enter(0x18)
@1,098,945us: [+0 T:0x4001f930 S:0xbedb5acc] OM - Memory_alloc> return (0x5f3f0)
@1,099,096us: [+0 T:0x4001f930 S:0xbedb5af4] OG - Global_atexit> enter (fxn=0x2e610)
@1,099,348us: [+6 T:0x4001f930 S:0xbedb5aec] CE - Engine_init> CE debugging on (CE_DEBUG=3; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@1,099,527us: [+0 T:0x4001f930 S:0xbedb5adc] OG - Global_atexit> enter (fxn=0x25f6c)
@1,099,717us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> Enter(0x18)
@1,099,883us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> return (0x5f430)
@1,100,456us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> Enter(0x18)
@1,100,639us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> return (0x5f450)
@1,100,789us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> Enter(0x18)
@1,100,937us: [+0 T:0x4001f930 S:0xbedb5abc] OM - Memory_alloc> return (0x5f470)
@1,101,220us: [+0 T:0x4001f930 S:0xbedb5af4] CS - Server_init()
@1,101,379us: [+0 T:0x4001f930 S:0xbedb5af4] CS - Server_init> Global_useLinkArbiter = 0
@1,101,529us: [+0 T:0x4001f930 S:0xbedb5af4] OG - Global_atexit> enter (fxn=0x2424c)
@1,101,808us: [+0 T:0x4001f930 S:0xbedb5b04] OG - Global_atexit> enter (fxn=0x12f4c)
TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil)
@1,103,004us: [+1 T:0x40bc8490 S:0x40bc7d74] OP - daemon> thread created.
@1,103,226us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Enter (proc=0x40bc7de8)
@1,103,392us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x5f1c0] timeout[0xffffffff]
@1,354,839us: [+2 T:0x4001f930 S:0xbedb58bc] ti.sdo.dmai - [BufTab] Allocating BufTab for 1 buffers
@1,355,279us: [+0 T:0x4001f930 S:0xbedb588c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40bc9000, size=4)
@1,355,489us: [+1 T:0x4001f930 S:0xbedb588c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40bc9000, size=4)
@1,355,680us: [+1 T:0x4001f930 S:0xbedb588c] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@1,355,860us: [+1 T:0x4001f930 S:0xbedb588c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x40bc9000) = 0x80800000.
@1,356,041us: [+1 T:0x4001f930 S:0xbedb5844] OM - Memory__addContigBuf> Enter(virtAddr=0x40bc9000, size=4, physAddr=0x80800000)
@1,356,212us: [+1 T:0x4001f930 S:0xbedb5844] OM - Memory__addContigBuf> creating new contigBuf object
@1,356,357us: [+0 T:0x4001f930 S:0xbedb582c] OM - Memory_alloc> Enter(0x10)
@1,356,514us: [+0 T:0x4001f930 S:0xbedb582c] OM - Memory_alloc> return (0x96990)
@1,356,661us: [+1 T:0x4001f930 S:0xbedb5844] OM - Memory__addContigBuf> returning: cb->phys=0x80800000, cb->size=4, cb->virt=0x40bc9000
@1,356,819us: [+0 T:0x4001f930 S:0xbedb588c] OM - Memory_getBufferPhysicalAddress> return (0x80800000)
@1,356,963us: [+2 T:0x4001f930 S:0xbedb58c4] ti.sdo.dmai - [Buffer] Set user pointer 0x40bc9000 (physical 0x80800000)
@1,358,329us: [+2 T:0x4001f930 S:0xbedb58e4] ti.sdo.dmai - [Display] Display buffer 0 mapped to 0x40bc9000 has physical address 0x40025000
@1,392,413us: [+2 T:0x413f5490 S:0x413f4c54] ti.sdo.dmai - [Display] Video output set to size 720x480 pitch 1440
@1,392,751us: [+2 T:0x413f5490 S:0x413f4adc] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers
@1,393,326us: [+0 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x413f6000, size=4)
@1,393,530us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x413f6000, size=4)
@1,393,691us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@1,393,859us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x413f6000) = 0x86000000.
@1,394,060us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> Enter(virtAddr=0x413f6000, size=4, physAddr=0x86000000)
@1,394,238us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> creating new contigBuf object
@1,394,380us: [+0 T:0x413f5490 S:0x413f4a4c] OM - Memory_alloc> Enter(0x10)
@1,394,531us: [+0 T:0x413f5490 S:0x413f4a4c] OM - Memory_alloc> return (0x96ef8)
@1,394,675us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> returning: cb->phys=0x86000000, cb->size=4, cb->virt=0x413f6000
@1,394,827us: [+0 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> return (0x86000000)
@1,394,971us: [+2 T:0x413f5490 S:0x413f4ae4] ti.sdo.dmai - [Buffer] Set user pointer 0x413f6000 (physical 0x86000000)
@1,410,939us: [+2 T:0x413f5490 S:0x413f4b04] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x413f6000 has physical address 0x86000000
@1,411,552us: [+0 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x417f2000, size=4)
@1,411,755us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x417f2000, size=4)
@1,411,913us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@1,412,079us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x417f2000) = 0x86400000.
@1,412,261us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> Enter(virtAddr=0x417f2000, size=4, physAddr=0x86400000)
@1,412,425us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> creating new contigBuf object
@1,412,597us: [+0 T:0x413f5490 S:0x413f4a4c] OM - Memory_alloc> Enter(0x10)
@1,412,756us: [+0 T:0x413f5490 S:0x413f4a4c] OM - Memory_alloc> return (0x96f10)
@1,412,900us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> returning: cb->phys=0x86400000, cb->size=4, cb->virt=0x417f2000
@1,413,052us: [+0 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> return (0x86400000)
@1,413,198us: [+2 T:0x413f5490 S:0x413f4ae4] ti.sdo.dmai - [Buffer] Set user pointer 0x417f2000 (physical 0x86400000)
@1,429,069us: [+2 T:0x413f5490 S:0x413f4b04] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x417f2000 has physical address 0x86400000
@1,429,693us: [+0 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x41bee000, size=4)
@1,429,897us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x41bee000, size=4)
@1,430,187us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@1,771,115us: [+1 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x41bee000) = 0x86800000.
@1,771,336us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> Enter(virtAddr=0x41bee000, size=4, physAddr=0x86800000)
@1,771,509us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> creating new contigBuf object
@1,771,652us: [+0 T:0x413f5490 S:0x413f4a4c] OM - Memory_alloc> Enter(0x10)
@1,771,810us: [+0 T:0x413f5490 S:0x413f4a4c] OM - Memory_alloc> return (0x97018)
@1,771,955us: [+1 T:0x413f5490 S:0x413f4a64] OM - Memory__addContigBuf> returning: cb->phys=0x86800000, cb->size=4, cb->virt=0x41bee000
@1,772,110us: [+0 T:0x413f5490 S:0x413f4aac] OM - Memory_getBufferPhysicalAddress> return (0x86800000)
@1,772,258us: [+2 T:0x413f5490 S:0x413f4ae4] ti.sdo.dmai - [Buffer] Set user pointer 0x41bee000 (physical 0x86800000)
@1,788,159us: [+2 T:0x413f5490 S:0x413f4b04] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x41bee000 has physical address 0x86800000
@1,788,680us: [+2 T:0x427e9490 S:0x427e8c8c] ti.sdo.dmai - [Capture] Checking video standard
@1,813,972us: [+2 T:0x427e9490 S:0x427e8c8c] ti.sdo.dmai - [Capture] Capture input set to COMPOSITE
@1,815,324us: [+0 T:0x42fe9490 S:0x42fe8c44] CE - Engine_open> Enter('video_copy', 0x0, 0x42fe8cb4)
@1,815,542us: [+0 T:0x42fe9490 S:0x42fe8c2c] OM - Memory_alloc> Enter(0x2c)
@1,815,716us: [+0 T:0x42fe9490 S:0x42fe8c2c] OM - Memory_alloc> return (0x970f8)
@1,815,867us: [+0 T:0x42fe9490 S:0x42fe8c44] CE - rserverOpen('video_copy.x64P'), count = 0
@1,816,016us: [+0 T:0x42fe9490 S:0x42fe8c0c] OP - Processor_create> Enter(imageName='video_copy.x64P', linkCfg='(null)', attrs=0x42fe8c98)
@1,816,921us: [+0 T:0x4001f930 S:0xbedb5a6c] CE - Engine_open> Enter('video_copy', 0x0, 0xbedb5adc)
@1,817,139us: [+0 T:0x4001f930 S:0xbedb5a54] OM - Memory_alloc> Enter(0x2c)
@1,817,308us: [+0 T:0x4001f930 S:0xbedb5a54] OM - Memory_alloc> return (0x97128)
@1,817,946us: [+0 T:0x42fe9490 S:0x42fe8bf4] OM - Memory_alloc> Enter(0x24)
@1,818,161us: [+0 T:0x42fe9490 S:0x42fe8bf4] OM - Memory_alloc> return (0x97158)
@1,818,352us: [+0 T:0x42fe9490 S:0x42fe8bec] OP - doCmd> Enter (cmdId=1, proc=0x97158)
@1,818,511us: [+0 T:0x42fe9490 S:0x42fe8bdc] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x5f1c0]
@1,818,732us: [+0 T:0x42fe9490 S:0x42fe8bec] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x5f1c0]
@1,818,903us: [+0 T:0x42fe9490 S:0x42fe8bcc] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x5f1d8] timeout[0xffffffff]
@1,819,315us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x5f1c0] status[0]
@1,819,507us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Exit (result=1)
@1,819,661us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Enter(proc=0x97158)
@1,819,836us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Initializing DSP PROC...
@1,820,140us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'video_copy.x64P']
@1,820,328us: [+0 T:0x40bc8490 S:0x40bc7d5c] OM - Memory_alloc> Enter(0xe0)
@1,820,500us: [+0 T:0x40bc8490 S:0x40bc7d5c] OM - Memory_alloc> return (0x97180)
@1,820,858us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fa00000, sizeInBytes=0x400000, shared=1, syncd=0
@1,821,071us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000, sizeInBytes=0x100000, shared=1, syncd=0
@1,821,268us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x8ff00000, sizeInBytes=0x80, shared=1, syncd=0
@1,821,478us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x88000000, sizeInBytes=0x7a00000, shared=0, syncd=0
@1,821,663us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> DODSPCTRL was=1; now=0
@1,825,881us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Attaching to DSP PROC...
@1,836,449us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Opening MSGQ pool...
@1,837,422us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Loading video_copy.x64P on DSP (1 args)...
@1,838,858us: [+2 T:0x427e9490 S:0x427e8ad4] ti.sdo.dmai - [Capture] Checking video standard
@1,866,865us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Starting DSP PROC...
@1,903,507us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Opening remote transport...
@1,904,635us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> return (1)
@1,904,842us: [+0 T:0x40bc8490 S:0x40bc7d64] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x5f1d8]
@1,905,056us: [+0 T:0x42fe9490 S:0x42fe8bcc] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x5f1d8] status[0]
@1,905,240us: [+0 T:0x42fe9490 S:0x42fe8bec] OP - doCmd> Exit (result=1)
@1,905,381us: [+0 T:0x42fe9490 S:0x42fe8c0c] OP - Processor_create> return (0x97158)
@1,905,566us: [+0 T:0x42fe9490 S:0x42fe8c44] CE - rserverOpen('video_copy.x64P'): 0x5dde4 done.
@1,905,762us: [+0 T:0x42fe9490 S:0x42fe8c2c] OM - Memory_alloc> Enter(0x28)
@2,246,090us: [+0 T:0x42fe9490 S:0x42fe8c2c] OM - Memory_alloc> return (0x973b8)
@2,246,313us: [+0 T:0x42fe9490 S:0x42fe8c1c] OC - Comm_create> Enter(queueName='video_copy_771_0', queue=0x97108, attrs=0x0)
@2,246,481us: [+0 T:0x42fe9490 S:0x42fe8c04] OM - Memory_alloc> Enter(0x4)
@2,246,635us: [+0 T:0x42fe9490 S:0x42fe8c04] OM - Memory_alloc> return (0x973e8)
@2,247,156us: [+0 T:0x42fe9490 S:0x42fe8c1c] OC - Comm_create> return (0x973e8)
@2,247,358us: [+0 T:0x42fe9490 S:0x42fe8c24] OM - Memory_free> Enter(0x973b8, 0x28)
@2,247,560us: [+0 T:0x42fe9490 S:0x42fe8c24] OM - Memory_free> return (0x1)
@2,247,711us: [+0 T:0x42fe9490 S:0x42fe8c24] OC - Comm_alloc> Enter(poolId=0x0, msg=0x97114, size=576)
@2,247,913us: [+0 T:0x42fe9490 S:0x42fe8c24] OC - Comm_alloc> msg=0x437f9c80, returning (0)
@2,248,071us: [+0 T:0x42fe9490 S:0x42fe8c0c] OC - Comm_locate> Enter(queueName='rmsq', queue=0x97104)
@2,248,466us: [+2 T:0x427e9490 S:0x427e8ad4] ti.sdo.dmai - [Capture] Capture input set to COMPOSITE
@2,248,822us: [+2 T:0x427e9490 S:0x427e8bb4] ti.sdo.dmai - [Capture] Video input connected size 720x480 pitch 1440
@2,249,100us: [+2 T:0x427e9490 S:0x427e8a3c] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers
@2,249,465us: [+0 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x4386a000, size=4)
@2,249,668us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x4386a000, size=4)
@2,249,825us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@2,250,115us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x4386a000) = 0x80a00000.
@2,250,333us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> Enter(virtAddr=0x4386a000, size=4, physAddr=0x80a00000)
@2,250,503us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> creating new contigBuf object
@2,250,646us: [+0 T:0x427e9490 S:0x427e89ac] OM - Memory_alloc> Enter(0x10)
@2,250,792us: [+0 T:0x427e9490 S:0x427e89ac] OM - Memory_alloc> return (0xd7380)
@2,250,937us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> returning: cb->phys=0x80a00000, cb->size=4, cb->virt=0x4386a000
@2,251,092us: [+0 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> return (0x80a00000)
@2,251,242us: [+2 T:0x427e9490 S:0x427e8a44] ti.sdo.dmai - [Buffer] Set user pointer 0x4386a000 (physical 0x80a00000)
@2,267,112us: [+2 T:0x427e9490 S:0x427e8a64] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x4386a000 has physical address 0x80a00000
@2,267,557us: [+0 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43942000, size=4)
@2,267,765us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43942000, size=4)
@2,267,925us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@2,268,094us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43942000) = 0x87300000.
@2,268,274us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> Enter(virtAddr=0x43942000, size=4, physAddr=0x87300000)
@2,268,439us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> creating new contigBuf object
@2,268,578us: [+0 T:0x427e9490 S:0x427e89ac] OM - Memory_alloc> Enter(0x10)
@2,268,761us: [+0 T:0x427e9490 S:0x427e89ac] OM - Memory_alloc> return (0xd7398)
@2,268,913us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> returning: cb->phys=0x87300000, cb->size=4, cb->virt=0x43942000
@2,269,071us: [+0 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> return (0x87300000)
@2,269,220us: [+2 T:0x427e9490 S:0x427e8a44] ti.sdo.dmai - [Buffer] Set user pointer 0x43942000 (physical 0x87300000)
@2,285,154us: [+2 T:0x427e9490 S:0x427e8a64] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x43942000 has physical address 0x87300000
@2,285,590us: [+0 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43a1a000, size=4)
@2,285,824us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43a1a000, size=4)
@2,285,988us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@2,286,161us: [+1 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43a1a000) = 0x80900000.
@2,627,272us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> Enter(virtAddr=0x43a1a000, size=4, physAddr=0x80900000)
@2,627,479us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> creating new contigBuf object
@2,627,634us: [+0 T:0x427e9490 S:0x427e89ac] OM - Memory_alloc> Enter(0x10)
@2,627,791us: [+0 T:0x427e9490 S:0x427e89ac] OM - Memory_alloc> return (0xd73b0)
@2,627,938us: [+1 T:0x427e9490 S:0x427e89c4] OM - Memory__addContigBuf> returning: cb->phys=0x80900000, cb->size=4, cb->virt=0x43a1a000
@2,628,093us: [+0 T:0x427e9490 S:0x427e8a0c] OM - Memory_getBufferPhysicalAddress> return (0x80900000)
@2,628,241us: [+2 T:0x427e9490 S:0x427e8a44] ti.sdo.dmai - [Buffer] Set user pointer 0x43a1a000 (physical 0x80900000)
@2,644,195us: [+2 T:0x427e9490 S:0x427e8a64] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x43a1a000 has physical address 0x80900000
@2,644,620us: [+0 T:0x42fe9490 S:0x42fe8c0c] OC - Comm_locate> return (0)
@2,644,838us: [+0 T:0x42fe9490 S:0x42fe8c44] CE - checkServer(0x970f8)
@2,645,025us: [+0 T:0x42fe9490 S:0x42fe8c14] OC - Comm_put> Enter(queue=0x0, msg=0x437f9c80)
@2,645,299us: [+0 T:0x42fe9490 S:0x42fe8c14] OC - Comm_put> return (0)
@2,645,501us: [+0 T:0x42fe9490 S:0x42fe8c0c] OC - Comm_get> Enter(queue=0x10000, msg=0x42fe8cb0, timeout=-1)
@2,645,753us: [+0 T:0x4001f930 S:0xbedb5a6c] CE - rserverOpen('video_copy.x64P'), count = 1
@2,645,962us: [+0 T:0x4001f930 S:0xbedb5a6c] CE - rserverOpen('video_copy.x64P'): 0x5dde4 done.
@2,646,350us: [+0 T:0x4001f930 S:0xbedb5a54] OM - Memory_alloc> Enter(0x28)
@2,646,521us: [+0 T:0x4001f930 S:0xbedb5a54] OM - Memory_alloc> return (0x973b8)
@2,646,718us: [+0 T:0x4001f930 S:0xbedb5a44] OC - Comm_create> Enter(queueName='video_copy_771_1', queue=0x97138, attrs=0x0)
@2,646,886us: [+0 T:0x4001f930 S:0xbedb5a2c] OM - Memory_alloc> Enter(0x4)
@2,647,068us: [+0 T:0x4001f930 S:0xbedb5a2c] OM - Memory_alloc> return (0xd73c8)
@2,647,813us: [+0 T:0x4001f930 S:0xbedb5a44] OC - Comm_create> return (0xd73c8)
@2,648,017us: [+0 T:0x4001f930 S:0xbedb5a4c] OM - Memory_free> Enter(0x973b8, 0x28)
@2,648,186us: [+0 T:0x4001f930 S:0xbedb5a4c] OM - Memory_free> return (0x1)
@2,648,353us: [+0 T:0x4001f930 S:0xbedb5a4c] OC - Comm_alloc> Enter(poolId=0x0, msg=0x97144, size=576)
@2,648,586us: [+0 T:0x4001f930 S:0xbedb5a4c] OC - Comm_alloc> msg=0x437fac80, returning (0)
@2,648,749us: [+0 T:0x4001f930 S:0xbedb5a34] OC - Comm_locate> Enter(queueName='rmsq', queue=0x97134)
@2,649,136us: [+0 T:0x40bc8490 S:0x40bc7d74] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x5f1d8]
@2,649,562us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Enter (proc=0x40bc7de8)
@2,649,733us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x5f1c0] timeout[0xffffffff]
@2,650,249us: [+0 T:0x42fe9490 S:0x42fe8c0c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@2,650,456us: [+0 T:0x42fe9490 S:0x42fe8c44] CE - rmsInit> RMS initialized(0x970f8); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3
@2,650,638us: [+0 T:0x42fe9490 S:0x42fe8c1c] CE - Engine_setTrace> Enter(engine=0x970f8, mask='*+01234567,GT_prefix=12345,GT_time=3')
@2,650,853us: [+1 T:0x42fe9490 S:0x42fe8c1c] CE - Engine_setTrace> Requesting DSP set trace ...
@2,651,007us: [+0 T:0x42fe9490 S:0x42fe8bec] OC - Comm_put> Enter(queue=0x0, msg=0x437f9c80)
@2,651,237us: [+0 T:0x42fe9490 S:0x42fe8bec] OC - Comm_put> return (0)
@2,651,434us: [+0 T:0x42fe9490 S:0x42fe8be4] OC - Comm_get> Enter(queue=0x10000, msg=0x42fe8c64, timeout=-1)
@2,651,908us: [+0 T:0x4001f930 S:0xbedb5a34] OC - Comm_locate> return (0)
@2,652,108us: [+0 T:0x4001f930 S:0xbedb5a6c] CE - checkServer(0x97128)
@2,652,310us: [+0 T:0x4001f930 S:0xbedb5a3c] OC - Comm_put> Enter(queue=0x0, msg=0x437fac80)
@2,652,596us: [+0 T:0x4001f930 S:0xbedb5a3c] OC - Comm_put> return (0)
@2,652,812us: [+0 T:0x4001f930 S:0xbedb5a34] OC - Comm_get> Enter(queue=0x10001, msg=0xbedb5ad8, timeout=-1)
@2,653,180us: [+0 T:0x42fe9490 S:0x42fe8be4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@2,994,174us: [+0 T:0x42fe9490 S:0x42fe8c1c] CE - Engine_setTrace> return(0)
@2,994,393us: [+0 T:0x42fe9490 S:0x42fe8bac] OC - Comm_put> Enter(queue=0x0, msg=0x437f9c80)
@2,994,635us: [+0 T:0x42fe9490 S:0x42fe8bac] OC - Comm_put> return (0)
@2,994,842us: [+0 T:0x42fe9490 S:0x42fe8ba4] OC - Comm_get> Enter(queue=0x10000, msg=0x42fe8c44, timeout=-1)
@2,995,063us: [+0 T:0x4001f930 S:0xbedb5a34] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@2,995,440us: [+0 T:0x42fe9490 S:0x42fe8ba4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @0x000001b6:[T:0x00000000] servers.video_copy.evmDM6446 - main> Welcome to DSP server's main().
[DSP] @1,735,542tk: [+0 T:0x8faa5bc4 S:0x8faa9b3c] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3')
[DSP] @1,735,618tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @1,735,679tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.targets.rts6000 (/home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/packages/ti/targets/rts6000/) [1,0,0,0,1225517497925]
[DSP] @1,735,760tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.fc.global (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/sdo/fc/global/) [1,0,0,1240266696499]
[DSP] @1,735,843tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.fc.dman3 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662]
[DSP] @1,735,926tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.global (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464]
[DSP] @1,736,006tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.xdais.dm (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/xdais/dm/) [1,0,5,1236972452910]
[DSP] @1,736,086tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.xdais (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/xdais/) [1,2,1,1236972427008]
[DSP] @1,736,163tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.node (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858]
[DSP] @1,736,251tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1240276720026]
[DSP] @1,736,339tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.utils.trace (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890]
[DSP] @1,736,424tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.utils.xdm (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490]
[DSP] @1,736,506tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package dsplink.dsp (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/dsplink/dsp/) [1,4,0,1239931280000]
[DSP] @1,736,586tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.rtdx (/home/gzj/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/rtdx/) [2,0,0,4,1219531643983]
[DSP] @1,736,658tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.psl (/home/gzj/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/psl/) [5,0,0,0,0]
[DSP] @1,736,724tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.bios (/home/gzj/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/bios/) [5,2,5,6,1227035764854]
[DSP] @1,736,796tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.fc.dskt2 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/sdo/fc/dskt2/) [1,0,4,1240266678055]
[DSP] @1,736,879tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.fc.memutils (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007]
[DSP] @1,736,963tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.fc.acpy3 (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108]
[DSP] @1,737,046tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.bios.utils (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages/ti/bios/utils/) [2,0,2,1,1228269225511]
[DSP] @1,737,128tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.catalog.c6000 (/home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/packages/ti/catalog/c6000/) [1,0,0,0,0]
[DSP] @1,737,203tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.platforms.evmDM6446 (/home/gzj/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/platforms/evmDM6446/) [1,0,0,1,0]
[DSP] @1,737,281tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.osal (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,12402767@3,342,221us: [+0 T:0x42fe9490 S:0x42fe8bac] OC - Comm_put> Enter(queue=0x0, msg=0x437f9c80)
@3,342,529us: [+0 T:0x42fe9490 S:0x42fe8bac] OC - Comm_put> return (0)
@3,342,735us: [+0 T:0x42fe9490 S:0x42fe8ba4] OC - Comm_get> Enter(queue=0x10000, msg=0x42fe8c44, timeout=-1)
@3,343,076us: [+0 T:0x42fe9490 S:0x42fe8ba4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
30877]
[DSP] @1,737,360tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.osal.bios (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/bios/) [2,0,1,1240276734107]
[DSP] @1,737,443tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.ipc (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961]
[DSP] @1,737,521tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.ipc.bios (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1240276705217]
[DSP] @1,737,603tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.alg (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798]
[DSP] @1,737,681tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491]
[DSP] @1,737,757tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.bioslog (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/bioslog/) [1,0,1,1240276303166]
[DSP] @1,737,838tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package ti.sdo.ce.video (/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video/) [1,0,3,1240276930771]
[DSP] @1,737,918tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package codecs.viddec_copy (/home/gzj/gzjDVEVM/video_copy_encodedecode/codecs/viddec_copy/) [1,0,0,1269220815000]
[DSP] @1,737,994tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package codecs.videnc_copy (/home/gzj/gzjDVEVM/video_copy_encodedecode/codecs/videnc_copy/) [1,0,0,1269066695000]
[DSP] @1,738,072tk: [+4 T:0x8faa5bc4 S:0x8faa9b3c] OG -     package video_copy (/home/gzj/gzjDVEVM/video_copy_encodedecode/servers/video_copy/video_copy/) []
[DSP] @1,738,142tk: [+0 T:0x8faa5bc4 S:0x8faa9b3c] OG - Global_setSpecialTrace> return
[DSP] @1,738,672tk: [+0 T:0x8faa5bc4 S:0x8faa9b84] CR - processRmsCmd(0x8fe06ca8, 4056): cmd = 6
[DSP] @2,532,311tk: [+0 T:0x8faa5bc4 S:0x8faa9b84] CR - processRmsCmd(0x8fe05ca8, 4056): cmd = 5
[DSP] @2,532,367tk: [+0 T:0x8faa5bc4 S:0x8faa9b84] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @3,339,530tk: [+0 T:0x8faa5bc4 S:0x8faa9b84] CR - processRmsCmd(0x8fe05ca8, 4056): cmd = 5
[DSP] @3,339,592tk: [+0 T:0x8faa5bc4 S:0x8faa9b84] CR - remote time = 0x0, trace buffer size = 4032
@3,346,937us: [+0 T:0x42fe9490 S:0x42fe8bdc] CE - Engine_fwriteTrace> returning count [6539]
@3,347,144us: [+0 T:0x42fe9490 S:0x42fe8c44] CE - Engine_open> return(618744)
@3,347,527us: [+7 T:0x42fe9490 S:0x42fe8bcc] ti.sdo.dmai - [Venc1] Cannot pass null for engine, codec name, params or dynamic params
Error: Failed to create video encoder: videnc_copy
@3,688,872us: [+0 T:0x4001f930 S:0xbedb59d4] OC - Comm_put> Enter(queue=0x0, msg=0x437fac80)
@3,689,171us: [+0 T:0x4001f930 S:0xbedb59d4] OC - Comm_put> return (0)
@3,689,389us: [+0 T:0x4001f930 S:0xbedb59cc] OC - Comm_get> Enter(queue=0x10001, msg=0xbedb5a6c, timeout=-1)
@3,689,762us: [+0 T:0x4001f930 S:0xbedb59cc] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @4,143,848tk: [+0 T:0x8faa5bc4 S:0x8faa9b84] CR - processRmsCmd(0x8fe06ca8, 4056): cmd = 5
[DSP] @4,143,903tk: [+0 T:0x8faa5bc4 S:0x8faa9b84] CR - remote time = 0x0, trace buffer size = 4032
@3,690,421us: [+0 T:0x4001f930 S:0xbedb5a04] CE - Engine_fwriteTrace> returning count [197]
@3,690,605us: [+0 T:0x4001f930 S:0xbedb5a6c] CE - Engine_open> return(618792)
@37,799,177us: [+0 T:0x4001f930 S:0xbedb575c] OG - Global_exit> enter
@37,799,403us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x12f4c()...
@37,799,607us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2424c()...
@37,799,773us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x25f6c()...
@37,800,084us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> Enter(0x5f430, 0x18)
@37,800,283us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> return (0x1)
@37,800,442us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> Enter(0x5f450, 0x18)
@37,800,602us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> return (0x1)
@37,800,748us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> Enter(0x5f470, 0x18)
@37,800,903us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> return (0x1)
@37,801,052us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2e610()...
@37,801,211us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x28ad8()...
@37,801,367us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x296ac()...
@37,801,520us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2bde4()...
@37,801,673us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x29a60()...
@37,801,820us: [+0 T:0x4001f930 S:0xbedb572c] OP - doCmd> Enter (cmdId=3, proc=0x0)
@37,801,974us: [+0 T:0x4001f930 S:0xbedb571c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x5f1c0]
@37,802,161us: [+0 T:0x4001f930 S:0xbedb572c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x5f1c0]
@37,802,325us: [+0 T:0x4001f930 S:0xbedb570c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x5f1d8] timeout[0xffffffff]
@37,802,533us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x5f1c0] status[0]
@37,802,713us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Exit (result=3)
@37,802,865us: [+0 T:0x40bc8490 S:0x40bc7d64] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x5f1d8]
@37,803,044us: [+0 T:0x40bc8490 S:0x40bc7d74] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x5f1d8]
@37,803,463us: [+0 T:0x4001f930 S:0xbedb570c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x5f1d8] status[0]
@37,803,668us: [+0 T:0x4001f930 S:0xbedb572c] OP - doCmd> Exit (result=1)
@37,803,818us: [+0 T:0x4001f930 S:0xbedb5734] OT - Thread_delete> Enter (task=0x5f210)
@37,804,028us: [+4 T:0x4001f930 S:0xbedb5734] OT - Thread_delete> pthread_cancel (0x3)
@37,804,241us: [+4 T:0x4001f930 S:0xbedb5734] OT - Thread_delete> pthread_join (0x0)
@37,804,408us: [+0 T:0x4001f930 S:0xbedb5714] OM - Memory_free> Enter(0x5f210, 0x64)
@37,804,574us: [+0 T:0x4001f930 S:0xbedb5714] OM - Memory_free> return (0x1)
@37,804,721us: [+0 T:0x4001f930 S:0xbedb574c] OT - Thread_delete> Exit (task=0x5f210)
@37,804,867us: [+0 T:0x4001f930 S:0xbedb573c] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x5f1c0]
@37,805,046us: [+0 T:0x4001f930 S:0xbedb571c] OM - Memory_free> Enter(0x5f1c0, 0x14)
@37,805,221us: [+0 T:0x4001f930 S:0xbedb571c] OM - Memory_free> return (0x1)
@37,805,369us: [+0 T:0x4001f930 S:0xbedb574c] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@37,805,512us: [+0 T:0x4001f930 S:0xbedb573c] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x5f1d8]
@37,805,658us: [+0 T:0x4001f930 S:0xbedb571c] OM - Memory_free> Enter(0x5f1d8, 0x14)
@37,805,811us: [+0 T:0x4001f930 S:0xbedb571c] OM - Memory_free> return (0x1)
@37,805,959us: [+0 T:0x4001f930 S:0xbedb574c] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@37,806,100us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> Enter(0x5f1f0, 0x18)
@37,806,250us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> return (0x1)
@37,806,399us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2e120()...
@37,806,588us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2b898()...
@37,806,755us: [+0 T:0x4001f930 S:0xbedb573c] OM - Memory_free> Enter(0x5f140, 0x18)
@37,806,911us: [+0 T:0x4001f930 S:0xbedb573c] OM - Memory_free> return (0x1)
@37,807,060us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2c9ec()...
@38,340,025us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> Enter(0x5f0f0, 0x18)
@38,340,239us: [+0 T:0x4001f930 S:0xbedb572c] OM - Memory_free> return (0x1)
@38,340,410us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2eabc()...
@38,340,575us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2f670()...
@38,340,732us: [+2 T:0x4001f930 S:0xbedb575c] OG - Global_exit> calling function *0x2ea1c()...
root@192.168.0.15:/opt/dvevm#

You've highlighted exactly the issue:

zhijun guo said:

@3,347,527us: [+7 T:0x42fe9490 S:0x42fe8bcc] ti.sdo.dmai - [Venc1] Cannot pass null for engine, codec name, params or dynamic params
Error: Failed to create video encoder: videnc_copy

While XDM doesn't require you provide creation params (they can be NULL), it appears that DMAI's Venc1_create() _does_ require that you provide create params.  It also looks like Venc1_create() implicitly also makes 2 control() calls (XDM_SETPARAMS and XDM_GETBUFINFO), so it also requires you provide dynamicParams as well.

Fortunately, it looks like DMAI provides default structs which applications can use:  Venc1_Params_DEFAULT and Venc1_DynamicParams_DEFAULT.  Perhaps you can create your video codec using those?

Chris

thank you very much for you reply
 after modified the video.c and rebuild the codecs servers app
 then copy to the nfs  and run >CE_DEBUG=3 ./encodedecode
 the console print this words "VISA_create2> Unable to locate alg "videnc_copy"."
 
 
 the details I did like is :
 ======================================================================================================
 1. modify the video.c
       .........................................
    decParams = envp->decParams ? envp->decParams : &defaultDecParams;
    decDynParams = envp->decDynParams ? envp->decDynParams :
                                        &defaultDecDynParams;

    encParams = envp->encParams ? envp->encParams : &defaultEncParams;
    encDynParams = envp->encDynParams ? envp->encDynParams :
                                        &defaultEncDynParams;

    gblSetImageWidth(envp->imageWidth);
    gblSetImageHeight(envp->imageHeight);

    gfxAttrs.colorSpace     = ColorSpace_UYVY;
    gfxAttrs.dim.width      = envp->imageWidth;
    gfxAttrs.dim.height     = envp->imageHeight;
    gfxAttrs.dim.lineLength = BufferGfx_calcLineLength(gfxAttrs.dim.width,
                                                       gfxAttrs.colorSpace);

    if (envp->passThrough) {
        bufSize = gfxAttrs.dim.lineLength * gfxAttrs.dim.height;

        /* Only the display thread can own a buffer since no codecs are used */
        gfxAttrs.bAttrs.useMask = DISPLAY_FREE;
    }
    else {
        /* Open the codec engine */
        hEngine = Engine_open(envp->engineName, NULL, NULL);

        if (hEngine == NULL) {
            ERR("Failed to open codec engine %s\n", envp->engineName);
            cleanup(THREAD_FAILURE);
        }
        printf("create the codec engine successed,ID is :%d\n", hEngine);
        /* Set the resolution to match the specified resolution */
        encParams->maxWidth          = envp->imageWidth;
        encParams->maxHeight         = envp->imageHeight;
        encParams->inputChromaFormat = XDM_YUV_422ILE;

        /* Set up codec parameters depending on bit rate */
        if (envp->videoBitRate < 0) {
            /* Variable bit rate */
            encParams->rateControlPreset = IVIDEO_NONE;

            /*
             * If variable bit rate use a bogus bit rate value (> 0)
             * since it will be ignored.
             */
            encParams->maxBitRate        = 2000000;
        }
        else {
            /* Constant bit rate */
            encParams->rateControlPreset = IVIDEO_LOW_DELAY;
            encParams->maxBitRate        = envp->videoBitRate;
        }

        encDynParams->targetBitRate = encParams->maxBitRate;
        encDynParams->inputWidth    = encParams->maxWidth;
        encDynParams->inputHeight   = encParams->maxHeight;

      
        /* Create the video encoder */
        hVe1 = Venc1_create(hEngine, envp->videoEncoder,
                            encParams, encDynParams);  // //★★★★★★★★★
        /*hVe1 = Venc1_create(hEngine, envp->videoEncoder,
                            NULL, NULL);*/ 
        if (hVe1 == NULL) {
            ERR("Failed to create video encoder: %s\n", envp->videoEncoder);
            cleanup(THREAD_FAILURE);
        }

.................................................................
   +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++    
2, rebuild the codecs and servers
  this is build servers message:
 
  XDCPATH="/home/gzj/gzjDVEVM/video_copy_encodedecode/servers/video_copy/../..;/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages;/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages;/home/gzj/dvsdk_2_00_00_22/bios_5_33_03/packages" /home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/xs xdc.tools.configuro -c /home/gzj/dvsdk_2_00_00_22/cg6x_6_0_16/ -o video_copy \
        -t ti.targets.C64P -p ti.platforms.evmDM6446 -b /home/gzj/gzjDVEVM/video_copy_encodedecode/servers/video_copy/../../config.bld \
        --tcf video_copy.cfg
making package.mak (because of package.bld) ...
config.bld: Running the version from Codec Engine Examples.
config.bld: loading user build configuration file /home/gzj/gzjDVEVM/video_copy_encodedecode/user.bld
generating interfaces for package video_copy (because package/package.xdc.inc is older than package.xdc) ...
configuring video_copy.x64P from package/cfg/video_copy_x64P.cfg ...
platform   = ti.platforms.evmDM6446
codecs.videnc_copy.close() ...
ti.sdo.ce.ipc.bios.close(): loading dsplink.dsp

NOTE: You can find the complete server data sheet in ./package/info/video_copy.x64P.DataSheet.html
--------------------------------------------------------------------------------------------------

    will link with codecs.videnc_copy:lib/videnc_copy_dma.a64P
    will link with codecs.viddec_copy:lib/viddec_copy.a64P
    will link with ti.sdo.ce.video:lib/release/video.a64P
    will link with ti.sdo.ce.bioslog:lib/release/bioslog.a64P
    will link with ti.sdo.ce:lib/release/ce.a64P
    will link with ti.sdo.ce.alg:lib/release/Algorithm_BIOS.a64P
    will link with ti.sdo.ce.ipc.bios:lib/release/ipc_bios.a64P
    will link with ti.sdo.ce.osal.bios:lib/osal_bios.a64P
    will link with ti.sdo.ce.osal.bios:lib/osal_bios_load.a64P
    will link with ti.bios.utils:lib/utils.a64P
    will link with ti.sdo.fc.acpy3:lib/release/acpy3.a64P
    will link with ti.sdo.fc.memutils:lib/release/memutils.a64P
    will link with ti.sdo.fc.dskt2:lib/release/dskt2.a64P
    will link with ti.sdo.ce.utils.xdm:lib/release/XdmUtils.a64P
    will link with ti.sdo.utils.trace:lib/release/gt.a64P
    will link with ti.sdo.ce.node:lib/release/node.a64P
    will link with ti.sdo.fc.dman3:lib/release/dman3Cfg.a64P
cl64P package/cfg/video_copy_x64P.c ...
asm64P package/cfg/video_copy_x64Pcfg.s62 ...
cl64P package/cfg/video_copy_x64Pcfg_c.c ...
XDCPATH="/home/gzj/gzjDVEVM/video_copy_encodedecode/servers/video_copy/../..;/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/cetools/packages;/home/gzj/dvsdk_2_00_00_22/codec_engine_2_23_01/packages;/home/gzj/dvsdk_2_00_00_22/bios_5_33_03/packages" /home/gzj/dvsdk_2_00_00_22/xdctools_3_10_03/xs xdc.tools.configuro -c /home/gzj/dvsdk_2_00_00_22/cg6x_6_0_16/ -o video_copy \
        -t ti.targets.C64P -p ti.platforms.evmDM6446 -b /home/gzj/gzjDVEVM/video_copy_encodedecode/servers/video_copy/../../config.bld \
        --tcf video_copy.cfg
/home/gzj/dvsdk_2_00_00_22/cg6x_6_0_16//bin/cl6x -@ video_copy/compiler.opt -c main.c
/home/gzj/dvsdk_2_00_00_22/cg6x_6_0_16//bin/lnk6x -o video_copy.x64P -c main.obj video_copy/linker.cmd
Creating server release:
making package.mak (because of package.bld) ...
config.bld: Running the version from Codec Engine Examples.
config.bld: loading user build configuration file /home/gzj/gzjDVEVM/video_copy_encodedecode/user.bld
generating interfaces for package servers.video_copy (because package/package.xdc.inc is older than package.xdc) ...
all files complete.
generating schema include file list ...
generating external package references package/package.ext.xml ...
generating package references graph package/package.rel.dot ...
making release file servers_video_copy.tar (because of package/rel/servers_video_copy.xdc.inc) ...
+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
3,then I rebuild the apps and copy video_copy.x64P and encodedecode to nfs
+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
4,then run >CE_DEBUG=3 ./encodedecode
the console print like is :
......................
@3,723,032us: [+2 T:0x42fe9490 S:0x42fe8bcc] ti.sdo.dmai - [Venc1] Creating encoder videnc_copy for max 720x480 bitrate 2000000 ratectrl 4
@3,723,307us: [+0 T:0x42fe9490 S:0x42fe8ba4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x970f8, name='videnc_copy', params=0x42fe8d84)
@4,063,881us: [+0 T:0x42fe9490 S:0x42fe8b74] CV - VISA_create(0x970f8, 'videnc_copy', 0x42fe8d84, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
@4,064,095us: [+0 T:0x42fe9490 S:0x42fe8a74] CV - VISA_create2(0x970f8, 'videnc_copy', 0x42fe8d84, 0x30, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
@4,064,288us: [+6 T:0x42fe9490 S:0x42fe8a54] CE - Engine_getConstName> Unable to locate alg "videnc_copy" (type "ti.sdo.ce.video1.IVIDENC1").
@4,064,455us: [+6 T:0x42fe9490 S:0x42fe8a74] CV - VISA_create2> Unable to locate alg "videnc_copy".
@4,064,608us: [+0 T:0x42fe9490 S:0x42fe8a4c] CV - VISA_delete(0x0)
@4,064,751us: [+0 T:0x42fe9490 S:0x42fe8ba4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x0)
@4,064,906us: [+7 T:0x42fe9490 S:0x42fe8bcc] ti.sdo.dmai - [Venc1] Failed to open video encode algorithm: videnc_copy (0x0)
....................................

 

 

thank you Chris!

this problem have been solved ;as you said  my codec videnc_copy use IVIDENC but my apps(ARM-side) use IVIDENC1, I edit the codec using CE_INSTALL_DIR/..../videnc1_copy instead of videnc_copy then rebuild and copy    it's work very well!!!

thank you !

hi,  zhijun guo

I am now doing dm6467 and encountered the same problem as you ( add the videnc1_copy to the encodedecode demo, but was told " failed to create encoder"  ), could you help me?

thank you!

zhiqiang li

 

hello  Chris,

         I am doing a project based on dm6467, and I encountered the same problem as zhijun guo ( add the videnc1_copy and viddec2_copy to the encodedecode demo, and the encoder failed to create ).

         I don't know why.

         could you help me?  Thank you.

         I use the rename the loopback.cfg to video_copy.cfg,   rename the loopback.tcf to video_copy.tcf, and modify the contents of encodedecode.cfg

var demoEngine = Engine.createFromServer(
    "encodedecode",
    "./video_copy.x64P",
    "ti.sdo.ce.examples.servers.video_copy.evmDM6467"
    );

/*
var demoEngine = Engine.createFromServer(
    "encodedecode",
    "./loopbackCombo.x64P",
    "ti.sdo.servers.loopback"
    );
*/

modify the contents of video.c

 

/* Create the video encoder */
/*---------------------------------------------modifiedd by lizhiqiang, 2010, 7, 22-----------------------*/
/*        hVe1 = Venc1_create(hEngine, "h264enc", &encParams,
                            (VIDENC1_DynamicParams *) &extDynParams);
*/

         hVe1 = Venc1_create(hEngine, "videnc1_copy", &encParams,
                            (VIDENC1_DynamicParams *) &extDynParams);

        if (hVe1 == NULL) {
        /*    ERR("Failed to create h264 video encoder\n");  */
            ERR("Failed to create  videnc1_copy encoder\n");
            cleanup(THREAD_FAILURE);
        }

        decParams.maxWidth   = encParams.maxWidth;
        decParams.maxHeight  = encParams.maxHeight;

        /* Create the video decoder */
/*--------------------------------------------modified by lizhiqiang, 2010, 7, 22-------------------------*/
/*        hVd2 = Vdec2_create(hEngine, "h264dec", &decParams, &decDynParams);
*/

        hVd2 = Vdec2_create(hEngine, "viddec2_copy", &decParams, &decDynParams);

/*----------------------------------------------------------------------------------------------------------------------*/

 

the contents of all the files I modified are as follows:

/*****************************/

main.c

/*
 *  ======== main.c ========
 */
#include <xdc/std.h>
#include <ti/sdo/ce/CERuntime.h>
#include <ti/sdo/ce/trace/gt.h>

#include <ti/sdo/fc/rman/rman.h>
#include <ti/sdo/fc/ires/edma3chan/iresman_edma3Chan.h>
#include <ti/sdo/fc/ires/hdvicp/iresman_hdvicp.h>

static IRESMAN_HdVicpParams hdvicpConfig;

static IRESMAN_Edma3ChanParams edma3Config;

volatile char global_flag ;
volatile char frameSkipFlagGlobal;

/* trace info: module name, mask */
static GT_Mask gtMask = {0,0};

/*
 *  ======== main ========
 */
Void main (Int argc, Char *argv [])
{
    /* init Codec Engine */
    CERuntime_init();

    /* init trace */
 GT_init();

 /* create a mask to allow a trace-print welcome message below */
 GT_create(&gtMask, "decode_server");

 /* ...and initialize all masks in this module to "on" */
 GT_set("loopback_server=01234567");

 GT_0trace(gtMask, GT_4CLASS, "main> Welcome to DSP server's main().\n");

    RMAN_init();

    edma3Config.baseConfig.allocFxn = RMAN_PARAMS.allocFxn;
    edma3Config.baseConfig.freeFxn = RMAN_PARAMS.freeFxn;
    edma3Config.baseConfig.size = sizeof(IRESMAN_Edma3ChanParams);
    RMAN_register(&IRESMAN_EDMA3CHAN, (IRESMAN_Params *)&edma3Config);

    hdvicpConfig.numResources = 2;
    hdvicpConfig.baseConfig.allocFxn = RMAN_PARAMS.allocFxn;
    hdvicpConfig.baseConfig.freeFxn = RMAN_PARAMS.freeFxn;
    RMAN_register(&IRESMAN_HDVICP, (IRESMAN_Params *)&hdvicpConfig);

}

encodedecode.cfg

/*  ============================================================================
 *   Copyright (c)  Texas Instruments Incorporated 2008
 *
 *   Use of this software is controlled by the terms and conditions found in the
 *   license agreement under which this software has been supplied or provided.
 *  ============================================================================
 */

/* Load support for the Codec Engine OSAL */
var osalGlobal = xdc.useModule('ti.sdo.ce.osal.Global');
var os = xdc.useModule('ti.sdo.ce.osal.linux.Settings');
osalGlobal.os = os;

/* Configure CE to use it's DSP Link Linux version */
var ipc = xdc.useModule('ti.sdo.ce.ipc.Settings');
ipc.commType = ipc.COMM_DSPLINK;

/* Enable SoCrates tracing in the demo */
var TraceUtil = xdc.useModule('ti.sdo.ce.utils.trace.TraceUtil');
TraceUtil.attrs = TraceUtil.SOCRATES_TRACING;

/*
 *  ======== Engine Configuration ========
 */
var Engine = xdc.useModule('ti.sdo.ce.Engine');

var demoEngine = Engine.createFromServer(
    "encodedecode",
    "./video_copy.x64P",
    "ti.sdo.ce.examples.servers.video_copy.evmDM6467"
    );

/*
var demoEngine = Engine.createFromServer(
    "encodedecode",
    "./loopbackCombo.x64P",
    "ti.sdo.servers.loopback"
    );
*/

/* Load support for the 'Davinci Multimedia Application Interface' module */
var DMAI = xdc.loadPackage('ti.sdo.dmai');

/* Load support for SimpleWidget */
var SW = xdc.loadPackage('ti.sdo.simplewidget');

video.c

/*
 * video.c
 *
 * ============================================================================
 * Copyright (c) Texas Instruments Inc 2008
 *
 * Use of this software is controlled by the terms and conditions found in the
 * license agreement under which this software has been supplied or provided.
 * ============================================================================
 */

#include <stdio.h>
#include <string.h>

#include <xdc/std.h>

#include <ti/sdo/ce/Engine.h>
#include <ti/sdo/ce/osal/Memory.h>

#include <ti/sdo/dmai/Fifo.h>
#include <ti/sdo/dmai/Pause.h>
#include <ti/sdo/dmai/BufTab.h>
#include <ti/sdo/dmai/VideoStd.h>
#include <ti/sdo/dmai/BufferGfx.h>
#include <ti/sdo/dmai/Rendezvous.h>
#include <ti/sdo/dmai/ce/Vdec2.h>
#include <ti/sdo/dmai/ce/Venc1.h>

/* Include codec specific header file for extended params */
#include <ti/sdo/codecs/h264enc/ih264venc.h>

#include "encodedecode.h"
#include "video.h"

#define CAPTURE_PIPE_SIZE       4
#define DISPLAY_PIPE_SIZE       4
#define NUM_VIDEO_BUFS          CAPTURE_PIPE_SIZE + DISPLAY_PIPE_SIZE

/* The masks to use for knowing when a buffer is free */
#define CODEC_FREE              0x1
#define DISPLAY_FREE            0x2

/******************************************************************************
 * encodedecode
 ******************************************************************************/
static Int encodedecode(Venc1_Handle hVe1,
                        Vdec2_Handle hVd2,
                        Buffer_Handle hVidBuf,
                        Buffer_Handle hEncBuf,
                        Fifo_Handle displayFifo)
{
    Buffer_Handle hOutBuf, hFreeBuf;
    Int           ret;

    /* Make sure the whole buffer is used for input and output */
    BufferGfx_resetDimensions(hVidBuf);

    /* Encode the video buffer */
    if (Venc1_process(hVe1, hVidBuf, hEncBuf) < 0) {
        ERR("Failed to encode video buffer\n");
        return FAILURE;
    }

    /* Update global data for user interface */
    gblIncVideoBytesProcessed(Buffer_getNumBytesUsed(hEncBuf));

    /* Decode the video buffer */
    ret = Vdec2_process(hVd2, hEncBuf, hVidBuf);

    if (ret != Dmai_EOK) {
        ERR("Failed to decode video buffer\n");
        return FAILURE;
    }

    /* Send display frames to display thread */
    hOutBuf = Vdec2_getDisplayBuf(hVd2);
    while (hOutBuf) {
        if (Fifo_put(displayFifo, hOutBuf) < 0) {
            ERR("Failed to send buffer to display thread\n");
            return FAILURE;
        }

        hOutBuf = Vdec2_getDisplayBuf(hVd2);
    }

    /* Free up released frames */
    hFreeBuf = Vdec2_getFreeBuf(hVd2);
    while (hFreeBuf) {
        Buffer_freeUseMask(hFreeBuf, CODEC_FREE);
        hFreeBuf = Vdec2_getFreeBuf(hVd2);
    }

    return SUCCESS;
}

/******************************************************************************
 * resizeBufTab
******************************************************************************/
static Int resizeBufTab(Vdec2_Handle hVd2, Int displayBufs)
{
    BufTab_Handle hBufTab = Vdec2_getBufTab(hVd2);
    Int numBufs, numCodecBuffers, numExpBufs;
    Buffer_Handle hBuf;
    Int32 frameSize;

    /* How many buffers can the codec keep at one time? */
    numCodecBuffers = Vdec2_getMinOutBufs(hVd2);

    if (numCodecBuffers < 0) {
        ERR("Failed to get buffer requirements\n");
        return FAILURE;
    }

    /*
     * Total number of frames needed are the number of buffers the codec
     * can keep at any time, plus the number of frames in the display pipe.
     */
    numBufs = numCodecBuffers + displayBufs;

    /* Get the size of output buffers needed from codec */
    frameSize = Vdec2_getOutBufSize(hVd2);

    /*
     * Get the first buffer of the BufTab to determine buffer characteristics.
     * All buffers in a BufTab share the same characteristics.
     */
    hBuf = BufTab_getBuf(hBufTab, 0);

    /* Do we need to resize the BufTab? */
    if (numBufs > BufTab_getNumBufs(hBufTab) ||
        frameSize < Buffer_getSize(hBuf)) {

        /* Should we break the current buffers in to many smaller buffers? */
        if (frameSize < Buffer_getSize(hBuf)) {

            /* First undo any previous chunking done */
            BufTab_collapse(Vdec2_getBufTab(hVd2));

            /*
             * Chunk the larger buffers of the BufTab in to smaller buffers
             * to accomodate the codec requirements.
             */
            numExpBufs = BufTab_chunk(hBufTab, numBufs, frameSize);

            if (numExpBufs < 0) {
                ERR("Failed to chunk %d bufs size %ld to %d bufs size %ld\n",
                    BufTab_getNumBufs(hBufTab), Buffer_getSize(hBuf),
                    numBufs, frameSize);
                return FAILURE;
            }

            /*
             * Did the current BufTab fit the chunked buffers,
             * or do we need to expand the BufTab (numExpBufs > 0)?
             */
            if (BufTab_expand(hBufTab, numExpBufs) < 0) {
                ERR("Failed to expand BufTab with %d buffers\n",
                    numExpBufs);
                return FAILURE;
            }
        }
        else {
            /* Just expand the BufTab with more buffers */
            if (BufTab_expand(hBufTab, numCodecBuffers) < 0) {
                ERR("Failed to expand BufTab with %d buffers\n",
                    numCodecBuffers);
                return FAILURE;
            }
        }
    }

    return numBufs;
}

/******************************************************************************
 * videoThrFxn
 ******************************************************************************/
Void *videoThrFxn(Void *arg)
{
    VideoEnv               *envp            = (VideoEnv *) arg;
    Void                   *status          = THREAD_SUCCESS;
    VIDDEC2_Params          decParams       = Vdec2_Params_DEFAULT;
    VIDDEC2_DynamicParams   decDynParams    = Vdec2_DynamicParams_DEFAULT;
    VIDENC1_Params          encParams       = Venc1_Params_DEFAULT;
    BufferGfx_Attrs         gfxAttrs        = BufferGfx_Attrs_DEFAULT;
    Buffer_Attrs            bAttrs          = Buffer_Attrs_DEFAULT;
    Vdec2_Handle            hVd2            = NULL;
    Venc1_Handle            hVe1            = NULL;
    BufTab_Handle           hBufTab         = NULL;
    Engine_Handle           hEngine         = NULL;
    Buffer_Handle           hEncBuf         = NULL;
    Int                     ret             = Dmai_EOK;
    Int                     numBufs         = 0;
    Buffer_Handle           hVidBuf, hDispBuf, hDstBuf;
    Int32                   bufSize;
    Int                     fifoRet;
    Int                     bufIdx;

    /* Use extended dynamic parameters to allow tweaking of the QP value */
    IH264VENC_DynamicParams extDynParams = {
        Venc1_DynamicParams_DEFAULT,
        18,   /* QPISlice */
        20,   /* QPSlice */
        51,   /* RateCtrlQpMax */
        0,    /* RateCtrlQpMin */
        0,    /* NumRowsInSlice */
        0,    /* LfDisableIdc */
        0,    /* LFAlphaC0Offset */
        0,    /* LFBetaOffset */
        0,    /* ChromaQPOffset */
        0,    /* SecChromaQPOffset */
    };

    gfxAttrs.colorSpace = ColorSpace_YUV420PSEMI;
    gfxAttrs.dim.width = envp->imageWidth;
    gfxAttrs.dim.height = envp->imageHeight;
    gfxAttrs.dim.lineLength = BufferGfx_calcLineLength(gfxAttrs.dim.width,
                                                       gfxAttrs.colorSpace);

    if (envp->passThrough) {
        /*
         * Calculate buffer size needed of a video resolution for 420P.
         * This shouldn't be done if codecs are being used, since
         * the buffers  may require additional space due to padding.
         */
        bufSize = gfxAttrs.dim.lineLength * gfxAttrs.dim.height * 3 / 2;

        /* Only the display thread can own a buffer since no codecs are used */
        gfxAttrs.bAttrs.useMask = DISPLAY_FREE;
    }
    else {
        /* Open the codec engine */
        hEngine = Engine_open(envp->engineName, NULL, NULL);

        if (hEngine == NULL) {
            ERR("Failed to open codec engine %s\n", envp->engineName);
            cleanup(THREAD_FAILURE);
        }

        encParams.maxWidth = envp->imageWidth;
        encParams.maxHeight = envp->imageHeight;

        /* Set up codec parameters depending on bit rate */
        if (envp->videoBitRate < 0) {
            /* Variable bit rate */
            encParams.rateControlPreset = IVIDEO_NONE;

            /*
             * If variable bit rate use a bogus bit rate value (> 0)
             * since it will be ignored.
             */
            encParams.maxBitRate        = 2000000;
        }
        else {
            /* Constant bit rate */
            encParams.rateControlPreset = IVIDEO_LOW_DELAY;
            encParams.maxBitRate        = envp->videoBitRate;
        }

        extDynParams.videncDynamicParams.size = sizeof(IH264VENC_DynamicParams);
        extDynParams.videncDynamicParams.targetBitRate = encParams.maxBitRate;
        extDynParams.videncDynamicParams.inputWidth = encParams.maxWidth;
        extDynParams.videncDynamicParams.inputHeight = encParams.maxHeight;

        /* Create the video encoder */
/*---------------------------------------------modifiedd by lizhiqiang, 2010, 7, 22-----------------------*/
/*        hVe1 = Venc1_create(hEngine, "h264enc", &encParams,
                            (VIDENC1_DynamicParams *) &extDynParams);
*/

         hVe1 = Venc1_create(hEngine, "videnc1_copy", &encParams,
                            (VIDENC1_DynamicParams *) &extDynParams);

        if (hVe1 == NULL) {
        /*    ERR("Failed to create h264 video encoder\n");  */
            ERR("Failed to create  videnc1_copy encoder\n");
            cleanup(THREAD_FAILURE);
        }

        decParams.maxWidth   = encParams.maxWidth;
        decParams.maxHeight  = encParams.maxHeight;

        /* Create the video decoder */
/*--------------------------------------------modified by lizhiqiang, 2010, 7, 22-------------------------*/
/*        hVd2 = Vdec2_create(hEngine, "h264dec", &decParams, &decDynParams);
*/

        hVd2 = Vdec2_create(hEngine, "viddec2_copy", &decParams, &decDynParams);

        if (hVd2 == NULL) {
       /*     ERR("Failed to create h264 video decoder\n");  */
            ERR("Failed to create viddec2_copy decoder\n");
            cleanup(THREAD_FAILURE);
        }

        /* Which output buffer size does the codec require? */
        bufSize = Vdec2_getOutBufSize(hVd2);

        /* Allocate buffer for encoded data */
        hEncBuf = Buffer_create(Vdec2_getInBufSize(hVd2), &bAttrs);

        if (hEncBuf == NULL) {
            ERR("Failed to allocate buffer for encoded data\n");
            cleanup(THREAD_FAILURE);
        }

        /* A buffer can be owned by either the codec or the display thread */
        gfxAttrs.bAttrs.useMask = CODEC_FREE | DISPLAY_FREE;
    }

    /* Allocate video buffers */
    hBufTab = BufTab_create(NUM_VIDEO_BUFS, bufSize,
                            BufferGfx_getBufferAttrs(&gfxAttrs));

    if (hBufTab == NULL) {
        ERR("Failed to create BufTab for display pipe\n");
        cleanup(THREAD_FAILURE);
    }

    if (!envp->passThrough) {
        /* The codec is going to use this BufTab for output buffers */
        Vdec2_setBufTab(hVd2, hBufTab);
    }

    /* Prime the capture pipe with buffers */
    for (bufIdx = 0; bufIdx < NUM_VIDEO_BUFS; bufIdx++) {
        hDstBuf = BufTab_getFreeBuf(hBufTab);

        if (hDstBuf == NULL) {
            ERR("Failed to get free buffer from BufTab\n");
            BufTab_print(hBufTab);
            cleanup(THREAD_FAILURE);
        }

        if (Fifo_put(envp->hCaptureInFifo, hDstBuf) < 0) {
            ERR("Failed to send buffer to display thread\n");
            cleanup(THREAD_FAILURE);
        }
    }

    /* Make sure the display thread is stopped when it's unlocked */
    Pause_on(envp->hPausePrime);

    /* Signal that initialization is done and wait for other threads */
    Rendezvous_meet(envp->hRendezvousInit);

    /* Process one buffer to figure out buffer requirements */
    fifoRet = Fifo_get(envp->hCaptureOutFifo, &hVidBuf);

    if (fifoRet < 0) {
        ERR("Failed to get buffer from video thread\n");
        cleanup(THREAD_FAILURE);
    }

    /* Did the capture thread flush the fifo? */
    if (fifoRet == Dmai_EFLUSH) {
        cleanup(THREAD_SUCCESS);
    }

    if (!envp->passThrough) {
        /*
         * Encode and decode the buffer from the capture thread and
         * send any display buffers to the display thread.
         */
        ret = encodedecode(hVe1, hVd2, hVidBuf, hEncBuf, envp->hDisplayInFifo);

        if (ret < 0) {
            cleanup(THREAD_FAILURE);
        }

        /*
         * Resize the BufTab after the first frame has been processed.
         * This because the codec may not know it's buffer requirements
         * before the first frame has been decoded.
         */
        numBufs = resizeBufTab(hVd2, NUM_VIDEO_BUFS);

        /* Send any additional buffers to the capture thread */
        for (bufIdx = NUM_VIDEO_BUFS; bufIdx < numBufs; bufIdx++) {
            /* Get a free buffer from the BufTab */
            hDstBuf = BufTab_getFreeBuf(hBufTab);

            if (hDstBuf == NULL) {
                ERR("Failed to get free buffer from BufTab\n");
                BufTab_print(hBufTab);
                cleanup(THREAD_FAILURE);
            }

            if (Fifo_put(envp->hCaptureInFifo, hDstBuf) < 0) {
                ERR("Failed to send buffer to display thread\n");
                cleanup(THREAD_FAILURE);
            }
        }
    }
    else {
        /* Send the buffer through to the display thread unmodified */
        if (Fifo_put(envp->hDisplayInFifo, hVidBuf) < 0) {
            ERR("Failed to send buffer to display thread\n");
            cleanup(THREAD_FAILURE);
        }
    }

    /* Prime the display thread */
    for (bufIdx=0; bufIdx < numBufs - CAPTURE_PIPE_SIZE  - 1; bufIdx++) {
        if (ret != Dmai_EFIRSTFIELD) {
            /* Get a video buffer from the capture thread */
            fifoRet = Fifo_get(envp->hCaptureOutFifo, &hVidBuf);

            if (fifoRet < 0) {
                ERR("Failed to get buffer from video thread\n");
                cleanup(THREAD_FAILURE);
            }

            /* Did the capture thread flush the fifo? */
            if (fifoRet == Dmai_EFLUSH) {
                cleanup(THREAD_SUCCESS);
            }
        }

        if (!envp->passThrough) {
            /*
             * Encode and decode the buffer from the capture thread and
             * send any display buffers to the display thread.
             */
            ret = encodedecode(hVe1, hVd2, hVidBuf, hEncBuf,
                               envp->hDisplayInFifo);

            if (ret < 0) {
                cleanup(THREAD_FAILURE);
            }
        }
        else {
            /* Send the buffer through to the display thread unmodified */
            if (Fifo_put(envp->hDisplayInFifo, hVidBuf) < 0) {
                ERR("Failed to send buffer to display thread\n");
                cleanup(THREAD_FAILURE);
            }
        }
    }

    /* Release the display thread, it is now fully primed */
    Pause_off(envp->hPausePrime);

    /* Main loop */
    while (!gblGetQuit()) {
        /* Get a buffer from the capture thread */
        fifoRet = Fifo_get(envp->hCaptureOutFifo, &hVidBuf);

        if (fifoRet < 0) {
            ERR("Failed to get buffer from capture thread\n");
            cleanup(THREAD_FAILURE);
        }

        /* Did the capture thread flush the fifo? */
        if (fifoRet == Dmai_EFLUSH) {
            cleanup(THREAD_SUCCESS);
        }

        if (!envp->passThrough) {
            /*
             * Encode and decode the buffer from the capture thread and
             * send any display buffers to the display thread.
             */
            ret = encodedecode(hVe1, hVd2, hVidBuf, hEncBuf,
                               envp->hDisplayInFifo);

            if (ret < 0) {
                cleanup(THREAD_FAILURE);
            }
        }
        else {
            /* Send the buffer through to the display thread unmodified */
            if (Fifo_put(envp->hDisplayInFifo, hVidBuf) < 0) {
                ERR("Failed to send buffer to display thread\n");
                cleanup(THREAD_FAILURE);
            }
        }

        /* Get a buffer from the display thread to send to the capture thread */
        if (ret != Dmai_EFIRSTFIELD) {
            do {
                fifoRet = Fifo_get(envp->hDisplayOutFifo, &hDispBuf);

                if (fifoRet < 0) {
                    ERR("Failed to get buffer from video thread\n");
                    cleanup(THREAD_FAILURE);
                }

                /* Did the display thread flush the fifo? */
                if (fifoRet == Dmai_EFLUSH) {
                    cleanup(THREAD_SUCCESS);
                }

                /* The display thread is no longer using the buffer */
                Buffer_freeUseMask(BufTab_getBuf(hBufTab,
                                                 Buffer_getId(hDispBuf)),
                                   DISPLAY_FREE);

                /* Get a free buffer */
                hDstBuf = BufTab_getFreeBuf(hBufTab);

                if (hDstBuf == NULL) {
                    ERR("Failed to get free buffer from BufTab\n");
                    BufTab_print(hBufTab);
                    cleanup(THREAD_FAILURE);
                }

                /*
                 * Reset the dimensions of the buffer in case the decoder has
                 * changed them due to padding.
                 */
                BufferGfx_resetDimensions(hDstBuf);

                /* Send a buffer to the capture thread */
                if (Fifo_put(envp->hCaptureInFifo, hDstBuf) < 0) {
                    ERR("Failed to send buffer to capture thread\n");
                    cleanup(THREAD_FAILURE);
                }

            } while (Fifo_getNumEntries(envp->hDisplayOutFifo) > 0);
        }
    }

cleanup:
    /* Make sure the other threads aren't waiting for us */
    Rendezvous_force(envp->hRendezvousInit);
    Pause_off(envp->hPauseProcess);
    Pause_off(envp->hPausePrime);
    Fifo_flush(envp->hDisplayInFifo);

    /* Meet up with other threads before cleaning up */
    Rendezvous_meet(envp->hRendezvousCleanup);

    /* Clean up the thread before exiting */
    if (hEncBuf) {
        Buffer_delete(hEncBuf);
    }

    if (hVd2) {
        Vdec2_delete(hVd2);
    }

    if (hVe1) {
        Venc1_delete(hVe1);
    }

    if (hEngine) {
        Engine_close(hEngine);
    }

    if (hBufTab) {
        BufTab_delete(hBufTab);
    }

    return status;
}

video_copy.cfg

/* set up OSAL */
var osalGlobal = xdc.useModule('ti.sdo.ce.osal.Global');
osalGlobal.runtimeEnv = osalGlobal.DSPLINK_BIOS;
osalGlobal.traceBufferSize = 0x40000;

/* configure default memory seg id to BIOS-defined "DDR" */
osalGlobal.defaultMemSegId = "DDR2";

/* Enable DSP-side BIOS logging */
var LogServer = xdc.useModule('ti.sdo.ce.bioslog.LogServer');

/*
 *  ======== Server Configuration ========
 */
var Server = xdc.useModule('ti.sdo.ce.Server');
Server.threadAttrs.stackSize = 16384;
/*
 * The optional stack pad to add to non-configured stacks.  This is well
 * beyond most codec needs, but follows the approach of "start big and
 * safe, then optimize when things are working."
 */
Server.stackSizePad = 9000;

/* get various codec modules; i.e., implementation of codecs */
var H264ENC = xdc.useModule('ti.sdo.codecs.h264enc.ce.H264ENC');
var H264DEC = xdc.useModule('ti.sdo.codecs.h264dec.ce.H264DEC');
var HDVICP = xdc.useModule('ti.sdo.codecs.hdvicp.HDVICP');

/*-----------------------------------added by lizhiqiang, 2010, 7, 22 -------------------------------*/
var VIDDEC2_COPY =
    xdc.useModule('ti.sdo.ce.examples.codecs.viddec2_copy.VIDDEC2_COPY');
var VIDENC1_COPY =
    xdc.useModule('ti.sdo.ce.examples.codecs.videnc1_copy.VIDENC1_COPY');

H264DEC.alg.codeSection  = "DDR2";
H264ENC.alg.codeSection   = "DDR2";

/* Switching Off Out Bufs cache */
H264ENC.manageOutBufsCache = [ false, false, false, false, false, false, false, false, false, false, false, false, false, false, false, false ];
H264DEC.manageOutBufsCache = [ false, false, false, false, false, false, false, false, false, false, false, false, false, false, false, false ];

Server.algs = [   

    {name: "h264enc", mod: H264ENC,groupId:0,threadAttrs: {
                    stackMemId: 0, priority: Server.MINPRI + 1}
    },   
    {name: "h264dec", mod: H264DEC,groupId:1,threadAttrs: {
                stackMemId: 0, priority: Server.MINPRI + 1}
    },  
    {name: "viddec2_copy", mod: VIDDEC2_COPY, threadAttrs: {
        stackMemId: 0, priority: Server.MINPRI + 2}, groupId : 0,
    },
    {name: "videnc1_copy", mod: VIDENC1_COPY, threadAttrs: {
        stackMemId: 0, priority: Server.MINPRI + 2}, groupId : 0,
    }
 
];

/*
 *  ======== DSKT2 and RMAN Configuration ========
 *  XDAIS Algorithm Memory and DMA allocation
 */
    var DSKT2 = xdc.useModule('ti.sdo.fc.dskt2.DSKT2');
    DSKT2.DARAM0     = "IRAM";
    DSKT2.DARAM1     = "IRAM";
    DSKT2.DARAM2     = "IRAM";
    DSKT2.SARAM0     = "IRAM";
    DSKT2.SARAM1     = "IRAM";
    DSKT2.SARAM2     = "IRAM";
    DSKT2.ESDATA     = "DDRALGHEAP";
    DSKT2.IPROG      = "IRAM";
    DSKT2.EPROG      = "DDR2";
    DSKT2.DSKT2_HEAP = "DDR2";    /* to allocate internal DSKT2 object */
    DSKT2.trace = false;
    DSKT2.debug = false;
      
    DSKT2.DARAM_SCRATCH_SIZES = [ 32768, 32768, 0,0,0,0,0, /* ... */ 0 ];
    DSKT2.SARAM_SCRATCH_SIZES = [ 32768, 32768, 0,0,0,0,0, /* ... */ 0 ];

  
    var RMAN = xdc.useModule('ti.sdo.fc.rman.RMAN');
    RMAN.useDSKT2 = true;
    RMAN.tableSize = 10;
    RMAN.semCreateFxn = "Sem_create";
    RMAN.semDeleteFxn = "Sem_delete";
    RMAN.semPendFxn = "Sem_pend";
    RMAN.semPostFxn = "Sem_post";
    RMAN.debug = false;
    RMAN.trace = false;   
   
    var EDMA3 = xdc.useModule('ti.sdo.fc.edma3.Settings');   
    EDMA3.trace = false;
    EDMA3.debug = false;      
  
   
       
    //EDMA3.regionConfig = "DM6467_EDMA3_RM_INITCONFIG";
    /*
     *
     * Group:0, H264ENC gets 192 PaRAMs, 13 TCCs, 19 EDMA, and 2 QDMA channels
     */
   
     EDMA3.maxPaRams[0] = 192;
     EDMA3.maxTccs[0] = 21;
     EDMA3.maxEdmaChannels[0] = 21;
     EDMA3.maxQdmaChannels[0] = 0;
    
     /*
     * Group:1, H264DEC gets 192 PaRAMs, 13 TCCs, 19 EDMA, and 2 QDMA channels
     */

    EDMA3.maxPaRams[1] = 192;
    EDMA3.maxTccs[1] = 18;
    EDMA3.maxEdmaChannels[1] = 18;
    EDMA3.maxQdmaChannels[1] = 2;
   
   
    var EDMA3CHAN = xdc.useModule('ti.sdo.fc.ires.edma3chan.EDMA3CHAN');
    EDMA3CHAN.debug = false;
    EDMA3CHAN.trace = false;

    var HDVICP =  xdc.useModule('ti.sdo.fc.ires.hdvicp.HDVICP');
    HDVICP.debug = false;
    HDVICP.trace = false;

    var HDINTC = xdc.useModule('ti.sdo.fc.hdintc.HDINTC');
    HDINTC.interruptVectorId_0 = 10;
    HDINTC.interruptVectorId_1 = 11;
    HDINTC.hdvicpInterruptEventNo_0 = 29;
    HDINTC.hdvicpInterruptEventNo_1 = 39;

   

video_copy.cfg

 /*
 * Setup platform-specific memory map, CLK rate, etc.
 */
var mem_ext = [
    // will use for cmem: base: 0x87800000 (120MB offset), size: 0x04200000 (66MB)
{
    comment:    "DDRALGHEAP: off-chip memory for dynamic algmem allocation",
    name:       "DDRALGHEAP",
    base:       0x8BA00000,  
    len:        0x04000000,   // 66MB
    space:      "code/data"
},
{
    comment:    "DDR2: off-chip memory for code and data",
    name:       "DDR2",
    base:       0x8FA00000,   // 250MB offset
    len:        0x00400000,   // 4MB size
    space:      "code/data"
},
{
    comment:    "DSPLINK: off-chip memory for DSPLINK code and data",
    name:       "DSPLINKMEM",
    base:       0x8FE00000,   // 254MB
    len:        0x00100000,   //   1MB
    space:      "code/data"
},
{
    comment:    "RESET_VECTOR: off-chip memory for the reset vector table",
    name:       "RESET_VECTOR",
    base:       0x8FF00000,
    len:        0x00000080,
    space:      "code/data"
},
];

/* Specify the L2 memory setting */
var device_regs = {
    l1PMode: "32k",
    l1DMode: "32k",
    l2Mode: "32k"
};

var params = {
    clockRate: 594,
    catalogName: "ti.catalog.c6000",
    deviceName: "DM6467",
    regs: device_regs,
    mem: mem_ext
};

/*
 * Customize generic platform with parameters specified above.
 */
utils.loadPlatform("ti.platforms.generic", params);

/*  ===========================================================================
 *  Enable heaps and tasks
 *  ===========================================================================
 */
bios.enableMemoryHeaps(prog);
bios.enableTskManager(prog);

/*  ===========================================================================
 *  Create heaps in memory segments that are to have heap
 *  ===========================================================================
 */
bios.DDR2.createHeap = true;
bios.DDR2.heapSize   = 0x00040000; // 256K

bios.DDRALGHEAP.createHeap = true;
bios.DDRALGHEAP.heapSize   = bios.DDRALGHEAP.len;

/*  ===========================================================================
 *  GBL
 *  ===========================================================================
 */
prog.module("GBL").ENABLEALLTRC    = false;
prog.module("GBL").PROCID          = 0;

/*
bios.MEM.instance("IRAM").base = 0x11818000;
bios.MEM.instance("IRAM").len = 0x18000;
bios.MEM.instance("CACHE_L2").base = 0x11818000+0x18000;
bios.MEM.instance("CACHE_L2").len = 0x8000;
*/

prog.module("GBL").C64PLUSCONFIGURE   = true ;
prog.module("GBL").C64PLUSMAR128to159 = 0x0000ffff;

/*  ===========================================================================
 *  HWI
 *  ===========================================================================
 */
bios.HWI_INT4.interruptSelectNumber = 16
bios.HWI_INT5.interruptSelectNumber = 17

/*  ===========================================================================
 *  MEM
 *  ===========================================================================
 */
prog.module("MEM").STACKSIZE = 0x1000 ;
prog.module("TSK").STACKSIZE = 0x1000 ;

/*  ===========================================================================
 *  Global Settings
 *  ===========================================================================
 */
prog.module("MEM").ARGSSIZE = 200;

/*  ===========================================================================
 *  Enable MSGQ and POOL Managers
 *  ===========================================================================
 */
bios.MSGQ.ENABLEMSGQ = true;
bios.POOL.ENABLEPOOL = true;

/*  ===========================================================================
 *  Set all code and data sections to use DDR
 *  ===========================================================================
 */
bios.setMemCodeSections (prog, bios.DDR2) ;
bios.setMemDataNoHeapSections (prog, bios.DDR2) ;
bios.setMemDataHeapSections (prog, bios.DDRALGHEAP) ;

/*  ===========================================================================
 *  MEM : Global
 *  ===========================================================================
 */
prog.module("MEM").BIOSOBJSEG = bios.DDRALGHEAP;
prog.module("MEM").MALLOCSEG  = bios.DDRALGHEAP;

/*  ===========================================================================
 *  TSK : Global
 *  ===========================================================================
 */
prog.module("TSK").STACKSEG = bios.DDRALGHEAP ;

bios.TSK.instance("TSK_idle").stackSize = 0x1000;

//Fix for clock
prog.module("CLK").SPECIFYRATE = true;
prog.module("CLK").INPUTCLK = 148.5;

/*  ===========================================================================
 *  Generate configuration files...
 *  ===========================================================================
 */
if (config.hasReportedError == false) {

bios.MEM.instance("IRAM").createHeap = 1;
bios.MEM.instance("IRAM").heapSize = 0x18000;
bios.MEM.instance("IRAM").enableHeapLabel = 1;
bios.MEM.instance("IRAM").heapLabel = prog.extern("IRAM_HEAP", "asm");
// !GRAPHICAL_CONFIG_TOOL_SCRIPT_INSERT_POINT!

    prog.gen();
}

 

 

 

when I enter "CE_DEBUG=0 ./encodedecode",  part of the information are as follows,

 

 

ce/) [1,0,0,1220943366422]
@0,258,360us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/xdm/) [1,0,1,1220951322616]
@0,258,594us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dman3/) [1,0,3,1220943053023]
@0,258,823us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/acpy3/) [1,0,2,1220943014135]
@0,259,048us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package dsplink.gpp (/opt/dvsdk_1_40_02_33/dsplink-davinci-v1.50-prebuilt/packages/dsplink/gpp/) [3,0,0]@0,259,261us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.linuxutils.cmem (/opt/dvsdk_1_40_02_33/cmem_2_10/packages/ti/sdo/linuxutils/cmem/) [2,0,1,1204929560755]
@0,259,514us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.catalog.c470 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/catalog/c470/) [1,0,1,0,1203561761475]
@0,259,730us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.catalog.c6000 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/catalog/c6000/) [1,0,0,0,1203561781695]
@0,259,947us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.platforms.evmDM6467 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/platforms/evmDM6467/) [1,0,0,0,1203562062227]
@0,260,231us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.osal (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/) [2,0,2,1220951127739]
@0,260,462us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/) [2,0,1,1220951085787]
@0,260,681us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.osal.linux (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/linux/)
 [2,0,1,1220951140072]
@0,260,908us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.ipc.dsplink (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/dsplink/) [2,0,1,1220951096818]
@0,261,135us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.alg (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/alg/) [1,0,1,1220950781938]
@0,261,351us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/) [1,0,6,1220950771473]@0,261,561us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.video1 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video1/) [1,0,2,1220951340734]
@0,594,981us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.codecs.h264enc.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1221669049000]
@0,595,264us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.video2 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video2/) [1,0,2,1220951347240]
@0,595,499us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.codecs.h264dec.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264dec/ce/) [1,0,0,1221669049000]
@0,595,739us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.examples.codecs.viddec2_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/viddec2_copy/) []
@0,595,977us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.examples.codecs.videnc1_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/videnc1_copy/) []
@0,596,216us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.speech (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/speech/) [1,0,2,1220951161404]
@0,596,436us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.speech1 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/speech1/) [1,0,1,1220951167662]
@0,596,657us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.audio (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/audio/) [1,0,2,1220950788137]
@0,596,875us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.video (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video/) [1,0,3,1220951334122]
@0,597,093us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.dmai (/opt/dvsdk_1_40_02_33/dmai_1_10_00_06/packages/ti/sdo/dmai/) [1,0,0,1372398243000]
@0,597,304us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.simplewidget (/opt/dvsdk_1_40_02_33/dvsdk_demos_1_40_00_18/packages/ti/sdo/simplewidget/)
 []
@0,597,516us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/bioslog/) [1,0,1,1220950800329]
@0,597,769us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.utils.trace (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/trace/) [1,0,1,1220951317087]
@0,598,003us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package encodedecode_config (/opt/dvsdk_1_40_02_33/dvsdk_demos_1_40_00_18/dm6467/encodedecode/encodedecode_config/) []
@0,598,332us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2d1bc)
@0,598,541us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2c654)
@0,598,835us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@0,599,028us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x590f0)
@0,599,434us: [+0 T:0x40018528 S:0xbefffb04] OG - Global_atexit> enter (fxn=0x2af3c)
@0,599,714us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@0,599,912us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x59140)
@0,600,157us: [+0 T:0x40018528 S:0xbefffb04] OG - Global_atexit> enter (fxn=0x28b88)
@0,600,444us: [+0 T:0x40018528 S:0xbefffb0c] OG - Global_atexit> enter (fxn=0x2bcd8)
@0,600,735us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,600,923us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> Enter(0x14)
@0,601,097us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> return (0x591c0)
@0,601,294us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x591c0]
@0,601,480us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,601,642us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> Enter(0x14)
@0,601,807us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> return (0x591d8)
@0,601,973us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x591d8]
@0,936,144us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> Enter(0x18)
@0,936,345us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> return (0x591f0)
@0,936,526us: [+0 T:0x40018528 S:0xbefffadc] OT - Thread_create> Enter (fxn=0x27cc8, attrs=0x0)
@0,936,707us: [+0 T:0x40018528 S:0xbefffac4] OM - Memory_alloc> Enter(0x64)
@0,936,875us: [+0 T:0x40018528 S:0xbefffac4] OM - Memory_alloc> return (0x59210)
@0,937,568us: [+0 T:0x40018528 S:0xbefffadc] OT - Thread_create> Exit (task=0x59210)
@0,937,791us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x27888)
@0,937,997us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2997c)
@0,938,287us: [+0 T:0x40018528 S:0xbefffafc] ti.sdo.ce.alg - ALG_init> Enter
@0,938,470us: [+0 T:0x40018528 S:0xbefffaec] OG - Global_atexit> enter (fxn=0x26dd0)
@0,938,651us: [+0 T:0x40018528 S:0xbefffb1c] ti.sdo.ce.alg - ALG_init> Exit
@0,938,810us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x26870)
@0,939,034us: [+0 T:0x40018528 S:0xbefffaec] OM - Memory_alloc> Enter(0x18)
@0,939,217us: [+0 T:0x40018528 S:0xbefffaec] OM - Memory_alloc> return (0x593a8)
@0,939,393us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2be3c)
@0,943,960us: [+1 T:0x40acab60 S:0x40aca52c] OP - daemon> thread created.
@0,944,232us: [+0 T:0x40acab60 S:0x40aca52c] OP - getCmd_d> Enter (proc=0x40aca5a4)
@0,944,419us: [+0 T:0x40acab60 S:0x40aca50c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x591c0] timeout[0xffffffff]
@0,944,852us: [+6 T:0x40018528 S:0xbefffb14] CE - Engine_init> CE debugging on (CE_DEBUG=0; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@0,945,101us: [+0 T:0x40018528 S:0xbefffb04] OG - Global_atexit> enter (fxn=0x23bf4)
@0,945,286us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@0,945,466us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x593e8)
@0,945,638us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@0,945,809us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x59408)
@0,945,977us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@0,946,147us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x59428)
@0,946,380us: [+0 T:0x40018528 S:0xbefffb14] CS - Server_init()
@0,946,544us: [+0 T:0x40018528 S:0xbefffb14] CS - Server_init> Global_useLinkArbiter = 0
@0,946,718us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x22744)
@0,946,986us: [+0 T:0x40018528 S:0xbefffb24] OG - Global_atexit> enter (fxn=0x11b84)
Encodedecode demo started.
TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil)
@0,956,400us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> Enter(0x7800)
@0,956,625us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> Enter(size=30720, align=-1, cached=FALSE, heap=FALSE)
@0,956,986us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_alloc(30720) = 0x40ad3000.
@0,957,233us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_getPhys(0x40ad3000) = 0x8804e000.
@0,957,437us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> Enter(virtAddr=0x40ad3000, size=30720, physAddr=0x8804e000)
@0,957,651us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> creating new contigBuf object
@0,957,827us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> Enter(0x10)
@0,957,999us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> return (0x617b0)
@0,958,171us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> returning: cb->phys=0x8804e000, cb->size=30720, cb->virt=0x40ad3000
@0,958,385us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> return (0x40ad3000)
@0,958,590us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> return (0x40ad3000)
@0,958,761us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40ad3000, size=4)
@0,958,959us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40ad3000, size=4)
@1,294,140us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40ad3000, Ec=0x40ada800, Ss=0x40ad3000, Es=0x40ad3004, PSc=0x8804e000)
@1,294,428us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> returning physAddr=0x8804e000
@1,294,621us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> return (0x8804e000)
@1,294,809us: [+2 T:0x40018528 S:0xbefffa6c] ti.sdo.dmai - [Buffer] Alloc Buffer of size 30720 at 0x40ad3000 (0x8804e000 phys)
@1,546,541us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> Enter(0x7800)
@1,546,784us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> Enter(size=30720, align=-1, cached=FALSE, heap=FALSE)
@1,547,136us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_alloc(30720) = 0x40ae2000.
@1,547,385us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_getPhys(0x40ae2000) = 0x8803f000.
@1,547,588us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> Enter(virtAddr=0x40ae2000, size=30720, physAddr=0x8803f000)
@1,547,804us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> creating new contigBuf object
@1,547,979us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> Enter(0x10)
@1,548,151us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> return (0x61838)
@1,548,323us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> returning: cb->phys=0x8803f000, cb->size=30720, cb->virt=0x40ae2000
@1,548,537us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> return (0x40ae2000)
@1,548,706us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> return (0x40ae2000)
@1,548,873us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40ae2000, size=4)
@1,549,067us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40ae2000, size=4)
@1,549,262us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40ae2000, Ec=0x40ae9800, Ss=0x40ae2000, Es=0x40ae2004, PSc=0x8803f000)
@1,549,498us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> returning physAddr=0x8803f000
@1,549,680us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> return (0x8803f000)
@1,549,890us: [+2 T:0x40018528 S:0xbefffa6c] ti.sdo.dmai - [Buffer] Alloc Buffer of size 30720 at 0x40ae2000 (0x8803f000 phys)
VPIF_OPEN: LINE: 2430.
@1,953,357us: [+0 T:0x422f0b60 S:0x422f0404] CE - Engine_open> Enter('encodedecode', 0x0, 0x422f044c)
@1,953,681us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> Enter(0x2c)
@1,953,890us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> return (0x61e90)
@1,954,115us: [+0 T:0x422f0b60 S:0x422f0404] CE - rserverOpen('video_copy.x64P'), count = 0
@1,954,310us: [+0 T:0x422f0b60 S:0x422f03cc] OP - Processor_create> Enter(imageName='video_copy.x64P', linkCfg='(null)', attrs=0x422f0450)
@1,954,874us: [+0 T:0x40018528 S:0xbefffa74] CE - Engine_open> Enter('encodedecode', 0x0, 0xbefffabc)
@1,955,114us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> Enter(0x2c)
@1,955,618us: [+0 T:0x422f0b60 S:0x422f03b4] OM - Memory_alloc> Enter(0x24)
@1,955,840us: [+0 T:0x422f0b60 S:0x422f03b4] OM - Memory_alloc> return (0x61ec0)
@1,956,031us: [+0 T:0x422f0b60 S:0x422f03ac] OP - doCmd> Enter (cmdId=1, proc=0x61ec0)
@1,956,223us: [+0 T:0x422f0b60 S:0x422f039c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x591c0]
@1,956,467us: [+0 T:0x422f0b60 S:0x422f03ac] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x591c0]
@1,956,674us: [+0 T:0x422f0b60 S:0x422f038c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x591d8] timeout[0xffffffff]
@1,956,963us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> return (0x61ee8)
@1,957,579us: [+0 T:0x40acab60 S:0x40aca50c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x591c0] status[0]
@1,958,559us: [+0 T:0x40acab60 S:0x40aca52c] OP - getCmd_d> Exit (result=1)
@1,959,249us: [+0 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Enter(proc=0x61ec0)
@2,410,809us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Initializing DSP PROC...
@2,411,819us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'video_copy.x64P']
@2,412,533us: [+0 T:0x40acab60 S:0x40aca514] OM - Memory_alloc> Enter(0xe0)
in Display_v412_create, FILE: linux/Display_v4l2.c, LINE: 148.
@3,473,813us: [+2 T:0x412f0b60 S:0x412f03fc] ti.sdo.dmai - [Display] Video output set to size 720x480 pitch 720
in Display_v412_create, FILE: linux/Display_v4l2.c, LINE: 163.
@3,474,540us: [+2 T:0x412f0b60 S:0x412f024c] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers
@3,796,374us: [+2 T:0x412f0b60 S:0x412f029c] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x422f1000 has physical address 0x83400000
@4,109,915us: [+2 T:0x412f0b60 S:0x412f029c] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x426e6000 has physical address 0x83800000
@4,423,510us: [+2 T:0x412f0b60 S:0x412f029c] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x42adb000 has physical address 0x83c00000
@5,446,448us: [+0 T:0x40acab60 S:0x40aca514] OM - Memory_alloc> return (0x61f18)
@5,446,724us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fa00000, sizeInBytes=0x400000, shared=1
@5,447,041us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000,
 sizeInBytes=0x100000, shared=1
@5,447,318us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x8ff00000, sizeInBytes=0x80, shared=0
@5,447,584us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x8ba00000,
 sizeInBytes=0x4000000, shared=0
@5,447,850us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> DOPOWERCONTROL was=0; now=0
@6,466,269us: [+2 T:0x41af0b60 S:0x41af0254] ti.sdo.dmai - [Capture] Capture input set to COMPOSITE
@6,466,663us: [+2 T:0x41af0b60 S:0x41af02f4] ti.sdo.dmai - [Capture] Video input connected size 720x480 pitch 720
@6,467,010us: [+2 T:0x41af0b60 S:0x41af0144] ti.sdo.dmai - [BufTab] Allocating BufTab for 4 buffers
@6,795,994us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x42ed0000 has physical address 0x80800000
@7,109,817us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x432c5000 has physical address 0x80c00000
@7,423,690us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x436ba000 has physical address 0x84000000
@7,737,498us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 3 mapped to 0x43aaf000 has physical address 0x84400000
-----------FILE: capture.c, LINE: 55...............
-----------FILE: capture.c, LINE: 61...............
-----------FILE: capture.c, LINE: 71...............
-----------FILE: (null), LINE: 52...............
@7,759,722us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Attaching to DSP PROC...
@7,769,219us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Opening MSGQ pool...
@7,769,866us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Loading video_copy.x64P on DSP (1 args)...
@8,180,280us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Starting DSP PROC...
@8,235,350us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Opening remote transport...
@8,236,003us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> return (1)
@8,236,237us: [+0 T:0x40acab60 S:0x40aca51c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x591d8]
@8,236,484us: [+0 T:0x422f0b60 S:0x422f038c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x591d8] status[0]
@8,236,708us: [+0 T:0x422f0b60 S:0x422f03ac] OP - doCmd> Exit (result=1)
@8,236,885us: [+0 T:0x422f0b60 S:0x422f03cc] OP - Processor_create> return (0x61ec0)
@8,237,068us: [+0 T:0x422f0b60 S:0x422f0404] CE - rserverOpen('video_copy.x64P'): 0x57be0 done.
@8,237,297us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> Enter(0x20)
@8,237,496us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> return (0x623d0)
@8,237,703us: [+0 T:0x422f0b60 S:0x422f03dc] OC - Comm_create> Enter(queueName='encodedecode_0', queue=0x61ea0, attrs=0x0)
@8,237,916us: [+0 T:0x422f0b60 S:0x422f03c4] OM - Memory_alloc> Enter(0x4)
@8,238,097us: [+0 T:0x422f0b60 S:0x422f03c4] OM - Memory_alloc> return (0x623f8)
@8,238,593us: [+0 T:0x422f0b60 S:0x422f03dc] OC - Comm_create> return (0x623f8)
@8,238,857us: [+0 T:0x422f0b60 S:0x422f03dc] OM - Memory_free> Enter(0x623d0, 0x20)
@8,239,058us: [+0 T:0x422f0b60 S:0x422f03dc] OM - Memory_free> return (0x1)
@8,239,240us: [+0 T:0x422f0b60 S:0x422f03e4] OC - Comm_alloc> Enter(poolId=0x0, msg=0x61eac, size=576)
@8,239,475us: [+0 T:0x422f0b60 S:0x422f03e4] OC - Comm_alloc> msg=0x446b2880, returning (0)
@8,239,674us: [+0 T:0x422f0b60 S:0x422f03c4] OC - Comm_locate> Enter(queueName='rmsq', queue=0x61e9c)
@8,245,966us: [+0 T:0x422f0b60 S:0x422f03c4] OC - Comm_locate> return (0)
@8,246,198us: [+0 T:0x422f0b60 S:0x422f0404] CE - checkServer(0x61e90)
@8,246,407us: [+0 T:0x422f0b60 S:0x422f03d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,246,663us: [+0 T:0x422f0b60 S:0x422f03d4] OC - Comm_put> return (0)
@8,246,923us: [+0 T:0x422f0b60 S:0x422f03cc] OC - Comm_get> Enter(queue=0x10000, msg=0x422f0448, timeout=-1)
@8,247,191us: [+0 T:0x422f0b60 S:0x422f03cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@8,247,409us: [+0 T:0x422f0b60 S:0x422f0404] CE - rmsInit> RMS initialized(0x61e90); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3
@8,247,662us: [+0 T:0x422f0b60 S:0x422f03d4] CE - Engine_setTrace> Enter(engine=0x61e90, mask='*+01234567,GT_prefix=12345,GT_time=3')
@8,247,901us: [+1 T:0x422f0b60 S:0x422f03d4] CE - Engine_setTrace> Requesting DSP set trace ...
@8,248,089us: [+0 T:0x422f0b60 S:0x422f03a4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,248,327us: [+0 T:0x422f0b60 S:0x422f03a4] OC - Comm_put> return (0)
@8,248,515us: [+0 T:0x422f0b60 S:0x422f039c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f040c, timeout=-1)
@8,248,775us: [+0 T:0x40018528 S:0xbefffa74] CE - rserverOpen('video_copy.x64P'), count = 1
@8,248,974us: [+0 T:0x40018528 S:0xbefffa74] CE - rserverOpen('video_copy.x64P'): 0x57be0 done.
@8,249,178us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> Enter(0x20)
@8,249,359us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> return (0x623d0)
@8,249,550us: [+0 T:0x40018528 S:0xbefffa4c] OC - Comm_create> Enter(queueName='encodedecode_1', queue=0x61ef8, attrs=0x0)
@8,249,755us: [+0 T:0x40018528 S:0xbefffa34] OM - Memory_alloc> Enter(0x4)
@8,249,948us: [+0 T:0x40018528 S:0xbefffa34] OM - Memory_alloc> return (0x62408)
@8,250,654us: [+0 T:0x422f0b60 S:0x422f039c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@8,250,905us: [+0 T:0x422f0b60 S:0x422f03d4] CE - Engine_setTrace> return(0)
@8,251,124us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,251,376us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> return (0)
@8,251,630us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f03f0, timeout=-1)
@8,251,877us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @0,030,302tk: [+0 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3')
[DSP] @0,030,414tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,030,495tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.targets.rts6000 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/targets/rts6000/) [1,0,0,0,1203621186754]
[DSP] @0,030,598tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264enc (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264enc/) [1,0,0,1221669049000]
[DSP] @0,030,717tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264dec (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264dec/) [1,0,0,1221669049000]
[DSP] @0,030,828tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.hdvicp (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/hdvicp/) [1,0,0,1221669049000]
[DSP] @0,030,938tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais.dm.examples.viddec2_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/xdais/dm/examples/viddec2_copy/) [2,0,0,1372385245000]
[DSP] @0,031,058tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais.dm.examples.videnc1_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/xdais/dm/examples/videnc1_copy/) [2,0,0,1372399186000]
[DSP] @0,031,178tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.ires.hdvicp (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/hdvicp/) [1,0,0,1220943209717]
[DSP] @0,031,291tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.hdintc (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/hdintc/) [1,0,3,1220943133917]
[DSP] @0,031,399tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.edma3.rm (/opt/dvsdk_1_40_02_33/edma3_lld_1_04_00/packages/ti/sdo/edma3/rm/) [1,3,2,1201524583021]
[DSP] @0,031,501tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.ires.nullresource (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/nullresource/) [1,0,0,1220943221523]
[DSP] @0,031,619tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais.dm (/opt/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/dm/) [1,0,4,1210262746529]
[DSP] @0,031,715tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais (/opt/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/) [1,2,1,1210262742149]
[DSP] @0,031,807tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.node (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/node/) [1,0,0,1220951122176]
[DSP] @0,031,909tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1220951102696]
[DSP] @0,032,022tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.utils.trace (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/utils/trace/) [1,0,0,1220943366422]
[DSP] @0,032,131tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/xdm/) [1,0,1,1220951322616]
[DSP] @0,032,239tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dman3/) [1,0,3,1220943053023]
[DSP] @0,032,346tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/acpy3/) [1,0,2,1220943014135]
[DSP] @0,032,453tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package dsplink.dsp (/opt/dvsdk_1_40_02_33/dsplink-davinci-v1.50-prebuilt/packages/dsplink/dsp/) [1,3,0]
[DSP] @0,032,550tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.rtdx (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/rtdx/) [2,0,0,1,1194024051755]
[DSP] @0,032,643tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.psl (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/psl/) [5,0,0,0,0]
[DSP] @0,032,728tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti@8,253,049us: [+0 T:0x40018528 S:0xbefffa4c] OC - Comm_create> return (0x62408)
@8,931,721us: [+0 T:0x40018528 S:0xbefffa4c] OM - Memory_free> Enter(0x623d0, 0x20)
@8,931,941us: [+0 T:0x40018528 S:0xbefffa4c] OM - Memory_free> return (0x1)
@8,932,117us: [+0 T:0x40018528 S:0xbefffa54] OC - Comm_alloc> Enter(poolId=0x0, msg=0x61f04, size=576)
@8,932,348us: [+0 T:0x40018528 S:0xbefffa54] OC - Comm_alloc> msg=0x446b3880, returning (0)
@8,932,535us: [+0 T:0x40018528 S:0xbefffa34] OC - Comm_locate> Enter(queueName='rmsq', queue=0x61ef4)
@8,938,894us: [+0 T:0x40018528 S:0xbefffa34] OC - Comm_locate> return (0)
@8,939,114us: [+0 T:0x40018528 S:0xbefffa74] CE - checkServer(0x61ee8)
@8,939,313us: [+0 T:0x40018528 S:0xbefffa44] OC - Comm_put> Enter(queue=0x0, msg=0x446b3880)
@8,939,562us: [+0 T:0x40018528 S:0xbefffa44] OC - Comm_put> return (0)
@8,939,808us: [+0 T:0x40018528 S:0xbefffa3c] OC - Comm_get> Enter(queue=0x10001, msg=0xbefffab8, timeout=-1)
@8,940,140us: [+0 T:0x40018528 S:0xbefffa3c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@8,940,395us: [+0 T:0x40acab60 S:0x40aca52c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x591d8]
@8,940,632us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,940,902us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> return (0)
@8,941,163us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f03f0, timeout=-1)
@8,941,408us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
.bios (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/bios/) [5,2,4,9,1193960176642]
[DSP] @0,032,821tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.dskt2 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dskt2/) [1,0,4,1220943095081]
[DSP] @0,032,927tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.rman (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/rman/) [2,0,0,1220943245318]
[DSP] @0,033,037tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.edma3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/edma3/) [2,0,0,1220943121256]
[DSP] @0,033,144tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.ires.edma3chan (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/edma3chan/) [1,0,0,1220943162542]
[DSP] @0,033,259tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.bios.utils (/opt/dvsdk_1_40_02_33/biosutils_1_01_00/packages/ti/bios/utils/) [2,0,1,0,1191891830609]
[DSP] @0,033,360tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.catalog.c6000 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/catalog/c6000/) [1,0,0,0,1203561781695]
[DSP] @0,033,460tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.platforms.evmDM6467 (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/platforms/evmDM6467/) [1,0,0,0,1192229633217]
[DSP] @0,033,567tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.osal (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/) [2,0,2,1220951127739]
[DSP] @0,033,669tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/) [2,0,1,1220951085787]
[DSP] @0,033,771tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.alg (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/alg/) [1,0,1,1220950781938]
[DSP] @0,033,872tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.osal.bios (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/bios/) [2,0,1,1220951133740]
[DSP] @0,033,979tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.ipc.bios (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1220951091097]
[DSP] @0,034,085tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/) [1,0,6,1220950771473]
[DSP] @0,034,181tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/bioslog/)
 [1,0,1,1220950800329]
[DSP] @0,034,286tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.video1 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video1/) [1,0,2,1220951340734]
[DSP] @0,034,390tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264enc.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1221669049000]
[DSP] @0,034,504tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.video2 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video2/) [1,0,2,1220951347240]
[DSP] @0,034,607tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264dec.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264dec/ce/) [1,0,0,1221669049000]
[DSP] @0,034,721tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.examples.codecs.viddec2_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/viddec2_copy/) []
[DSP] @0,034,837tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.examples.codecs.videnc1_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/videnc1_copy/) []
[DSP] @0,034,953tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package video_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/servers/video_copy/evmDM6467/video_copy/) []
[DSP] @0,035,065tk: [+0 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> return
[DSP] @0,037,335tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,037,411tk: [+0 T:0@8,946,463us: [+0 T:0x40acab60 S:0x40aca52c] OP - getCmd_d> Enter (proc=0x40aca5a4)
@9,321,756us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@9,322,061us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> return (0)
@9,322,333us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f03f0, timeout=-1)
@9,322,578us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @1,634,131tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 6
[DSP] @1,637,239tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @1,637,307tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @2,521,641tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @2,521,714tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@9,323,879us: [+0 T:0x422f0b60 S:0x422f0394] CE - Engine_fwriteTrace> returning count [8916]
@9,324,099us: [+0 T:0x422f0b60 S:0x422f0404] CE - Engine_open> return(401040)
@9,324,385us: [+2 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] Creating encoder videnc1_copy for max 720x480 bitrate 2000000 ratectrl 4
@9,324,736us: [+0 T:0x422f0b60 S:0x422f036c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x61e90, name='videnc1_copy', params=0x422f0568)
@9,325,016us: [+0 T:0x422f0b60 S:0x422f033c] CV - VISA_create(0x61e90, 'videnc1_copy', 0x422f0568, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
@9,325,259us: [+0 T:0x422f0b60 S:0x422f0264] CV - VISA_create2(0x61e90, 'videnc1_copy', 0x422f0568, 0x30, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
@9,325,516us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> Enter(0x30)
@9,325,707us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> return (0x62550)
@9,325,890us: [+0 T:0x422f0b60 S:0x422f01f4] CE - Engine_createNode(0x61e90, 'videnc1_copy', 2496, 0x422f0568, 0x30, 0x422f0368)
@9,326,116us: [+0 T:0x422f0b60 S:0x422f01dc] OM - Memory_alloc> Enter(0x20)
@9,326,294us: [+0 T:0x422f0b60 S:0x422f01dc] OM - Memory_alloc> return (0x623d0)
@9,326,491us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_create> Enter(queueName='gppfromnode_2', queue=0x623d8, attrs=0x0)
@9,326,707us: [+0 T:0x422f0b60 S:0x422f01b4] OM - Memory_alloc> Enter(0x4)
@9,326,889us: [+0 T:0x422f0b60 S:0x422f01b4] OM - Memory_alloc> return (0x62588)
@9,327,418us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_create> return (0x62588)
@9,327,679us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@9,663,864us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> return (0)
@9,664,082us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> Enter(queue=0x10000, msg=0x422f024c, timeout=-1)
@9,664,350us: [+0 T:0x40018528 S:0xbefff9d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b3880)
@9,664,628us: [+0 T:0x40018528 S:0xbefff9d4] OC - Comm_put> return (0)
@9,665,038us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@9,665,281us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@9,665,535us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> return (0)
@9,665,792us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> Enter(queue=0x10000, msg=0x422f024c, timeout=-1)
@9,666,031us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@9,666,239us: [+4 T:0x422f0b60 S:0x422f01f4] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10002, msgq=0x62588, algName='videnc1_copy', rmsNode=0x8fa70678, algHandle=0x8fa70760)
@9,666,586us: [+0 T:0x40018528 S:0xbefff9cc] OC - Comm_get> Enter(queue=0x10001, msg=0xbefffa60, timeout=-1)
@9,666,830us: [+0 T:0x40018528 S:0xbefff9cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @3,314,722tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 0
[DSP] @3,314,798tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0x18)
[DSP] @3,314,863tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fa70678)
[DSP] @3,314,927tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0xf)
[DSP] @3,314,987tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fa70690)
[DSP] @3,315,054tk: [+0 T:0x8ba0006c S:0x8ba03edc] OM - Memory_alloc> Enter(size=0x20)
[DSP] @3,315,114tk: [+0 T:0x8ba0006c S:0x8ba03edc] OM - Memory_alloc> return (0x8fa706a0)
[DSP] @3,315,177tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_alloc> Enter(size=0x24)
[DSP] @3,315,237tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_alloc> return (0x8fa706c0)
[DSP] @3,315,327tk: [+0 T:0x8ba0006c S:0x8ba03ec4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x0, name='videnc1_copy', params=0x8fe038c0)
[DSP] @3,315,431tk: [+0 T:0x8ba0006c S:0x8ba03e8c] CV - VISA_create(0x0, 'videnc1_copy', 0x8fe038c0, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
[DSP] @3,315,525tk: [+0 T:0x8ba0006c S:0x8ba03d7c] CV - VISA_create2(0x0, 'videnc1_copy', 0x8fe038c0, 0x30, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
[DSP] @3,315,628tk: [+0 T:0x8ba0006c S:0x8ba03d14] CE - Engine_open> Enter('local', 0x8ba03d6c, 0x9c0)
[DSP] @3,315,698tk: [+0 T:0x8ba0006c S:0x8ba03cf4] OM - Memory_alloc> Enter(size=0x2c)
[DSP] @3,315,758tk: [+0 T:0x8ba0006c S:0x8ba03cf4] OM - Memory_alloc> return (0x8fa70730)
[DSP] @3,315,828tk: [+0 T:0x8ba0006c S:0x8ba03d14] CE - Engine_open> return(-1884879056)
[DSP] @3,315,904tk: [+0 T:0x8ba0006c S:0x8ba03d5c] OM - Memory_alloc> Enter(size=0x30)
[DSP] @3,315,965tk: [+0 T:0x8ba0006c S:0x8ba03d5c] OM - Memory_alloc> return (0x8fa70760)
[DSP] @3,316,030tk: [+0 T:0x8ba0006c S:0x8ba03d34] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fa6fdb0, idma3Fxns=0x0, params=0x8fe038c0, attrs=0x8ba03e80)
[DSP] @3,316,136tk: [+0 T:0x8ba0006c S:0x8ba03d14] OM - Memory_alloc> Enter(size=0x10)
[DSP] @3,316,196tk: [+0 T:0x8ba0006c S:0x8ba03d14] OM - Memory_alloc> return (0x8fa70790)
[DSP] @3,316,347tk: [+0 T:0x8ba0006c S:0x8ba03d34] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8fa70790)
[DSP] @3,316,432tk: [+0 T:0x8ba0006c S:0x8ba03ec4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x8fa70760)
[DSP] @3,316,572tk: [+4 T:0x8ba0006c S:0x8ba03e84] OT - Thread_create > name: "videnc1_copy#0", pri:  -1, stack size:  11096, stack seg: 0
[DSP] @3,316,806tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 5
[DSP] @3,316,879tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@9,695,413us: [+0 T:0x40acab60 S:0x40aca50c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x591c0] timeout[0xffffffff]
@10,009,190us: [+0 T:0x40018528 S:0xbefffa04] CE - Engine_fwriteTrace> returning count [2698]
@10,009,445us: [+0 T:0x422f0b60 S:0x422f0154] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@10,009,712us: [+0 T:0x422f0b60 S:0x422f0154] OC - Comm_put> return (0)
@10,009,975us: [+0 T:0x422f0b60 S:0x422f014c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f01e0, timeout=-1)
@10,010,295us: [+0 T:0x422f0b60 S:0x422f014c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @3,318,643tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 1
[DSP] @4,117,220tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @4,117,288tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@10,011,090us: [+0 T:0x422f0b60 S:0x422f0184] CE - Engine_fwriteTrace> returning count [294]
@10,011,300us: [+2 T:0x422f0b60 S:0x422f01f4] CE - Engine_createNode> Returning 0x623d0
@10,011,490us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> Enter(0x4)
@10,011,729us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> return (0x62598)
@10,011,920us: [+0 T:0x422f0b60 S:0x422f0244] OC - Comm_alloc> Enter(poolId=0x0, msg=0x62598, size=2496)
@10,012,160us: [+0 T:0x422f0b60 S:0x422f0244] OC - Comm_alloc> msg=0x446b4880, returning (0)
@10,012,383us: [+5 T:0x422f0b60 S:0x422f0264] CV - VISA_create> remote codec created (name='videnc1_copy', localQueueID=0x10002, remoteQueueID=0x0002)
@10,012,637us: [+0 T:0x422f0b60 S:0x422f036c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x62550)
@10,012,860us: [+2 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] Setting dynParams size 720x480 bitrate 2000000
@10,013,074us: [+2 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] Made XDM_SETPARAMS control call
@10,013,262us: [+0 T:0x422f0b60 S:0x422f0304] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x62550, id=5, params=0x422f04a8 (size=0x3c), status=0x422f03d8 (size=0x9c)
@10,013,529us: [+5 T:0x422f0b60 S:0x422f02cc] CV - VISA_allocMsg> Allocating message for messageId=0x00026cbc
@10,013,735us: [+0 T:0x422f0b60 S:0x422f02ac] CV - VISA_call(visa=0x62550, msg=0x446b4880): messageId=0x00026cbc, command=0x1
@10,013,961us: [+0 T:0x422f0b60 S:0x422f027c] OC - Comm_put> Enter(queue=0x2, msg=0x446b4880)
@10,014,203us: [+0 T:0x422f0b60 S:0x422f027c] OC - Comm_put> return (0)
@10,014,423us: [+0 T:0x422f0b60 S:0x422f0274] OC - Comm_get> Enter(queue=0x10002, msg=0x422f030c, timeout=-1)
@10,014,728us: [+0 T:0x422f0b60 S:0x422f0274] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@10,014,961us: [+0 T:0x422f0b60 S:0x422f01fc] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@10,015,210us: [+0 T:0x422f0b60 S:0x422f01fc] OC - Comm_put> return (0)
@10,015,463us: [+0 T:0x422f0b60 S:0x422f01f4] OC - Comm_get> Enter(queue=0x10000, msg=0x422f0288, timeout=-1)
@10,015,705us: [+0 T:0x422f0b60 S:0x422f01f4] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @4,127,643tk: [+5 T:0x8ba051fc S:0x8ba07d14] CN - NODE> 0x8fa706a0(videnc1_copy#0) call(algHandle=0x8fa70760, msg=0x8fe05880); messageId=0x00026cbc
[DSP] @4,127,758tk: [+0 T:0x8ba051fc S:0x8ba07b6c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fa70760, id=5, params=0x8fe058b4 (size=0x3c),
status=0x8fe058f0 (size=0x9c)
[DSP] @4,127,886tk: [+5 T:0x8ba051fc S:0x8ba07b4c] CV - VISA_enter(visa=0x8fa70760): algHandle = 0x8fa70790
[DSP] @4,127,961tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(handle=0x8fa70790)
[DSP] @4,128,047tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> return
[DSP] @4,128,118tk: [+5 T:0x8ba051fc S:0x8ba07b4c] CV - VISA_exit(visa=0x8fa70760): algHandle = 0x8fa70790
[DSP] @4,128,192tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(handle=0x8fa70790)
[DSP] @4,128,272tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> return
[DSP] @4,128,339tk: [+0 T:0x8ba051fc S:0x8ba07b6c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fa70760, retVal=0xfffffffd)
[DSP] @4,128,446tk: [+5 T:0x8ba051fc S:0x8ba07d14] CN - NODE> returned from call(algHandle=0x8fa70760, msg=0x8fe05880); messageId=0x00026cbc
[DSP] @4,129,983tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @4,130,055tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@10,017,606us: [+0 T:0x40018528 S:0xbefffa74] CE - Engine_open> return(401128)
@10,355,320us: [+0 T:0x422f0b60 S:0x422f022c] CE - Engine_fwriteTrace> returning count [1490]
@10,355,545us: [+0 T:0x422f0b60 S:0x422f02ac] CV - VISA_call Completed: messageId=0x00026cbc, command=0x1, return(status=-3)
@10,355,782us: [+5 T:0x422f0b60 S:0x422f02bc] CV - VISA_freeMsg(0x62550, 0x446b4880): Freeing message with messageId=0x00026cbc
@10,356,013us: [+0 T:0x422f0b60 S:0x422f0304] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x62550, retVal=0xfffffffd)
@10,356,241us: [+7 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] XDM_GETBUFINFO control failed
@10,356,429us: [+0 T:0x422f0b60 S:0x422f037c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> Enter (handle=0x62550)
@10,356,660us: [+0 T:0x422f0b60 S:0x422f0354] CV - VISA_delete(0x62550)
@10,356,831us: [+5 T:0x422f0b60 S:0x422f0354] CV - VISA_delete> deleting codec (localQueue=0x10002, remoteQueue=0x2)
@10,357,036us: [+0 T:0x422f0b60 S:0x422f0324] OC - Comm_put> Enter(queue=0x2, msg=0x446b4880)
@10,357,283us: [+0 T:0x422f0b60 S:0x422f0324] OC - Comm_put> return (0)
@10,357,533us: [+0 T:0x422f0b60 S:0x422f031c] OC - Comm_get> Enter(queue=0x10002, msg=0x62598, timeout=-1)
@10,357,771us: [+0 T:0x422f0b60 S:0x422f031c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@10,357,974us: [+0 T:0x422f0b60 S:0x422f030c] CE - Engine_deleteNode(0x623d0)
@10,358,155us: [+0 T:0x422f0b60 S:0x422f02ec] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@10,358,388us: [+0 T:0x422f0b60 S:0x422f02ec] OC - Comm_put> return (0)
@10,358,571us: [+0 T:0x422f0b60 S:0x422f02e4] OC - Comm_get> Enter(queue=0x10000, msg=0x422f0354, timeout=-1)
ctrlFxnFUN: FILE: ../ctrl.c, LINE: 319.
@10,359,551us: [+5 T:0x422f0b60 S:0x422f030c] CE - Engine_deleteNode(0x623d0): algName = videnc1_copy, algHandle = 0x8fa70760, stack size = 11096, stack used
= 963(9%)
@10,359,822us: [+0 T:0x422f0b60 S:0x422f02f4] OC - Comm_delete> Enter (comm=0x62588)
@10,360,359us: [+0 T:0x422f0b60 S:0x422f02cc] OM - Memory_free> Enter(0x62588, 0x4)
@10,360,604us: [+0 T:0x422f0b60 S:0x422f02cc] OM - Memory_free> return (0x1)
@10,360,795us: [+0 T:0x422f0b60 S:0x422f0304] OC - Comm_delete> return
@10,360,968us: [+0 T:0x422f0b60 S:0x422f02e4] OM - Memory_free> Enter(0x623d0, 0x20)
@10,361,154us: [+0 T:0x422f0b60 S:0x422f02e4] OM - Memory_free> return (0x1)
@10,361,330us: [+0 T:0x422f0b60 S:0x422f033c] OC - Comm_free> Enter (msg=0x446b4880)
@10,361,544us: [+0 T:0x422f0b60 S:0x422f033c] OC - Comm_free> return (0)
@10,361,725us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> Enter(0x62598, 0x4)
@10,361,932us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> return (0x1)
@10,362,114us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> Enter(0x62550, 0x30)
@10,362,329us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> return (0x1)
@10,362,506us: [+0 T:0x422f0b60 S:0x422f038c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> return
Error: Failed to create  vidend1_copy encoder
ctrlFxnFUN: FILE: ../ctrl.c, LINE: 335.
ctrlFxnFUN: FILE: ../ctrl.c, LINE: 343.
ctrlFxnFUN: FILE: ../ctrl.c, LINE: 349.
@78,982,559us: [+0 T:0x40018528 S:0xbefff9f4] OG - Global_exit> enter
@78,982,805us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x11b84()...
@78,983,027us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x22744()...
@78,983,266us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x23bf4()...
@78,983,484us: [+0 T:0x40018528 S:0xbefff9bc] OM - Memory_free> Enter(0x593e8, 0x18)
@78,983,678us: [+0 T:0x40018528 S:0xbefff9bc] OM - Memory_free> return (0x1)
@78,983,851us: [+0 T:0x40018528 S:0xbefff9bc] OM - Memory_free> Enter(0x59408, 0x18)
@78,984,029us: [+0 T:0x40018528 S:0xbefff9bc] OM - Memory_free> return (0x1)
@78,984,200us: [+0 T:0x40018528 S:0xbefff9bc] OM - Memory_free> Enter(0x59428, 0x18)
@78,984,376us: [+0 T:0x40018528 S:0xbefff9bc] OM - Memory_free> return (0x1)
@78,984,544us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x2be3c()...
@78,984,727us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x26870()...
@78,984,906us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x26dd0()...
@78,985,086us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x2997c()...
@78,985,267us: [+2 T:0x40018528 S:0xbefff9f4] OG - Global_exit> calling function *0x27888()...
@78,985,445us: [+0 T:0x40018528 S:0xbefff9bc] OP - doCmd> Enter (cmdId=3, proc=0x0)
@78,985,618us: [+0 T:0x40018528 S:0xbefff9ac] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x591c0]
@78,985,824us: [+0 T:0x40018528 S:0xbefff9bc] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x591c0]
@78,986,052us: [+0 T:0x40018528 S:0xbefff99c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x591d8] timeout[0xffffffff]
@78,986,388us: [+0 T:0x40acab60 S:0x40aca50c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x591c0] status[0]
@78,986,622us: [+0 T:0x40acab60 S:0x40aca52c] OP - getCmd_d> Exit (result=3)
@78,986,804us: [+0 T:0x40acab60 S:0x40aca51c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x591d8]
@78,987,026us: [+0 T:0x40018528 S:0xbefff99c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x591d8] status[0]
@78,987,237us: [+0 T:0x40018528 S:0xbefff9bc] OP - doCmd> Exit (result=1)
@78,987,407us: [+0 T:0x40018528 S:0xbefff9c4] OT - Thread_delete> Enter (
root@192.168.5.127:/opt/dvsdk# clear

root@192.168.5.127:/opt/dvsdk#
root@192.168.5.127:/opt/dvsdk#
root@192.168.5.127:/opt/dvsdk#
root@192.168.5.127:/opt/dvsdk# CE_DEBUG=0 ./encodedecode
@0,357,181us: [+4 T:0x40018528 S:0xbefffb0c] OG - Global_init> This program was built with the following packages:
@0,358,122us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package gnu.targets.rts470MV (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/gnu/targets/rts470MV/) [1,0,0,0,1203621000516]
@0,358,491us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.codecs.h264enc (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264enc/) [1,0,0,1221669049000]
@0,358,742us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.codecs.h264dec (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264dec/) [1,0,0,1221669049000]
@0,358,976us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.xdais.dm.examples.viddec2_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/xdais/dm/examples/viddec2_copy/) [2,0,0,1372385245000]
@0,359,224us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.xdais.dm.examples.videnc1_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/xdais/dm/examples/videnc1_copy/) [2,0,0,1372399186000]
@0,359,470us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.xdais.dm (/opt/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/dm/) [1,0,4,1210262746529]
@0,359,678us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.xdais (/opt/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/) [1,2,1,1210262742149]
@0,359,880us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.utils.trace (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/utils/trace/) [1,0,0,1220943366422]
@0,360,160us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/xdm/) [1,0,1,1220951322616]
@0,360,404us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dman3/) [1,0,3,1220943053023]
@0,360,633us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/acpy3/) [1,0,2,1220943014135]
@0,360,859us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package dsplink.gpp (/opt/dvsdk_1_40_02_33/dsplink-davinci-v1.50-prebuilt/packages/dsplink/gpp/) [3,0,0]@0,361,066us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.linuxutils.cmem (/opt/dvsdk_1_40_02_33/cmem_2_10/packages/ti/sdo/linuxutils/cmem/) [2,0,1,1204929560755]
@0,361,392us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.catalog.c470 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/catalog/c470/) [1,0,1,0,1203561761475]
@0,361,613us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.catalog.c6000 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/catalog/c6000/) [1,0,0,0,1203561781695]
@0,361,833us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.platforms.evmDM6467 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/platforms/evmDM6467/) [1,0,0,0,1203562062227]
@0,362,059us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.osal (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/) [2,0,2,1220951127739]
@0,362,280us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/) [2,0,1,1220951085787]
@0,362,496us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.osal.linux (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/linux/)
 [2,0,1,1220951140072]
@0,362,722us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.ipc.dsplink (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/dsplink/) [2,0,1,1220951096818]
@0,362,951us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.alg (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/alg/) [1,0,1,1220950781938]
@0,363,167us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/) [1,0,6,1220950771473]@0,363,373us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.video1 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video1/) [1,0,2,1220951340734]
@0,696,757us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.codecs.h264enc.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1221669049000]
@0,697,020us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.video2 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video2/) [1,0,2,1220951347240]
@0,697,255us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.codecs.h264dec.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264dec/ce/) [1,0,0,1221669049000]
@0,697,494us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.examples.codecs.viddec2_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/viddec2_copy/) []
@0,697,736us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.examples.codecs.videnc1_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/videnc1_copy/) []
@0,697,975us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.speech (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/speech/) [1,0,2,1220951161404]
@0,698,193us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.speech1 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/speech1/) [1,0,1,1220951167662]
@0,698,412us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.audio (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/audio/) [1,0,2,1220950788137]
@0,698,629us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.video (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video/) [1,0,3,1220951334122]
@0,698,846us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.dmai (/opt/dvsdk_1_40_02_33/dmai_1_10_00_06/packages/ti/sdo/dmai/) [1,0,0,1372398243000]
@0,699,055us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.simplewidget (/opt/dvsdk_1_40_02_33/dvsdk_demos_1_40_00_18/packages/ti/sdo/simplewidget/)
 []
@0,699,272us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/bioslog/) [1,0,1,1220950800329]
@0,699,519us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package ti.sdo.ce.utils.trace (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/trace/) [1,0,1,1220951317087]
@0,699,752us: [+4 T:0x40018528 S:0xbefffb0c] OG -     package encodedecode_config (/opt/dvsdk_1_40_02_33/dvsdk_demos_1_40_00_18/dm6467/encodedecode/encodedecode_config/) []
@0,700,133us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2d1bc)
@0,700,350us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2c654)
@0,700,647us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@0,700,841us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x590f0)
@0,701,950us: [+0 T:0x40018528 S:0xbefffb04] OG - Global_atexit> enter (fxn=0x2af3c)
@0,702,249us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@0,702,478us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x59140)
@0,702,654us: [+0 T:0x40018528 S:0xbefffb04] OG - Global_atexit> enter (fxn=0x28b88)
@0,702,925us: [+0 T:0x40018528 S:0xbefffb0c] OG - Global_atexit> enter (fxn=0x2bcd8)
@0,703,181us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,703,368us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> Enter(0x14)
@0,703,541us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> return (0x591c0)
@0,703,736us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x591c0]
@0,703,920us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,704,083us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> Enter(0x14)
@0,704,252us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> return (0x591d8)
@0,704,415us: [+0 T:0x40018528 S:0xbefffaf4] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x591d8]
@1,037,986us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> Enter(0x18)
@1,038,202us: [+0 T:0x40018528 S:0xbefffadc] OM - Memory_alloc> return (0x591f0)
@1,038,384us: [+0 T:0x40018528 S:0xbefffadc] OT - Thread_create> Enter (fxn=0x27cc8, attrs=0x0)
@1,038,569us: [+0 T:0x40018528 S:0xbefffac4] OM - Memory_alloc> Enter(0x64)
@1,038,743us: [+0 T:0x40018528 S:0xbefffac4] OM - Memory_alloc> return (0x59210)
@1,039,462us: [+0 T:0x40018528 S:0xbefffadc] OT - Thread_create> Exit (task=0x59210)
@1,039,687us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x27888)
@1,039,898us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2997c)
@1,040,263us: [+0 T:0x40018528 S:0xbefffafc] ti.sdo.ce.alg - ALG_init> Enter
@1,040,461us: [+0 T:0x40018528 S:0xbefffaec] OG - Global_atexit> enter (fxn=0x26dd0)
@1,040,671us: [+0 T:0x40018528 S:0xbefffb1c] ti.sdo.ce.alg - ALG_init> Exit
@1,040,839us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x26870)
@1,041,030us: [+0 T:0x40018528 S:0xbefffaec] OM - Memory_alloc> Enter(0x18)
@1,041,211us: [+0 T:0x40018528 S:0xbefffaec] OM - Memory_alloc> return (0x593a8)
@1,041,385us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x2be3c)
@1,045,516us: [+1 T:0x40acab60 S:0x40aca52c] OP - daemon> thread created.
@1,046,094us: [+0 T:0x40acab60 S:0x40aca52c] OP - getCmd_d> Enter (proc=0x40aca5a4)
@1,046,322us: [+0 T:0x40acab60 S:0x40aca50c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x591c0] timeout[0xffffffff]
@1,046,735us: [+6 T:0x40018528 S:0xbefffb14] CE - Engine_init> CE debugging on (CE_DEBUG=0; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@1,046,987us: [+0 T:0x40018528 S:0xbefffb04] OG - Global_atexit> enter (fxn=0x23bf4)
@1,047,175us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@1,047,358us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x593e8)
@1,047,534us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@1,047,707us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x59408)
@1,047,879us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> Enter(0x18)
@1,048,052us: [+0 T:0x40018528 S:0xbefffae4] OM - Memory_alloc> return (0x59428)
@1,048,291us: [+0 T:0x40018528 S:0xbefffb14] CS - Server_init()
@1,048,455us: [+0 T:0x40018528 S:0xbefffb14] CS - Server_init> Global_useLinkArbiter = 0
@1,048,632us: [+0 T:0x40018528 S:0xbefffb14] OG - Global_atexit> enter (fxn=0x22744)
@1,048,900us: [+0 T:0x40018528 S:0xbefffb24] OG - Global_atexit> enter (fxn=0x11b84)
Encodedecode demo started.
TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil)
@1,058,390us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> Enter(0x7800)
@1,058,617us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> Enter(size=30720, align=-1, cached=FALSE, heap=FALSE)
@1,058,982us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_alloc(30720) = 0x40ad3000.
@1,059,231us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_getPhys(0x40ad3000) = 0x8804e000.
@1,059,441us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> Enter(virtAddr=0x40ad3000, size=30720, physAddr=0x8804e000)
@1,059,656us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> creating new contigBuf object
@1,059,832us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> Enter(0x10)
@1,060,066us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> return (0x617b0)
@1,060,259us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> returning: cb->phys=0x8804e000, cb->size=30720, cb->virt=0x40ad3000
@1,060,507us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> return (0x40ad3000)
@1,060,685us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> return (0x40ad3000)
@1,060,855us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40ad3000, size=4)
@1,061,051us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40ad3000, size=4)
@1,395,957us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40ad3000, Ec=0x40ada800, Ss=0x40ad3000, Es=0x40ad3004, PSc=0x8804e000)
@1,396,239us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> returning physAddr=0x8804e000
@1,396,432us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> return (0x8804e000)
@1,396,613us: [+2 T:0x40018528 S:0xbefffa6c] ti.sdo.dmai - [Buffer] Alloc Buffer of size 30720 at 0x40ad3000 (0x8804e000 phys)
@1,648,593us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> Enter(0x7800)
@1,648,834us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> Enter(size=30720, align=-1, cached=FALSE, heap=FALSE)
@1,649,181us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_alloc(30720) = 0x40ae2000.
@1,649,426us: [+4 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> CMEM_getPhys(0x40ae2000) = 0x8803f000.
@1,649,629us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> Enter(virtAddr=0x40ae2000, size=30720, physAddr=0x8803f000)
@1,649,845us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> creating new contigBuf object
@1,650,077us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> Enter(0x10)
@1,650,270us: [+0 T:0x40018528 S:0xbefff994] OM - Memory_alloc> return (0x61838)
@1,650,450us: [+1 T:0x40018528 S:0xbefff9ac] OM - Memory__addContigBuf> returning: cb->phys=0x8803f000, cb->size=30720, cb->virt=0x40ae2000
@1,650,666us: [+0 T:0x40018528 S:0xbefffa04] OM - Memory_contigAlloc> return (0x40ae2000)
@1,650,838us: [+0 T:0x40018528 S:0xbefffa54] OM - Memory_alloc> return (0x40ae2000)
@1,651,005us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40ae2000, size=4)
@1,651,200us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40ae2000, size=4)
@1,651,389us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40ae2000, Ec=0x40ae9800, Ss=0x40ae2000, Es=0x40ae2004, PSc=0x8803f000)
@1,651,626us: [+1 T:0x40018528 S:0xbefffa2c] OM - Memory__getPhysicalAddress> returning physAddr=0x8803f000
@1,651,810us: [+0 T:0x40018528 S:0xbefffa2c] OM - Memory_getBufferPhysicalAddress> return (0x8803f000)
@1,652,023us: [+2 T:0x40018528 S:0xbefffa6c] ti.sdo.dmai - [Buffer] Alloc Buffer of size 30720 at 0x40ae2000 (0x8803f000 phys)
VPIF_OPEN: LINE: 2430.
@2,055,557us: [+0 T:0x422f0b60 S:0x422f0404] CE - Engine_open> Enter('encodedecode', 0x0, 0x422f044c)
@2,055,888us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> Enter(0x2c)
@2,056,101us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> return (0x61e90)
@2,056,335us: [+0 T:0x422f0b60 S:0x422f0404] CE - rserverOpen('video_copy.x64P'), count = 0
@2,056,531us: [+0 T:0x422f0b60 S:0x422f03cc] OP - Processor_create> Enter(imageName='video_copy.x64P', linkCfg='(null)', attrs=0x422f0450)
@2,057,104us: [+0 T:0x40018528 S:0xbefffa74] CE - Engine_open> Enter('encodedecode', 0x0, 0xbefffabc)
@2,057,350us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> Enter(0x2c)
@2,057,855us: [+0 T:0x422f0b60 S:0x422f03b4] OM - Memory_alloc> Enter(0x24)
@2,058,077us: [+0 T:0x422f0b60 S:0x422f03b4] OM - Memory_alloc> return (0x61ec0)
@2,058,272us: [+0 T:0x422f0b60 S:0x422f03ac] OP - doCmd> Enter (cmdId=1, proc=0x61ec0)
@2,058,468us: [+0 T:0x422f0b60 S:0x422f039c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x591c0]
@2,058,716us: [+0 T:0x422f0b60 S:0x422f03ac] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x591c0]
@2,058,958us: [+0 T:0x422f0b60 S:0x422f038c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x591d8] timeout[0xffffffff]
@2,059,223us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> return (0x61ee8)
@2,059,849us: [+0 T:0x40acab60 S:0x40aca50c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x591c0] status[0]
@2,060,891us: [+0 T:0x40acab60 S:0x40aca52c] OP - getCmd_d> Exit (result=1)
@2,061,576us: [+0 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Enter(proc=0x61ec0)
@2,075,220us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Initializing DSP PROC...
@2,075,463us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'video_copy.x64P']
@2,075,702us: [+0 T:0x40acab60 S:0x40aca514] OM - Memory_alloc> Enter(0xe0)
@2,075,934us: [+0 T:0x40acab60 S:0x40aca514] OM - Memory_alloc> return (0x61f18)
@2,514,646us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fa00000, sizeInBytes=0x400000, shared=1
@2,515,487us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000,
 sizeInBytes=0x100000, shared=1
@2,515,800us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x8ff00000, sizeInBytes=0x80, shared=0
in Display_v412_create, FILE: linux/Display_v4l2.c, LINE: 148.
@2,516,076us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x8ba00000,
 sizeInBytes=0x4000000, shared=0
@5,640,429us: [+2 T:0x412f0b60 S:0x412f03fc] ti.sdo.dmai - [Display] Video output set to size 720x480 pitch 720
in Display_v412_create, FILE: linux/Display_v4l2.c, LINE: 163.
@5,641,150us: [+2 T:0x412f0b60 S:0x412f024c] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers
@5,641,448us: [+2 T:0x41af0b60 S:0x41af0254] ti.sdo.dmai - [Capture] Capture input set to COMPOSITE
@5,960,159us: [+2 T:0x412f0b60 S:0x412f029c] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x422f1000 has physical address 0x83400000
@6,273,615us: [+2 T:0x412f0b60 S:0x412f029c] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x426e6000 has physical address 0x83800000
@6,587,581us: [+2 T:0x412f0b60 S:0x412f029c] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x42adb000 has physical address 0x83c00000
@6,588,361us: [+2 T:0x41af0b60 S:0x41af02f4] ti.sdo.dmai - [Capture] Video input connected size 720x480 pitch 720
@6,588,691us: [+2 T:0x41af0b60 S:0x41af0144] ti.sdo.dmai - [BufTab] Allocating BufTab for 4 buffers
@6,902,361us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x42ed0000 has physical address 0x80800000
@7,216,046us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x432c5000 has physical address 0x80c00000
@7,529,776us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x436ba000 has physical address 0x84000000
@7,843,503us: [+2 T:0x41af0b60 S:0x41af0194] ti.sdo.dmai - [Dmai] Driver buffer 3 mapped to 0x43aaf000 has physical address 0x84400000
-----------FILE: capture.c, LINE: 55...............
-----------FILE: capture.c, LINE: 61...............
-----------FILE: capture.c, LINE: 71...............
-----------FILE: (null), LINE: 52...............
@7,844,601us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> DOPOWERCONTROL was=0; now=0
@7,851,639us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Attaching to DSP PROC...
@7,860,734us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Opening MSGQ pool...
@7,861,397us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Loading video_copy.x64P on DSP (1 args)...
@8,156,404us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Starting DSP PROC...
@8,249,723us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> Opening remote transport...
@8,254,261us: [+2 T:0x40acab60 S:0x40aca52c] OP - Processor_create_d> return (1)
@8,265,295us: [+0 T:0x40acab60 S:0x40aca51c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x591d8]
@8,265,574us: [+0 T:0x422f0b60 S:0x422f038c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x591d8] status[0]
@8,265,972us: [+0 T:0x422f0b60 S:0x422f03ac] OP - doCmd> Exit (result=1)
@8,266,172us: [+0 T:0x422f0b60 S:0x422f03cc] OP - Processor_create> return (0x61ec0)
@8,266,362us: [+0 T:0x422f0b60 S:0x422f0404] CE - rserverOpen('video_copy.x64P'): 0x57be0 done.
@8,266,587us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> Enter(0x20)
@8,266,787us: [+0 T:0x422f0b60 S:0x422f03ec] OM - Memory_alloc> return (0x623d0)
@8,266,997us: [+0 T:0x422f0b60 S:0x422f03dc] OC - Comm_create> Enter(queueName='encodedecode_0', queue=0x61ea0, attrs=0x0)
@8,267,215us: [+0 T:0x422f0b60 S:0x422f03c4] OM - Memory_alloc> Enter(0x4)
@8,267,393us: [+0 T:0x422f0b60 S:0x422f03c4] OM - Memory_alloc> return (0x623f8)
@8,267,895us: [+0 T:0x422f0b60 S:0x422f03dc] OC - Comm_create> return (0x623f8)
@8,268,129us: [+0 T:0x422f0b60 S:0x422f03dc] OM - Memory_free> Enter(0x623d0, 0x20)
@8,268,330us: [+0 T:0x422f0b60 S:0x422f03dc] OM - Memory_free> return (0x1)
@8,268,512us: [+0 T:0x422f0b60 S:0x422f03e4] OC - Comm_alloc> Enter(poolId=0x0, msg=0x61eac, size=576)
@8,268,788us: [+0 T:0x422f0b60 S:0x422f03e4] OC - Comm_alloc> msg=0x446b2880, returning (0)
@8,268,991us: [+0 T:0x422f0b60 S:0x422f03c4] OC - Comm_locate> Enter(queueName='rmsq', queue=0x61e9c)
@8,275,376us: [+0 T:0x422f0b60 S:0x422f03c4] OC - Comm_locate> return (0)
@8,275,610us: [+0 T:0x422f0b60 S:0x422f0404] CE - checkServer(0x61e90)
@8,275,824us: [+0 T:0x422f0b60 S:0x422f03d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,276,082us: [+0 T:0x422f0b60 S:0x422f03d4] OC - Comm_put> return (0)
@8,276,339us: [+0 T:0x422f0b60 S:0x422f03cc] OC - Comm_get> Enter(queue=0x10000, msg=0x422f0448, timeout=-1)
@8,276,576us: [+0 T:0x422f0b60 S:0x422f03cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@8,276,788us: [+0 T:0x422f0b60 S:0x422f0404] CE - rmsInit> RMS initialized(0x61e90); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3
@8,277,069us: [+0 T:0x422f0b60 S:0x422f03d4] CE - Engine_setTrace> Enter(engine=0x61e90, mask='*+01234567,GT_prefix=12345,GT_time=3')
@8,277,320us: [+1 T:0x422f0b60 S:0x422f03d4] CE - Engine_setTrace> Requesting DSP set trace ...
@8,277,510us: [+0 T:0x422f0b60 S:0x422f03a4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,277,743us: [+0 T:0x422f0b60 S:0x422f03a4] OC - Comm_put> return (0)
@8,277,927us: [+0 T:0x422f0b60 S:0x422f039c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f040c, timeout=-1)
@8,278,187us: [+0 T:0x40018528 S:0xbefffa74] CE - rserverOpen('video_copy.x64P'), count = 1
@8,278,389us: [+0 T:0x40018528 S:0xbefffa74] CE - rserverOpen('video_copy.x64P'): 0x57be0 done.
@8,278,587us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> Enter(0x20)
@8,278,765us: [+0 T:0x40018528 S:0xbefffa5c] OM - Memory_alloc> return (0x623d0)
@8,278,956us: [+0 T:0x40018528 S:0xbefffa4c] OC - Comm_create> Enter(queueName='encodedecode_1', queue=0x61ef8, attrs=0x0)
@8,279,159us: [+0 T:0x40018528 S:0xbefffa34] OM - Memory_alloc> Enter(0x4)
@8,279,326us: [+0 T:0x40018528 S:0xbefffa34] OM - Memory_alloc> return (0x62408)
@8,279,852us: [+0 T:0x40018528 S:0xbefffa4c] OC - Comm_create> return (0x62408)
@8,280,301us: [+0 T:0x422f0b60 S:0x422f039c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@8,280,535us: [+0 T:0x422f0b60 S:0x422f03d4] CE - Engine_setTrace> return(0)
@8,280,748us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,280,997us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> return (0)
@8,281,248us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f03f0, timeout=-1)
@8,281,486us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @0,066,105tk: [+0 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3')
[DSP] @0,066,216tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,066,298tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.targets.rts6000 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/targets/rts6000/) [1,0,0,0,1203621186754]
[DSP] @0,066,400tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264enc (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264enc/) [1,0,0,1221669049000]
[DSP] @0,066,511tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264dec (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264dec/) [1,0,0,1221669049000]
[DSP] @0,066,622tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.hdvicp (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/hdvicp/) [1,0,0,1221669049000]
[DSP] @0,066,731tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais.dm.examples.viddec2_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/xdais/dm/examples/viddec2_copy/) [2,0,0,1372385245000]
[DSP] @0,066,852tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais.dm.examples.videnc1_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/xdais/dm/examples/videnc1_copy/) [2,0,0,1372399186000]
[DSP] @0,066,972tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.ires.hdvicp (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/hdvicp/) [1,0,0,1220943209717]
[DSP] @0,067,085tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.hdintc (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/hdintc/) [1,0,3,1220943133917]
[DSP] @0,067,192tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.edma3.rm (/opt/dvsdk_1_40_02_33/edma3_lld_1_04_00/packages/ti/sdo/edma3/rm/) [1,3,2,1201524583021]
[DSP] @0,067,294tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.ires.nullresource (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/nullresource/) [1,0,0,1220943221523]
[DSP] @0,067,412tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais.dm (/opt/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/dm/) [1,0,4,1210262746529]
[DSP] @0,067,508tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.xdais (/opt/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/) [1,2,1,1210262742149]
[DSP] @0,067,600tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.node (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/node/) [1,0,0,1220951122176]
[DSP] @0,067,702tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1220951102696]
[DSP] @0,067,823tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.utils.trace (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/utils/trace/) [1,0,0,1220943366422]
[DSP] @0,067,933tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/xdm/) [1,0,1,1220951322616]
[DSP] @0,068,040tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dman3/) [1,0,3,1220943053023]
[DSP] @0,068,147tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/acpy3/) [1,0,2,1220943014135]
[DSP] @0,068,254tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package dsplink.dsp (/opt/dvsdk_1_40_02_33/dsplink-davinci-v1.50-prebuilt/packages/dsplink/dsp/) [1,3,0]
[DSP] @0,068,351tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.rtdx (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/rtdx/) [2,0,0,1,1194024051755]
[DSP] @0,068,443tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.psl (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/psl/) [5,0,0,0,0]
[DSP] @0,068,529tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti@8,282,716us: [+0 T:0x40018528 S:0xbefffa4c] OM - Memory_free> Enter(0x623d0, 0x20)
@8,626,728us: [+0 T:0x40018528 S:0xbefffa4c] OM - Memory_free> return (0x1)
@8,961,566us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@8,961,877us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> return (0)
@8,962,138us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f03f0, timeout=-1)
@8,962,378us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
.bios (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/bios/) [5,2,4,9,1193960176642]
[DSP] @0,068,622tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.dskt2 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dskt2/) [1,0,4,1220943095081]
[DSP] @0,068,728tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.rman (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/rman/) [2,0,0,1220943245318]
[DSP] @0,068,834tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.edma3 (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/edma3/) [2,0,0,1220943121256]
[DSP] @0,068,941tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.fc.ires.edma3chan (/opt/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/edma3chan/) [1,0,0,1220943162542]
[DSP] @0,069,056tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.bios.utils (/opt/dvsdk_1_40_02_33/biosutils_1_01_00/packages/ti/bios/utils/) [2,0,1,0,1191891830609]
[DSP] @0,069,157tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.catalog.c6000 (/opt/dvsdk_1_40_02_33/xdc_3_00_06/packages/ti/catalog/c6000/) [1,0,0,0,1203561781695]
[DSP] @0,069,257tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.platforms.evmDM6467 (/opt/dvsdk_1_40_02_33/bios_5_32_01/packages/ti/platforms/evmDM6467/) [1,0,0,0,1192229633217]
[DSP] @0,069,364tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.osal (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/) [2,0,2,1220951127739]
[DSP] @0,069,466tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/) [2,0,1,1220951085787]
[DSP] @0,069,567tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.alg (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/alg/) [1,0,1,1220950781938]
[DSP] @0,069,669tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.osal.bios (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/bios/) [2,0,1,1220951133740]
[DSP] @0,069,775tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.ipc.bios (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1220951091097]
[DSP] @0,069,881tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/) [1,0,6,1220950771473]
[DSP] @0,069,978tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/bioslog/)
 [1,0,1,1220950800329]
[DSP] @0,070,083tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.video1 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video1/) [1,0,2,1220951340734]
[DSP] @0,070,194tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264enc.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1221669049000]
[DSP] @0,070,307tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.video2 (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/video2/) [1,0,2,1220951347240]
[DSP] @0,070,412tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.codecs.h264dec.ce (/opt/dvsdk_1_40_02_33/dm6467_dvsdk_combos_1_17/packages/ti/sdo/codecs/h264dec/ce/) [1,0,0,1221669049000]
[DSP] @0,070,525tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.examples.codecs.viddec2_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/viddec2_copy/) []
[DSP] @0,070,641tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package ti.sdo.ce.examples.codecs.videnc1_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/codecs/videnc1_copy/) []
[DSP] @0,070,757tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG -     package video_copy (/opt/dvsdk_1_40_02_33/codec_engine_2_10_02/examples/ti/sdo/ce/examples/servers/video_copy/evmDM6467/video_copy/) []
[DSP] @0,070,869tk: [+0 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> return
[DSP] @0,073,610tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,073,686tk: [+0 T:0@8,969,216us: [+0 T:0x40018528 S:0xbefffa54] OC - Comm_alloc> Enter(poolId=0x0, msg=0x61f04, size=576)
@9,305,281us: [+0 T:0x40018528 S:0xbefffa54] OC - Comm_alloc> msg=0x446b3880, returning (0)
@9,305,480us: [+0 T:0x40018528 S:0xbefffa34] OC - Comm_locate> Enter(queueName='rmsq', queue=0x61ef4)
@9,311,953us: [+0 T:0x40018528 S:0xbefffa34] OC - Comm_locate> return (0)
@9,312,202us: [+0 T:0x40018528 S:0xbefffa74] CE - checkServer(0x61ee8)
@9,312,397us: [+0 T:0x40018528 S:0xbefffa44] OC - Comm_put> Enter(queue=0x0, msg=0x446b3880)
@9,312,642us: [+0 T:0x40018528 S:0xbefffa44] OC - Comm_put> return (0)
@9,312,890us: [+0 T:0x40018528 S:0xbefffa3c] OC - Comm_get> Enter(queue=0x10001, msg=0xbefffab8, timeout=-1)
@9,313,117us: [+0 T:0x40018528 S:0xbefffa3c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@9,313,359us: [+0 T:0x40acab60 S:0x40aca52c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x591d8]
@9,313,593us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@9,313,863us: [+0 T:0x422f0b60 S:0x422f0364] OC - Comm_put> return (0)
@9,314,121us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f03f0, timeout=-1)
@9,314,357us: [+0 T:0x422f0b60 S:0x422f035c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @1,653,450tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @1,653,520tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @2,467,339tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 6
[DSP] @2,470,170tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @2,470,238tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@9,315,711us: [+0 T:0x422f0b60 S:0x422f0394] CE - Engine_fwriteTrace> returning count [8916]
@9,315,934us: [+0 T:0x422f0b60 S:0x422f0404] CE - Engine_open> return(401040)
@9,316,183us: [+2 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] Creating encoder videnc1_copy for max 720x480 bitrate 2000000 ratectrl 4
@9,316,528us: [+0 T:0x422f0b60 S:0x422f036c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x61e90, name='videnc1_copy', params=0x422f0568)
@9,316,808us: [+0 T:0x422f0b60 S:0x422f033c] CV - VISA_create(0x61e90, 'videnc1_copy', 0x422f0568, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
@9,317,047us: [+0 T:0x422f0b60 S:0x422f0264] CV - VISA_create2(0x61e90, 'videnc1_copy', 0x422f0568, 0x30, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
@9,317,309us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> Enter(0x30)
@9,317,499us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> return (0x62550)
@9,317,716us: [+0 T:0x422f0b60 S:0x422f01f4] CE - Engine_createNode(0x61e90, 'videnc1_copy', 2496, 0x422f0568, 0x30, 0x422f0368)
@9,317,948us: [+0 T:0x422f0b60 S:0x422f01dc] OM - Memory_alloc> Enter(0x20)
@9,318,127us: [+0 T:0x422f0b60 S:0x422f01dc] OM - Memory_alloc> return (0x623d0)
@9,318,326us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_create> Enter(queueName='gppfromnode_2', queue=0x623d8, attrs=0x0)
@9,318,542us: [+0 T:0x422f0b60 S:0x422f01b4] OM - Memory_alloc> Enter(0x4)
@9,318,720us: [+0 T:0x422f0b60 S:0x422f01b4] OM - Memory_alloc> return (0x62588)
@9,654,717us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_create> return (0x62588)
@9,654,962us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@9,655,219us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> return (0)
@9,655,407us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> Enter(queue=0x10000, msg=0x422f024c, timeout=-1)
@9,655,664us: [+0 T:0x40018528 S:0xbefff9d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b3880)
@9,655,933us: [+0 T:0x40018528 S:0xbefff9d4] OC - Comm_put> return (0)
@9,656,258us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@9,656,490us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@9,656,737us: [+0 T:0x422f0b60 S:0x422f01d4] OC - Comm_put> return (0)
@9,657,005us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> Enter(queue=0x10000, msg=0x422f024c, timeout=-1)
@9,657,247us: [+0 T:0x422f0b60 S:0x422f01cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@9,657,452us: [+4 T:0x422f0b60 S:0x422f01f4] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10002, msgq=0x62588, algName='videnc1_copy', rmsNode=0x8fa70678, algHandle=0x8fa70760)
@9,657,783us: [+0 T:0x40018528 S:0xbefff9cc] OC - Comm_get> Enter(queue=0x10001, msg=0xbefffa60, timeout=-1)
@9,658,026us: [+0 T:0x40018528 S:0xbefff9cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @3,262,228tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 0
[DSP] @3,262,305tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0x18)
[DSP] @3,262,370tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fa70678)
[DSP] @3,262,434tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0xf)
[DSP] @3,262,492tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fa70690)
[DSP] @3,262,561tk: [+0 T:0x8ba0006c S:0x8ba03edc] OM - Memory_alloc> Enter(size=0x20)
[DSP] @3,262,620tk: [+0 T:0x8ba0006c S:0x8ba03edc] OM - Memory_alloc> return (0x8fa706a0)
[DSP] @3,262,683tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_alloc> Enter(size=0x24)
[DSP] @3,262,743tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_alloc> return (0x8fa706c0)
[DSP] @3,262,830tk: [+0 T:0x8ba0006c S:0x8ba03ec4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x0, name='videnc1_copy', params=0x8fe038c0)
[DSP] @3,262,946tk: [+0 T:0x8ba0006c S:0x8ba03e8c] CV - VISA_create(0x0, 'videnc1_copy', 0x8fe038c0, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
[DSP] @3,263,038tk: [+0 T:0x8ba0006c S:0x8ba03d7c] CV - VISA_create2(0x0, 'videnc1_copy', 0x8fe038c0, 0x30, 0x2496, 'ti.sdo.ce.video1.IVIDENC1')
[DSP] @3,263,142tk: [+0 T:0x8ba0006c S:0x8ba03d14] CE - Engine_open> Enter('local', 0x8ba03d6c, 0x9c0)
[DSP] @3,263,214tk: [+0 T:0x8ba0006c S:0x8ba03cf4] OM - Memory_alloc> Enter(size=0x2c)
[DSP] @3,263,275tk: [+0 T:0x8ba0006c S:0x8ba03cf4] OM - Memory_alloc> return (0x8fa70730)
[DSP] @3,263,345tk: [+0 T:0x8ba0006c S:0x8ba03d14] CE - Engine_open> return(-1884879056)
[DSP] @3,263,421tk: [+0 T:0x8ba0006c S:0x8ba03d5c] OM - Memory_alloc> Enter(size=0x30)
[DSP] @3,263,482tk: [+0 T:0x8ba0006c S:0x8ba03d5c] OM - Memory_alloc> return (0x8fa70760)
[DSP] @3,263,546tk: [+0 T:0x8ba0006c S:0x8ba03d34] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fa6fdb0, idma3Fxns=0x0, params=0x8fe038c0, attrs=0x8ba03e80)
[DSP] @3,263,652tk: [+0 T:0x8ba0006c S:0x8ba03d14] OM - Memory_alloc> Enter(size=0x10)
[DSP] @3,263,712tk: [+0 T:0x8ba0006c S:0x8ba03d14] OM - Memory_alloc> return (0x8fa70790)
[DSP] @3,263,913tk: [+0 T:0x8ba0006c S:0x8ba03d34] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8fa70790)
[DSP] @3,264,001tk: [+0 T:0x8ba0006c S:0x8ba03ec4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x8fa70760)
[DSP] @3,264,076tk: [+4 T:0x8ba0006c S:0x8ba03e84] OT - Thread_create > name: "videnc1_copy#0", pri:  -1, stack size:  11096, stack seg: 0
[DSP] @3,264,309tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 5
[DSP] @3,264,382tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@9,663,076us: [+0 T:0x40acab60 S:0x40aca52c] OP - getCmd_d> Enter (proc=0x40aca5a4)
@10,000,111us: [+0 T:0x40018528 S:0xbefffa04] CE - Engine_fwriteTrace> returning count [2698]
@10,000,388us: [+0 T:0x422f0b60 S:0x422f0154] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@10,000,662us: [+0 T:0x422f0b60 S:0x422f0154] OC - Comm_put> return (0)
@10,000,925us: [+0 T:0x422f0b60 S:0x422f014c] OC - Comm_get> Enter(queue=0x10000, msg=0x422f01e0, timeout=-1)
@10,001,167us: [+0 T:0x422f0b60 S:0x422f014c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @3,265,762tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 1
[DSP] @4,063,762tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @4,063,829tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@10,001,951us: [+0 T:0x422f0b60 S:0x422f0184] CE - Engine_fwriteTrace> returning count [294]
@10,002,193us: [+2 T:0x422f0b60 S:0x422f01f4] CE - Engine_createNode> Returning 0x623d0
@10,002,391us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> Enter(0x4)
@10,002,582us: [+0 T:0x422f0b60 S:0x422f024c] OM - Memory_alloc> return (0x62598)
@10,002,766us: [+0 T:0x422f0b60 S:0x422f0244] OC - Comm_alloc> Enter(poolId=0x0, msg=0x62598, size=2496)
@10,003,003us: [+0 T:0x422f0b60 S:0x422f0244] OC - Comm_alloc> msg=0x446b4880, returning (0)
@10,003,225us: [+5 T:0x422f0b60 S:0x422f0264] CV - VISA_create> remote codec created (name='videnc1_copy', localQueueID=0x10002, remoteQueueID=0x0002)
@10,003,476us: [+0 T:0x422f0b60 S:0x422f036c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x62550)
@10,003,679us: [+2 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] Setting dynParams size 720x480 bitrate 2000000
@10,003,886us: [+2 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] Made XDM_SETPARAMS control call
@10,004,070us: [+0 T:0x422f0b60 S:0x422f0304] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x62550, id=5, params=0x422f04a8 (size=0x3c), status=0x422f03d8 (size=0x9c)
@10,004,335us: [+5 T:0x422f0b60 S:0x422f02cc] CV - VISA_allocMsg> Allocating message for messageId=0x00026cbd
@10,004,542us: [+0 T:0x422f0b60 S:0x422f02ac] CV - VISA_call(visa=0x62550, msg=0x446b4880): messageId=0x00026cbd, command=0x1
@10,004,766us: [+0 T:0x422f0b60 S:0x422f027c] OC - Comm_put> Enter(queue=0x2, msg=0x446b4880)
@10,005,039us: [+0 T:0x422f0b60 S:0x422f027c] OC - Comm_put> return (0)
@10,005,230us: [+0 T:0x422f0b60 S:0x422f0274] OC - Comm_get> Enter(queue=0x10002, msg=0x422f030c, timeout=-1)
@10,005,524us: [+0 T:0x422f0b60 S:0x422f0274] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@10,005,757us: [+0 T:0x422f0b60 S:0x422f01fc] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@10,006,005us: [+0 T:0x422f0b60 S:0x422f01fc] OC - Comm_put> return (0)
@10,006,255us: [+0 T:0x422f0b60 S:0x422f01f4] OC - Comm_get> Enter(queue=0x10000, msg=0x422f0288, timeout=-1)
@10,006,493us: [+0 T:0x422f0b60 S:0x422f01f4] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @4,073,922tk: [+5 T:0x8ba051fc S:0x8ba07d14] CN - NODE> 0x8fa706a0(videnc1_copy#0) call(algHandle=0x8fa70760, msg=0x8fe05880); messageId=0x00026cbd
[DSP] @4,074,036tk: [+0 T:0x8ba051fc S:0x8ba07b6c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fa70760, id=5, params=0x8fe058b4 (size=0x3c),
status=0x8fe058f0 (size=0x9c)
[DSP] @4,074,164tk: [+5 T:0x8ba051fc S:0x8ba07b4c] CV - VISA_enter(visa=0x8fa70760): algHandle = 0x8fa70790
[DSP] @4,074,239tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(handle=0x8fa70790)
[DSP] @4,074,325tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> return
[DSP] @4,074,395tk: [+5 T:0x8ba051fc S:0x8ba07b4c] CV - VISA_exit(visa=0x8fa70760): algHandle = 0x8fa70790
[DSP] @4,074,469tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(handle=0x8fa70790)
[DSP] @4,074,548tk: [+0 T:0x8ba051fc S:0x8ba07b2c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> return
[DSP] @4,074,617tk: [+0 T:0x8ba051fc S:0x8ba07b6c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fa70760, retVal=0xfffffffd)
[DSP] @4,074,712tk: [+5 T:0x8ba051fc S:0x8ba07d14] CN - NODE> returned from call(algHandle=0x8fa70760, msg=0x8fe05880); messageId=0x00026cbd
[DSP] @4,076,168tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @4,076,241tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@10,008,023us: [+0 T:0x40018528 S:0xbefffa74] CE - Engine_open> return(401128)
ctrlFxnFUN: FILE: ../ctrl.c, LINE: 319.
ctrlFxnFUN: FILE: ../ctrl.c, LINE: 335.
@10,351,143us: [+0 T:0x40acab60 S:0x40aca50c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x591c0] timeout[0xffffffff]
@10,351,433us: [+0 T:0x422f0b60 S:0x422f022c] CE - Engine_fwriteTrace> returning count [1490]
@10,351,659us: [+0 T:0x422f0b60 S:0x422f02ac] CV - VISA_call Completed: messageId=0x00026cbd, command=0x1, return(status=-3)
@10,351,900us: [+5 T:0x422f0b60 S:0x422f02bc] CV - VISA_freeMsg(0x62550, 0x446b4880): Freeing message with messageId=0x00026cbd
@10,352,126us: [+0 T:0x422f0b60 S:0x422f0304] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x62550, retVal=0xfffffffd)
@10,352,349us: [+7 T:0x422f0b60 S:0x422f038c] ti.sdo.dmai - [Venc1] XDM_GETBUFINFO control failed
@10,352,532us: [+0 T:0x422f0b60 S:0x422f037c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> Enter (handle=0x62550)
@10,352,764us: [+0 T:0x422f0b60 S:0x422f0354] CV - VISA_delete(0x62550)
@10,352,938us: [+5 T:0x422f0b60 S:0x422f0354] CV - VISA_delete> deleting codec (localQueue=0x10002, remoteQueue=0x2)
@10,353,147us: [+0 T:0x422f0b60 S:0x422f0324] OC - Comm_put> Enter(queue=0x2, msg=0x446b4880)
@10,353,389us: [+0 T:0x422f0b60 S:0x422f0324] OC - Comm_put> return (0)
@10,353,634us: [+0 T:0x422f0b60 S:0x422f031c] OC - Comm_get> Enter(queue=0x10002, msg=0x62598, timeout=-1)
@10,353,871us: [+0 T:0x422f0b60 S:0x422f031c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@10,354,074us: [+0 T:0x422f0b60 S:0x422f030c] CE - Engine_deleteNode(0x623d0)
@10,354,258us: [+0 T:0x422f0b60 S:0x422f02ec] OC - Comm_put> Enter(queue=0x0, msg=0x446b2880)
@10,354,495us: [+0 T:0x422f0b60 S:0x422f02ec] OC - Comm_put> return (0)
@10,354,680us: [+0 T:0x422f0b60 S:0x422f02e4] OC - Comm_get> Enter(queue=0x10000, msg=0x422f0354, timeout=-1)
@10,355,387us: [+0 T:0x422f0b60 S:0x422f02e4] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@10,355,674us: [+5 T:0x422f0b60 S:0x422f030c] CE - Engine_deleteNode(0x623d0): algName = videnc1_copy, algHandle = 0x8fa70760, stack size = 11096, stack used
= 771(7%)
@10,355,947us: [+0 T:0x422f0b60 S:0x422f02f4] OC - Comm_delete> Enter (comm=0x62588)
@10,356,431us: [+0 T:0x422f0b60 S:0x422f02cc] OM - Memory_free> Enter(0x62588, 0x4)
@10,356,676us: [+0 T:0x422f0b60 S:0x422f02cc] OM - Memory_free> return (0x1)
@10,356,867us: [+0 T:0x422f0b60 S:0x422f0304] OC - Comm_delete> return
@10,357,034us: [+0 T:0x422f0b60 S:0x422f02e4] OM - Memory_free> Enter(0x623d0, 0x20)
@10,357,221us: [+0 T:0x422f0b60 S:0x422f02e4] OM - Memory_free> return (0x1)
@10,357,397us: [+0 T:0x422f0b60 S:0x422f033c] OC - Comm_free> Enter (msg=0x446b4880)
@10,357,613us: [+0 T:0x422f0b60 S:0x422f033c] OC - Comm_free> return (0)
@10,357,794us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> Enter(0x62598, 0x4)
@10,357,981us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> return (0x1)
@10,358,151us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> Enter(0x62550, 0x30)
@10,358,377us: [+0 T:0x422f0b60 S:0x422f032c] OM - Memory_free> return (0x1)
@10,358,560us: [+0 T:0x422f0b60 S:0x422f038c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> return