The DVSDK version is DVSDK_1_40_02_33.
And the aac codec is from TI.
The detail trace is as follows.
@0,192,980us: [+4 T:0x40018060 S:0xbefff96c] OG - Global_init> This program was built with the following packages:
@0,193,694us: [+4 T:0x40018060 S:0xbefff96c] OG - package gnu.targets.rts470MV (/home/bh/dvsdk_1_40_02_33/xdctools_3_15_01_59/packages/gnu/targets/rts470MV/) [1, 0, 0, 0]
@0,193,911us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.codecs.aacenc (/home/bh/dvsdk_1_40_02_33/audio_transcode/packages/ti/sdo/codecs/aacenc/) [1, 0, 0]
@0,194,057us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.xdais.dm (/home/bh/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/dm/) [1, 0, 4]
@0,194,256us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.xdais (/home/bh/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/) [1, 2.0, 1]
@0,194,392us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.utils.trace (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/utils/trace/) [1, 0, 0]
@0,194,527us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.utils.xdm (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/xdm/) [1, 0, 1]
@0,194,660us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.fc.dman3 (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dman3/) [1, 0, 3]
@0,194,791us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.fc.acpy3 (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/acpy3/) [1, 0, 2]
@0,194,921us: [+4 T:0x40018060 S:0xbefff96c] OG - package dsplink.gpp (/home/bh/dvsdk_1_40_02_33/dsplink-davinci-v1.50-prebuilt/packages/dsplink/gpp/) [3, 0, 0]
@0,195,054us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.linuxutils.cmem (/home/bh/dvsdk_1_40_02_33/cmem_2_10/packages/ti/sdo/linuxutils/cmem/) [2, 0, 1]
@0,195,188us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.catalog.arm (/home/bh/dvsdk_1_40_02_33/xdctools_3_15_01_59/packages/ti/catalog/arm/) [1, 0, 1, 0]
@0,195,319us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.catalog (/home/bh/dvsdk_1_40_02_33/xdctools_3_15_01_59/packages/ti/catalog/) [1, 0, 0]
@0,195,450us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.catalog.c6000 (/home/bh/dvsdk_1_40_02_33/xdctools_3_15_01_59/packages/ti/catalog/c6000/) [1, 0, 0, 0]
@0,195,582us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.platforms.evmDM6467 (/home/bh/dvsdk_1_40_02_33/bios_5_33_04/packages/ti/platforms/evmDM6467/) [1, 0, 0, 0]
@0,195,714us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.osal (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/) [2, 0, 2]
@0,195,845us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.osal.linux (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
@0,195,979us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.ipc (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/) [2, 0, 1]
@0,196,110us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.ipc.dsplink (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
@0,196,242us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.alg (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/alg/) [1, 0, 1]
@0,196,372us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/) [1, 0, 6]
@0,196,502us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.audio (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/audio/) [1, 0, 2]
@0,196,631us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.codecs.aacenc.ce (/home/bh/dvsdk_1_40_02_33/audio_transcode/packages/ti/sdo/codecs/aacenc/ce/) [1, 0, 0]
@0,196,763us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.bioslog (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
@0,196,893us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.ce.utils.trace (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/trace/) [1, 0, 1]
@0,197,026us: [+4 T:0x40018060 S:0xbefff96c] OG - package ti.sdo.app.audio_app (/home/bh/dvsdk_1_40_02_33/audio_transcode/packages/ti/sdo/app/audio_app/) []
@0,197,300us: [+0 T:0x40018060 S:0xbefff974] OG - Global_atexit> enter (fxn=0x19990)
@0,197,478us: [+0 T:0x40018060 S:0xbefff974] OG - Global_atexit> enter (fxn=0x18e28)
@0,197,703us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> Enter(0x18)
@0,197,880us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> return (0x3e3d0)
@0,198,261us: [+0 T:0x40018060 S:0xbefff964] OG - Global_atexit> enter (fxn=0x17710)
@0,198,502us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> Enter(0x18)
@0,198,664us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> return (0x3e420)
@0,198,804us: [+0 T:0x40018060 S:0xbefff964] OG - Global_atexit> enter (fxn=0x1535c)
@0,199,032us: [+0 T:0x40018060 S:0xbefff96c] OG - Global_atexit> enter (fxn=0x184ac)
@0,199,255us: [+0 T:0x40018060 S:0xbefff954] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,199,406us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_alloc> Enter(0x14)
@0,199,551us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_alloc> return (0x3e4a0)
@0,199,710us: [+0 T:0x40018060 S:0xbefff954] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x3e4a0]
@0,199,856us: [+0 T:0x40018060 S:0xbefff954] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,199,990us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_alloc> Enter(0x14)
@0,200,201us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_alloc> return (0x3e4b8)
@0,200,342us: [+0 T:0x40018060 S:0xbefff954] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x3e4b8]
@0,200,476us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_alloc> Enter(0x18)
@0,200,611us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_alloc> return (0x3e4d0)
@0,200,745us: [+0 T:0x40018060 S:0xbefff93c] OT - Thread_create> Enter (fxn=0x1449c, attrs=0x0)
@0,200,878us: [+0 T:0x40018060 S:0xbefff924] OM - Memory_alloc> Enter(0x64)
@0,201,014us: [+0 T:0x40018060 S:0xbefff924] OM - Memory_alloc> return (0x3e4f0)
@0,201,629us: [+0 T:0x40018060 S:0xbefff93c] OT - Thread_create> Exit (task=0x3e4f0)
@0,201,816us: [+0 T:0x40018060 S:0xbefff974] OG - Global_atexit> enter (fxn=0x1405c)
@0,201,988us: [+0 T:0x40018060 S:0xbefff974] OG - Global_atexit> enter (fxn=0x16150)
@0,202,240us: [+0 T:0x40018060 S:0xbefff95c] ti.sdo.ce.alg - ALG_init> Enter
@0,202,392us: [+0 T:0x40018060 S:0xbefff94c] OG - Global_atexit> enter (fxn=0x135a4)
@0,202,540us: [+0 T:0x40018060 S:0xbefff97c] ti.sdo.ce.alg - ALG_init> Exit
@0,202,676us: [+0 T:0x40018060 S:0xbefff974] OG - Global_atexit> enter (fxn=0x13044)
@0,202,875us: [+0 T:0x40018060 S:0xbefff94c] OM - Memory_alloc> Enter(0x18)
@0,203,033us: [+0 T:0x40018060 S:0xbefff94c] OM - Memory_alloc> return (0x3e688)
@0,203,177us: [+0 T:0x40018060 S:0xbefff974] OG - Global_atexit> enter (fxn=0x18610)
@0,204,965us: [+1 T:0x40ad0b60 S:0x40ad052c] OP - daemon> thread created.
@0,205,196us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - getCmd_d> Enter (proc=0x40ad05a4)
@0,205,349us: [+0 T:0x40ad0b60 S:0x40ad050c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x3e4a0] timeout[0xffffffff]
@0,205,682us: [+6 T:0x40018060 S:0xbefff974] CE - Engine_init> CE debugging on (CE_DEBUG=3; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@0,205,859us: [+0 T:0x40018060 S:0xbefff964] OG - Global_atexit> enter (fxn=0x103c8)
@0,206,012us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> Enter(0x18)
@0,206,163us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> return (0x3e6c8)
@0,206,304us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> Enter(0x18)
@0,206,447us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> return (0x3e6e8)
@0,206,582us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> Enter(0x18)
@0,206,723us: [+0 T:0x40018060 S:0xbefff944] OM - Memory_alloc> return (0x3e708)
@0,206,936us: [+0 T:0x40018060 S:0xbefff974] CS - Server_init()
@0,207,097us: [+0 T:0x40018060 S:0xbefff974] CS - Server_init> Global_useLinkArbiter = 0
@0,207,245us: [+0 T:0x40018060 S:0xbefff974] OG - Global_atexit> enter (fxn=0xef18)
@0,207,482us: [+0 T:0x40018060 S:0xbefff984] OG - Global_atexit> enter (fxn=0xcf14)
APP---------------------->CE Runtime Initialization Done
@0,207,845us: [+0 T:0x40018060 S:0xbefff924] CE - Engine_open> Enter('encodeCombo', 0x0, 0xbefff96c)
@0,208,021us: [+0 T:0x40018060 S:0xbefff90c] OM - Memory_alloc> Enter(0x2c)
@0,208,178us: [+0 T:0x40018060 S:0xbefff90c] OM - Memory_alloc> return (0x3e788)
@0,208,321us: [+0 T:0x40018060 S:0xbefff924] CE - rserverOpen('encodeCombo.x64P'), count = 0
@0,208,462us: [+0 T:0x40018060 S:0xbefff8ec] OP - Processor_create> Enter(imageName='encodeCombo.x64P', linkCfg='(null)', attrs=0xbefff970)
@0,209,442us: [+0 T:0x40018060 S:0xbefff8d4] OM - Memory_alloc> Enter(0x24)
@0,209,638us: [+0 T:0x40018060 S:0xbefff8d4] OM - Memory_alloc> return (0x3e7b8)
@0,209,789us: [+0 T:0x40018060 S:0xbefff8cc] OP - doCmd> Enter (cmdId=1, proc=0x3e7b8)
@0,209,932us: [+0 T:0x40018060 S:0xbefff8bc] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x3e4a0]
@0,210,194us: [+0 T:0x40018060 S:0xbefff8cc] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x3e4a0]
@0,210,359us: [+0 T:0x40018060 S:0xbefff8ac] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x3e4b8] timeout[0xffffffff]
@0,210,551us: [+0 T:0x40ad0b60 S:0x40ad050c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x3e4a0] status[0]
@0,210,716us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - getCmd_d> Exit (result=1)
@0,210,861us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Enter(proc=0x3e7b8)
@0,211,005us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Initializing DSP PROC...
@0,211,159us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'encodeCombo.x64P']
@0,211,309us: [+0 T:0x40ad0b60 S:0x40ad0514] OM - Memory_alloc> Enter(0xe0)
@0,211,462us: [+0 T:0x40ad0b60 S:0x40ad0514] OM - Memory_alloc> return (0x3e7e0)
@0,211,644us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fa00000, sizeInBytes=0x400000, shared=1
@0,211,826us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000, sizeInBytes=0x100000, shared=1
@0,211,992us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESETCTRL', startAddress=0x8ff00000, sizeInBytes=0x80, shared=0
@0,212,153us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x8ba00000, sizeInBytes=0x4000000, shared=0
@0,212,315us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> DOPOWERCONTROL was=0; now=0
@0,218,807us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Attaching to DSP PROC...
@0,227,620us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Opening MSGQ pool...
@0,228,200us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Loading encodeCombo.x64P on DSP (1 args)...
@0,295,540us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Starting DSP PROC...
@0,322,636us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> Opening remote transport...
@0,323,193us: [+2 T:0x40ad0b60 S:0x40ad052c] OP - Processor_create_d> return (1)
@0,323,385us: [+0 T:0x40ad0b60 S:0x40ad051c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x3e4b8]
@0,323,582us: [+0 T:0x40018060 S:0xbefff8ac] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x3e4b8] status[0]
@0,323,748us: [+0 T:0x40018060 S:0xbefff8cc] OP - doCmd> Exit (result=1)
@0,323,887us: [+0 T:0x40018060 S:0xbefff8ec] OP - Processor_create> return (0x3e7b8)
@0,324,026us: [+0 T:0x40018060 S:0xbefff924] CE - rserverOpen('encodeCombo.x64P'): 0x3d3e8 done.
@0,324,179us: [+0 T:0x40018060 S:0xbefff90c] OM - Memory_alloc> Enter(0x1f)
@0,324,326us: [+0 T:0x40018060 S:0xbefff90c] OM - Memory_alloc> return (0x3e998)
@0,324,580us: [+0 T:0x40018060 S:0xbefff8fc] OC - Comm_create> Enter(queueName='encodeCombo_0', queue=0x3e798, attrs=0x0)
@0,324,747us: [+0 T:0x40018060 S:0xbefff8e4] OM - Memory_alloc> Enter(0x4)
@0,324,896us: [+0 T:0x40018060 S:0xbefff8e4] OM - Memory_alloc> return (0x3e9c0)
@0,325,326us: [+0 T:0x40018060 S:0xbefff8fc] OC - Comm_create> return (0x3e9c0)
@0,325,565us: [+0 T:0x40018060 S:0xbefff8fc] OM - Memory_free> Enter(0x3e998, 0x1f)
@0,325,775us: [+0 T:0x40018060 S:0xbefff8fc] OM - Memory_free> return (0x1)
@0,325,934us: [+0 T:0x40018060 S:0xbefff904] OC - Comm_alloc> Enter(poolId=0x0, msg=0x3e7a4, size=576)
@0,326,123us: [+0 T:0x40018060 S:0xbefff904] OC - Comm_alloc> msg=0x412df880, returning (0)
@0,326,275us: [+0 T:0x40018060 S:0xbefff8e4] OC - Comm_locate> Enter(queueName='rmsq', queue=0x3e794)
@0,332,201us: [+0 T:0x40018060 S:0xbefff8e4] OC - Comm_locate> return (0)
@0,332,390us: [+0 T:0x40018060 S:0xbefff924] CE - checkServer(0x3e788)
@0,332,560us: [+0 T:0x40018060 S:0xbefff8f4] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,332,763us: [+0 T:0x40018060 S:0xbefff8f4] OC - Comm_put> return (0)
@0,332,981us: [+0 T:0x40018060 S:0xbefff8ec] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff968, timeout=-1)
@0,333,161us: [+0 T:0x40018060 S:0xbefff8ec] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@0,333,323us: [+0 T:0x40018060 S:0xbefff924] CE - rmsInit> RMS initialized(0x3e788); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3
@0,333,480us: [+0 T:0x40018060 S:0xbefff8f4] CE - Engine_setTrace> Enter(engine=0x3e788, mask='*+01234567,GT_prefix=12345,GT_time=3')
@0,333,650us: [+1 T:0x40018060 S:0xbefff8f4] CE - Engine_setTrace> Requesting DSP set trace ...
@0,333,787us: [+0 T:0x40018060 S:0xbefff8c4] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,333,972us: [+0 T:0x40018060 S:0xbefff8c4] OC - Comm_put> return (0)
@0,334,123us: [+0 T:0x40018060 S:0xbefff8bc] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff92c, timeout=-1)
@0,334,311us: [+0 T:0x40ad0b60 S:0x40ad052c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x3e4b8]
@0,334,473us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - getCmd_d> Enter (proc=0x40ad05a4)
@0,334,618us: [+0 T:0x40ad0b60 S:0x40ad050c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x3e4a0] timeout[0xffffffff]
@0,335,693us: [+0 T:0x40018060 S:0xbefff8bc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@0,335,867us: [+0 T:0x40018060 S:0xbefff8f4] CE - Engine_setTrace> return(0)
@0,336,039us: [+0 T:0x40018060 S:0xbefff884] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,336,237us: [+0 T:0x40018060 S:0xbefff884] OC - Comm_put> return (0)
@0,336,444us: [+0 T:0x40018060 S:0xbefff87c] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff910, timeout=-1)
@0,336,627us: [+0 T:0x40018060 S:0xbefff87c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @0,026,479tk: [+0 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3')
[DSP] @0,026,588tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,026,664tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.targets.rts6000 (/home/bh/dvsdk_1_40_02_33/xdctools_3_15_01_59/packages/ti/targets/rts6000/) [1, 0, 0, 0]
[DSP] @0,026,762tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.codecs.aacenc (/home/bh/dvsdk_1_40_02_33/audio_transcode/packages/ti/sdo/codecs/aacenc/) [1, 0, 0]
[DSP] @0,026,858tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.ires.hdvicp (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/hdvicp/) [1, 0, 0]
[DSP] @0,026,961tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.hdintc (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/hdintc/) [1, 0, 3]
[DSP] @0,027,060tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.edma3.rm (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/fctools/packages/ti/sdo/edma3/rm/) [1, 03, 02]
[DSP] @0,027,162tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.utils.trace (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/utils/trace/) [1, 0, 0]
[DSP] @0,027,262tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.ires.nullresource (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/nullresource/) [1, 0, 0]
[DSP] @0,027,372tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.rtdx (/home/bh/dvsdk_1_40_02_33/bios_5_33_04/packages/ti/rtdx/) [2, 0, 0, 4]
[DSP] @0,027,455tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.psl (/home/bh/dvsdk_1_40_02_33/bios_5_33_04/packages/ti/psl/) [5, 0, 0, 0]
[DSP] @0,027,538tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.bios (/home/bh/dvsdk_1_40_02_33/bios_5_33_04/packages/ti/bios/) [5, 2, 5, 9]
[DSP] @0,027,621tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.dskt2 (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
[DSP] @0,027,719tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.rman (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/rman/) [2, 0, 0]
[DSP] @0,027,815tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.edma3 (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/edma3/) [2, 0, 0]
[DSP] @0,027,913tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.ires.edma3chan (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/ires/edma3chan/) [1, 0, 0]
[DSP] @0,028,019tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.xdais.dm (/home/bh/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/dm/) [1, 0, 4]
[DSP] @0,028,105tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.xdais (/home/bh/dvsdk_1_40_02_33/xdais_6_10_01/packages/ti/xdais/) [1, 2.0, 1]
[DSP] @0,028,190tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.node (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/node/) [1, 0, 0]
[DSP] @0,028,282tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.ipc.dsplink.dsp (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2, 0, 1]
[DSP] @0,028,398tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.utils.xdm (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/utils/xdm/) [1, 0, 1]
[DSP] @0,028,495tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.dman3 (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/dman3/) [1, 0, 3]
[DSP] @0,028,593tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.fc.acpy3 (/home/bh/dvsdk_1_40_02_33/framework_components_2_10_02/packages/ti/sdo/fc/acpy3/) [1, 0, 2]
[DSP] @0,028,690tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package dsplink.dsp (/home/bh/dvsdk_1_40_02_33/dsplink-davinci-v1.50-prebuilt/packages/dsplink/dsp/) [1, 3, 0]
[DSP] @0,028,785tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.bios.utils (/home/bh/dvsdk_1_4@0,342,286us: [+0 T:0x40018060 S:0xbefff884] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,342,501us: [+0 T:0x40018060 S:0xbefff884] OC - Comm_put> return (0)
@0,342,718us: [+0 T:0x40018060 S:0xbefff87c] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff910, timeout=-1)
@0,342,899us: [+0 T:0x40018060 S:0xbefff87c] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
0_02_33/biosutils_1_01_00/packages/ti/bios/utils/) [2, 0, 1, 00]
[DSP] @0,028,877tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.catalog.c6000 (/home/bh/dvsdk_1_40_02_33/xdctools_3_15_01_59/packages/ti/catalog/c6000/) [1, 0, 0, 0]
[DSP] @0,028,972tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.catalog (/home/bh/dvsdk_1_40_02_33/xdctools_3_15_01_59/packages/ti/catalog/) [1, 0, 0]
[DSP] @0,029,061tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.platforms.evmDM6467 (/home/bh/dvsdk_1_40_02_33/bios_5_33_04/packages/ti/platforms/evmDM6467/) [1, 0, 0, 0]
[DSP] @0,029,158tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.osal (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/) [2, 0, 2]
[DSP] @0,029,251tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.osal.bios (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
[DSP] @0,029,348tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.ipc (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/) [2, 0, 1]
[DSP] @0,029,440tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.ipc.bios (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
[DSP] @0,029,536tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.alg (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/alg/) [1, 0, 1]
[DSP] @0,029,628tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/) [1, 0, 6]
[DSP] @0,029,716tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.bioslog (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
[DSP] @0,029,811tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.ce.audio (/home/bh/dvsdk_1_40_02_33/codec_engine_2_10_02/packages/ti/sdo/ce/audio/) [1, 0, 2]
[DSP] @0,029,905tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.codecs.aacenc.ce (/home/bh/dvsdk_1_40_02_33/audio_transcode/packages/ti/sdo/codecs/aacenc/ce/) [1, 0, 0]
[DSP] @0,030,004tk: [+4 T:0x8ba0006c S:0x8ba03fdc] OG - package ti.sdo.servers.encode (/home/bh/dvsdk_1_40_02_33/audio_transcode/packages/ti/sdo/servers/encode/) []
[DSP] @0,030,097tk: [+0 T:0x8ba0006c S:0x8ba03fdc] OG - Global_setSpecialTrace> return
[DSP] @0,031,701tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,031,767tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,046,222tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,046,286tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@0,346,625us: [+0 T:0x40018060 S:0xbefff8b4] CE - Engine_fwriteTrace> returning count [6934]
@0,346,776us: [+0 T:0x40018060 S:0xbefff924] CE - Engine_open> return(255880)
APP---------------------->Engine opened successfully
@0,347,045us: [+0 T:0x40018060 S:0xbefff974] ti.sdo.ce.audio.AUDENC - AUDENC_create> Enter (engine=0x3e788, name='aacenc', params=0xbefffb70)
@0,347,252us: [+0 T:0x40018060 S:0xbefff944] CV - VISA_create(0x3e788, 'aacenc', 0xbefffb70, 0x572, 'ti.sdo.ce.audio.IAUDENC')
@0,347,417us: [+0 T:0x40018060 S:0xbefff86c] CV - VISA_create2(0x3e788, 'aacenc', 0xbefffb70, 0x4c, 0x572, 'ti.sdo.ce.audio.IAUDENC')
@0,347,632us: [+0 T:0x40018060 S:0xbefff854] OM - Memory_alloc> Enter(0x30)
@0,347,792us: [+0 T:0x40018060 S:0xbefff854] OM - Memory_alloc> return (0x3ea20)
@0,347,938us: [+0 T:0x40018060 S:0xbefff7fc] CE - Engine_createNode(0x3e788, 'aacenc', 572, 0xbefffb70, 0x4c, 0xbefff970)
@0,348,092us: [+0 T:0x40018060 S:0xbefff7e4] OM - Memory_alloc> Enter(0x20)
@0,348,236us: [+0 T:0x40018060 S:0xbefff7e4] OM - Memory_alloc> return (0x3e998)
@0,348,395us: [+0 T:0x40018060 S:0xbefff7d4] OC - Comm_create> Enter(queueName='gppfromnode_1', queue=0x3e9a0, attrs=0x0)
@0,348,541us: [+0 T:0x40018060 S:0xbefff7bc] OM - Memory_alloc> Enter(0x4)
@0,348,685us: [+0 T:0x40018060 S:0xbefff7bc] OM - Memory_alloc> return (0x3ea58)
@0,349,122us: [+0 T:0x40018060 S:0xbefff7d4] OC - Comm_create> return (0x3ea58)
@0,349,319us: [+0 T:0x40018060 S:0xbefff7dc] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,349,526us: [+0 T:0x40018060 S:0xbefff7dc] OC - Comm_put> return (0)
@0,349,680us: [+0 T:0x40018060 S:0xbefff7d4] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff854, timeout=-1)
@0,355,854us: [+0 T:0x40018060 S:0xbefff7d4] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
@0,356,038us: [+0 T:0x40018060 S:0xbefff7e4] OC - Comm_delete> Enter (comm=0x3ea58)
@0,356,454us: [+0 T:0x40018060 S:0xbefff7bc] OM - Memory_free> Enter(0x3ea58, 0x4)
@0,356,654us: [+0 T:0x40018060 S:0xbefff7bc] OM - Memory_free> return (0x1)
@0,356,800us: [+0 T:0x40018060 S:0xbefff7f4] OC - Comm_delete> return
@0,356,932us: [+0 T:0x40018060 S:0xbefff7d4] OM - Memory_free> Enter(0x3e998, 0x20)
@0,357,074us: [+0 T:0x40018060 S:0xbefff7d4] OM - Memory_free> return (0x1)
@0,357,209us: [+6 T:0x40018060 S:0xbefff7fc] CE - Engine_createNode> Remote node creation FAILED (0x80008008).
@0,357,365us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,357,615us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> return (0)
@0,357,837us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff7e8, timeout=-1)
@0,358,023us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @0,062,525tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 0
[DSP] @0,062,597tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,062,661tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fab2b00)
[DSP] @0,062,719tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0x9)
[DSP] @0,062,774tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fab2b18)
[DSP] @0,062,837tk: [+0 T:0x8ba0006c S:0x8ba03edc] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,062,893tk: [+0 T:0x8ba0006c S:0x8ba03edc] OM - Memory_alloc> return (0x8fab2b28)
[DSP] @0,062,953tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,063,009tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_alloc> return (0x8fab2b48)
[DSP] @0,063,091tk: [+0 T:0x8ba0006c S:0x8ba03ec4] ti.sdo.ce.audio.AUDENC - AUDENC_create> Enter (engine=0x0, name='aacenc', params=0x8fe038c0)
[DSP] @0,063,198tk: [+0 T:0x8ba0006c S:0x8ba03e8c] CV - VISA_create(0x0, 'aacenc', 0x8fe038c0, 0x572, 'ti.sdo.ce.audio.IAUDENC')
[DSP] @0,063,280tk: [+0 T:0x8ba0006c S:0x8ba03d7c] CV - VISA_create2(0x0, 'aacenc', 0x8fe038c0, 0x4c, 0x572, 'ti.sdo.ce.audio.IAUDENC')
[DSP] @0,063,375tk: [+0 T:0x8ba0006c S:0x8ba03d14] CE - Engine_open> Enter('local', 0x8ba03d6c, 0x23c)
[DSP] @0,063,445tk: [+0 T:0x8ba0006c S:0x8ba03cf4] OM - Memory_alloc> Enter(size=0x2c)
[DSP] @0,063,501tk: [+0 T:0x8ba0006c S:0x8ba03cf4] OM - Memory_alloc> return (0x8fab2bb0)
[DSP] @0,063,566tk: [+0 T:0x8ba0006c S:0x8ba03d14] CE - Engine_open> return(-1884607568)
[DSP] @0,063,633tk: [+0 T:0x8ba0006c S:0x8ba03d5c] OM - Memory_alloc> Enter(size=0x30)
[DSP] @0,063,690tk: [+0 T:0x8ba0006c S:0x8ba03d5c] OM - Memory_alloc> return (0x8fab2be0)
[DSP] @0,063,753tk: [+0 T:0x8ba0006c S:0x8ba03d34] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fab16e4, idma3Fxns=0x0, params=0x8fe038c0, attrs=0x8ba03e80)
[DSP] @0,063,857tk: [+0 T:0x8ba0006c S:0x8ba03d14] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,063,912tk: [+0 T:0x8ba0006c S:0x8ba03d14] OM - Memory_alloc> return (0x8fab2c10)
[DSP] @0,063,990tk: [+0 T:0x8ba0006c S:0x8ba03cf4] ti.sdo.fc.dskt2 - _DSKT2_init> Enter
[DSP] @0,064,068tk: [+0 T:0x8ba0006c S:0x8ba03cf4] ti.sdo.fc.dskt2 - _DSKT2_init> Exit
[DSP] @0,064,123tk: [+0 T:0x8ba0006c S:0x8ba03d04] ti.sdo.fc.dskt2 - DSKT2_createAlg> Enter (scratchId=1, fxns=0x8fab16e4, parentAlg=0x0, params=0x8fe038c0)
[DSP] @0,064,222tk: [+0 T:0x8ba0006c S:0x8ba03c8c] ti.sdo.fc.dskt2 - _DSKT2_init> Enter
[DSP] @0,064,276tk: [+0 T:0x8ba0006c S:0x8ba03c8c] ti.sdo.fc.dskt2 - _DSKT2_init> Exit
[DSP] @0,064,330tk: [+0 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Enter (scratchId=1, fxns=0x8fab16e4, parentAlg=0x0, params=0x8fe038c0, extHeapId=-1881130816, singleHeap=1)
[DSP] @0,064,449tk: [+2 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> DSKT2_AlgAttrs extHeapId -1 and singleHeap 0
[DSP] @0,064,533tk: [+2 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Num memory recs requested 9
[DSP] @0,064,605tk: [+2 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> memTab allocated at 0x8fab2fb0 size=0xb4
[DSP] @0,064,686tk: [+2 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Num memory recs requested 9
[DSP] @0,064,758tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[0]: size=0x125f0, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,064,859tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[1]: size=0x800, align=0x4, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,064,957tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[2]: size=0x2910, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,065,056tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[3]: size=0x2bb8, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,065,154tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[4]: size=0x53f8, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,065,253tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested@0,363,907us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,364,116us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> return (0)
@0,364,326us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff7e8, timeout=-1)
@0,364,512us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
memTab[5]: size=0x11f8, align=0x4, space=IALG_EXTERNAL, attrs=IALG_SCRATCH
[DSP] @0,065,352tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[6]: size=0x23e8, align=0x8, space=IALG_EXTERNAL, attrs=IALG_SCRATCH
[DSP] @0,065,451tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[7]: size=0x10a44, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,065,565tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[8]: size=0xc05c, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,065,663tk: [+6 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Scratch Memory requested by algorithm, but algActivate, algDeactivate functions not implemented.
[DSP] @0,065,764tk: [+0 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> Enter (scratchId=1, numRecs=9, extHeapId=0)
[DSP] @0,065,848tk: [+0 T:0x8ba0006c S:0x8ba03c3c] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Enter (numRecs=9)
[DSP] @0,065,918tk: [+0 T:0x8ba0006c S:0x8ba03c3c] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Exit (returnVal=0)
[DSP] @0,065,993tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=0, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,066,799tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,066,873tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[0] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba051e8
[DSP] @0,066,981tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=1, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,067,094tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,067,165tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[1] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba177d8
[DSP] @0,067,271tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=2, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,067,473tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,067,545tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[2] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba17fd8
[DSP] @0,067,650tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=3, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,067,873tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,067,948tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[3] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba1a8e8
[DSP] @0,068,055tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=4, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,068,367tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,068,438tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[4] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba1d4a0
[DSP] @0,068,547tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=5, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,068,688tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,068,759tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[5] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba22898
[DSP] @0,068,865tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=6, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,069,051tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedS@0,370,085us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,370,300us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> return (0)
@0,370,512us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff7e8, timeout=-1)
@0,370,698us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
pace> Exit (returnVal=1)
[DSP] @0,069,122tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[6] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba23a90
[DSP] @0,069,228tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=7, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,070,055tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,070,156tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[7] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba25e78
[DSP] @0,070,264tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=8, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,070,874tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,070,947tk: [+2 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[8] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba368c0
[DSP] @0,071,057tk: [+0 T:0x8ba0006c S:0x8ba03c3c] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Enter (numRecs=9)
[DSP] @0,071,126tk: [+0 T:0x8ba0006c S:0x8ba03c3c] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Exit (returnVal=0)
[DSP] @0,071,194tk: [+0 T:0x8ba0006c S:0x8ba03c5c] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> Exit (returnVal=1)
[DSP] @0,071,269tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[0]: base=0x8ba051e8, size=0x125f0, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,071,380tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[1]: base=0x8ba177d8, size=0x800, align=0x4, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,071,489tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[2]: base=0x8ba17fd8, size=0x2910, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,071,599tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[3]: base=0x8ba1a8e8, size=0x2bb8, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,071,709tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[4]: base=0x8ba1d4a0, size=0x53f8, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,071,818tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[5]: base=0x8ba22898, size=0x11f8, align=0x4, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,071,928tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[6]: base=0x8ba23a90, size=0x23e8, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,072,038tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[7]: base=0x8ba25e78, size=0x10a44, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,072,148tk: [+4 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[8]: base=0x8ba368c0, size=0xc05c, align=0x8, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,072,263tk: [+0 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_enqueueMemTab> Enter (segId=1, memTabSize=180, numRecs=9, extHeapId=0)
[DSP] @0,072,377tk: [+0 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_enqueueMemTab> Exit (status=TRUE)
[DSP] @0,072,882tk: [+7 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> algInit call failed -1
[DSP] @0,072,957tk: [+0 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Enter (scratchMutexId=1, alg=0x8ba051e8)
[DSP] @0,073,037tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Dequeue alg information
[DSP] @0,073,102tk: [+0 T:0x8ba0006c S:0x8ba03c2c] ti.sdo.fc.dskt2 - _DSKT2_dequeueMemTab> Enter (segId=1, alg=0x8ba051e8)
[DSP] @0,073,187tk: [+0 T:0x8ba0006c S:0x8ba03c2c] ti.sdo.fc.dskt2 - _DSKT2_dequeueMemTab> Exit (memTab=0x8fab2fb0)
[DSP] @0,073,261tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Dequeued alg information, memTab 0x8fab2fb0 memTabSize 180, numRecs 9, extHeapI@0,376,227us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,376,427us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> return (0)
@0,376,636us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff7e8, timeout=-1)
@0,376,821us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
d 0
[DSP] @0,073,359tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Free instance memory
[DSP] @0,073,423tk: [+0 T:0x8ba0006c S:0x8ba03c3c] ti.sdo.fc.dskt2 - _DSKT2_freeInstanceMemory> Enter (scratchMutexId=1, numRecs=9, extHeapId=0)
[DSP] @0,073,507tk: [+0 T:0x8ba0006c S:0x8ba03c0c] ti.sdo.fc.dskt2 - _DSKT2_freeAllocatedMemory> Enter (scratchMutexId=1, number=9, extHeapId=0)
[DSP] @0,073,592tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba051e8)
[DSP] @0,073,679tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,073,747tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba177d8)
[DSP] @0,073,830tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,073,897tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba17fd8)
[DSP] @0,073,980tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,074,048tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba1a8e8)
[DSP] @0,074,130tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,074,198tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba1d4a0)
[DSP] @0,074,281tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,074,349tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba22898)
[DSP] @0,074,432tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,074,499tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba23a90)
[DSP] @0,074,582tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,074,650tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba25e78)
[DSP] @0,074,732tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,074,806tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=1, addr=0x8ba368c0)
[DSP] @0,074,889tk: [+0 T:0x8ba0006c S:0x8ba03bec] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,074,958tk: [+0 T:0x8ba0006c S:0x8ba03c0c] ti.sdo.fc.dskt2 - _DSKT2_freeAllocatedMemory> Exit (returnVal=1)
[DSP] @0,075,026tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Enter (numRecs=9)
[DSP] @0,075,095tk: [+0 T:0x8ba0006c S:0x8ba03c1c] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Exit (returnVal=0)
[DSP] @0,075,163tk: [+0 T:0x8ba0006c S:0x8ba03c3c] ti.sdo.fc.dskt2 - _DSKT2_freeInstanceMemory> Exit (returnVal=1)
[DSP] @0,075,232tk: [+0 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Exit
[DSP] @0,075,287tk: [+0 T:0x8ba0006c S:0x8ba03c9c] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Exit (algHandle=NULL)
[DSP] @0,075,354tk: [+0 T:0x8ba0006c S:0x8ba03d04] ti.sdo.fc.dskt2 - DSKT2_createAlg> Exit (algHandle=0x0)
[DSP] @0,075,421tk: [+7 T:0x8ba0006c S:0x8ba03d34] ti.sdo.ce.alg.Algorithm - Algorithm_create> Algorithm creation FAILED; make sure that 1) alg params are correct/appropriate, 2) there is enough internal and external algorithm memory available -- check DSKT2 settings for heap assignments and scratch allocation
[DSP] @0,075,584tk: [+0 T:0x8ba0006c S:0x8ba03d14] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(handle=0x8fab2c10)
[DSP] @0,075,660tk: [+0 T:0x8ba0006c S:0x8ba03ce4] OM - Memory_free> Enter(addr=0x8fab2c10, size=16)
[DSP] @0,075,726tk: [+0 T:0x8ba0006c S:0x8ba03ce4] OM - Memory_free> return (0x1)
[DSP] @0,075,778tk: [+0 T:0x8ba0006c S:0x8ba03d14] ti.sdo.ce.alg.Algorithm - Algorithm_delete> return
[DSP] @0,075,841tk: [+0 T:0x8ba0006c S:0x8ba03d34] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x0)
[DSP] @0,0@0,382,656us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,382,860us: [+0 T:0x40018060 S:0xbefff75c] OC - Comm_put> return (0)
@0,383,072us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff7e8, timeout=-1)
@0,383,257us: [+0 T:0x40018060 S:0xbefff754] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
75,906tk: [+2 T:0x8ba0006c S:0x8ba03d7c] CV - VISA_create> FAILED to create local codec.
[DSP] @0,075,968tk: [+0 T:0x8ba0006c S:0x8ba03d4c] CV - VISA_delete(0x8fab2be0)
[DSP] @0,076,023tk: [+5 T:0x8ba0006c S:0x8ba03d4c] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
[DSP] @0,076,099tk: [+0 T:0x8ba0006c S:0x8ba03d1c] OM - Memory_free> Enter(addr=0x8fab2be0, size=48)
[DSP] @0,076,164tk: [+0 T:0x8ba0006c S:0x8ba03d1c] OM - Memory_free> return (0x1)
[DSP] @0,076,217tk: [+0 T:0x8ba0006c S:0x8ba03ec4] ti.sdo.ce.audio.AUDENC - AUDENC_create> return (0x0)
[DSP] @0,076,289tk: [+0 T:0x8ba0006c S:0x8ba03eb4] ti.sdo.ce.audio.AUDENC - AUDENC_delete> Enter (handle=0x0)
[DSP] @0,076,357tk: [+0 T:0x8ba0006c S:0x8ba03e84] CV - VISA_delete(0x0)
[DSP] @0,076,404tk: [+0 T:0x8ba0006c S:0x8ba03eb4] ti.sdo.ce.audio.AUDENC - AUDENC_delete> return
[DSP] @0,076,467tk: [+0 T:0x8ba0006c S:0x8ba03e9c] OM - Memory_free> Enter(addr=0x8fab2b48, size=36)
[DSP] @0,076,533tk: [+0 T:0x8ba0006c S:0x8ba03e9c] OM - Memory_free> return (0x1)
[DSP] @0,076,585tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_free> Enter(addr=0x8fab2b28, size=32)
[DSP] @0,076,650tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_free> return (0x1)
[DSP] @0,076,706tk: [+0 T:0x8ba0006c S:0x8ba03f24] OM - Memory_free> Enter(addr=0x8fab2b18, size=9)
[DSP] @0,076,770tk: [+0 T:0x8ba0006c S:0x8ba03f24] OM - Memory_free> return (0x1)
[DSP] @0,076,822tk: [+0 T:0x8ba0006c S:0x8ba03f24] OM - Memory_free> Enter(addr=0x8fab2b00, size=24)
[DSP] @0,076,888tk: [+0 T:0x8ba0006c S:0x8ba03f24] OM - Memory_free> return (0x1)
[DSP] @0,081,309tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,081,374tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,096,379tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,096,442tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,110,728tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,110,792tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,124,946tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,125,010tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,139,873tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,139,937tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@0,386,956us: [+0 T:0x40018060 S:0xbefff78c] CE - Engine_fwriteTrace> returning count [19461]
@0,387,108us: [+2 T:0x40018060 S:0xbefff7fc] CE - Engine_createNode> Returning 0x0
@0,387,248us: [+2 T:0x40018060 S:0xbefff86c] CV - VISA_create> FAILED to create remote codec (0x8).
@0,387,388us: [+0 T:0x40018060 S:0xbefff844] CV - VISA_delete(0x3ea20)
@0,387,522us: [+5 T:0x40018060 S:0xbefff844] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
@0,387,662us: [+0 T:0x40018060 S:0xbefff81c] OM - Memory_free> Enter(0x3ea20, 0x30)
@0,387,803us: [+0 T:0x40018060 S:0xbefff81c] OM - Memory_free> return (0x1)
@0,387,937us: [+0 T:0x40018060 S:0xbefff974] ti.sdo.ce.audio.AUDENC - AUDENC_create> return (0x0)
Fail in aacenc Instance Creation
Close Codec Engine!
@0,388,159us: [+0 T:0x40018060 S:0xbefff974] CE - Engine_close(0x3e788)
@0,388,316us: [+0 T:0x40018060 S:0xbefff8d4] OC - Comm_put> Enter(queue=0x0, msg=0x412df880)
@0,388,507us: [+0 T:0x40018060 S:0xbefff8d4] OC - Comm_put> return (0)
@0,388,721us: [+0 T:0x40018060 S:0xbefff8cc] OC - Comm_get> Enter(queue=0x10000, msg=0xbefff960, timeout=-1)
@0,388,900us: [+0 T:0x40018060 S:0xbefff8cc] OC - Comm_get> MSGQ_Get() status=0x8000, return (0)
[DSP] @0,152,976tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,153,040tk: [+0 T:0x8ba0006c S:0x8ba04024] CR - remote time = 0x0, trace buffer size = 4032
@0,389,338us: [+0 T:0x40018060 S:0xbefff904] CE - Engine_fwriteTrace> returning count [197]
@0,389,488us: [+0 T:0x40018060 S:0xbefff95c] OC - Comm_free> Enter (msg=0x412df880)
@0,389,662us: [+0 T:0x40018060 S:0xbefff95c] OC - Comm_free> return (0)
@0,389,807us: [+0 T:0x40018060 S:0xbefff964] OC - Comm_delete> Enter (comm=0x3e9c0)
@0,390,276us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_free> Enter(0x3e9c0, 0x4)
@0,390,472us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_free> return (0x1)
@0,390,621us: [+0 T:0x40018060 S:0xbefff974] OC - Comm_delete> return
@0,390,754us: [+0 T:0x40018060 S:0xbefff95c] OC - Comm_release> Enter(queue=0x0)
@0,390,913us: [+0 T:0x40018060 S:0xbefff95c] OC - Comm_release> return (0)
@0,391,059us: [+0 T:0x40018060 S:0xbefff974] CE - rserverClose(0x3d3e8), count = 1
@0,391,204us: [+0 T:0x40018060 S:0xbefff964] OP - Processor_delete> Enter(proc=0x3e7b8)
@0,391,345us: [+0 T:0x40018060 S:0xbefff944] OP - doCmd> Enter (cmdId=2, proc=0x3e7b8)
@0,391,484us: [+0 T:0x40018060 S:0xbefff934] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x3e4a0]
@0,391,647us: [+0 T:0x40018060 S:0xbefff944] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x3e4a0]
@0,391,791us: [+0 T:0x40018060 S:0xbefff924] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x3e4b8] timeout[0xffffffff]
@0,391,975us: [+0 T:0x40ad0b60 S:0x40ad050c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x3e4a0] status[0]
@0,392,140us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - getCmd_d> Exit (result=2)
@0,392,286us: [+0 T:0x40ad0b60 S:0x40ad050c] OP - Processor_delete_d> Enter (proc=0x3e7b8)
@0,392,429us: [+2 T:0x40ad0b60 S:0x40ad050c] OP - Processor_delete_d> Closing remote transport...
@0,392,843us: [+2 T:0x40ad0b60 S:0x40ad050c] OP - Processor_delete_d> Stopping DSP...
@0,393,270us: [+2 T:0x40ad0b60 S:0x40ad050c] OP - Processor_delete_d> Closing pool...
@0,393,854us: [+2 T:0x40ad0b60 S:0x40ad050c] OP - Processor_delete_d> Detaching from DSP...
@0,403,599us: [+2 T:0x40ad0b60 S:0x40ad050c] OP - Processor_delete_d> Destroying DSP... (object, that is)
@0,404,774us: [+0 T:0x40ad0b60 S:0x40ad04e4] OM - Memory_free> Enter(0x3e7e0, 0x0)
@0,404,976us: [+0 T:0x40ad0b60 S:0x40ad04e4] OM - Memory_free> return (0x1)
@0,405,126us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - Processor_delete_d> return
@0,405,269us: [+0 T:0x40ad0b60 S:0x40ad051c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x3e4b8]
@0,405,455us: [+0 T:0x40018060 S:0xbefff924] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x3e4b8] status[0]
@0,405,617us: [+0 T:0x40018060 S:0xbefff944] OP - doCmd> Exit (result=1)
@0,405,755us: [+1 T:0x40018060 S:0xbefff964] OP - Processor_delete(0x3e7b8) freeing object ...
@0,405,891us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_free> Enter(0x3e7b8, 0x24)
@0,406,033us: [+0 T:0x40018060 S:0xbefff93c] OM - Memory_free> return (0x1)
@0,406,167us: [+0 T:0x40018060 S:0xbefff974] OP - Processor_delete> return.
@0,406,295us: [+0 T:0x40018060 S:0xbefff974] CE - rserverClose(0x3d3e8) done.
@0,406,431us: [+0 T:0x40018060 S:0xbefff96c] OM - Memory_free> Enter(0x3e788, 0x2c)
@0,406,570us: [+0 T:0x40018060 S:0xbefff96c] OM - Memory_free> return (0x1)
Close In File!
Close Out File!
@0,407,161us: [+0 T:0x40ad0b60 S:0x40ad052c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x3e4b8]
@0,407,352us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - getCmd_d> Enter (proc=0x40ad05a4)
@0,407,504us: [+0 T:0x40ad0b60 S:0x40ad050c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x3e4a0] timeout[0xffffffff]
@0,640,509us: [+0 T:0x40018060 S:0xbefffc4c] OG - Global_exit> enter
@0,640,688us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0xcf14()...
@0,640,859us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0xef18()...
@0,641,009us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x103c8()...
@0,641,179us: [+0 T:0x40018060 S:0xbefffc14] OM - Memory_free> Enter(0x3e6c8, 0x18)
@0,641,337us: [+0 T:0x40018060 S:0xbefffc14] OM - Memory_free> return (0x1)
@0,641,478us: [+0 T:0x40018060 S:0xbefffc14] OM - Memory_free> Enter(0x3e6e8, 0x18)
@0,641,618us: [+0 T:0x40018060 S:0xbefffc14] OM - Memory_free> return (0x1)
@0,641,749us: [+0 T:0x40018060 S:0xbefffc14] OM - Memory_free> Enter(0x3e708, 0x18)
@0,641,886us: [+0 T:0x40018060 S:0xbefffc14] OM - Memory_free> return (0x1)
@0,642,021us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x18610()...
@0,642,158us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x13044()...
@0,642,295us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x135a4()...
@0,642,430us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x16150()...
@0,642,565us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x1405c()...
@0,642,703us: [+0 T:0x40018060 S:0xbefffc14] OP - doCmd> Enter (cmdId=3, proc=0x0)
@0,642,839us: [+0 T:0x40018060 S:0xbefffc04] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x3e4a0]
@0,643,000us: [+0 T:0x40018060 S:0xbefffc14] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x3e4a0]
@0,643,147us: [+0 T:0x40018060 S:0xbefffbf4] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x3e4b8] timeout[0xffffffff]
@0,643,333us: [+0 T:0x40ad0b60 S:0x40ad050c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x3e4a0] status[0]
@0,643,498us: [+0 T:0x40ad0b60 S:0x40ad052c] OP - getCmd_d> Exit (result=3)
@0,643,643us: [+0 T:0x40ad0b60 S:0x40ad051c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x3e4b8]
@0,643,801us: [+0 T:0x40ad0b60 S:0x40ad052c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x3e4b8]
@0,644,069us: [+0 T:0x40018060 S:0xbefffbf4] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x3e4b8] status[0]
@0,644,244us: [+0 T:0x40018060 S:0xbefffc14] OP - doCmd> Exit (result=1)
@0,644,386us: [+0 T:0x40018060 S:0xbefffc1c] OT - Thread_delete> Enter (task=0x3e4f0)
@0,644,564us: [+4 T:0x40018060 S:0xbefffc1c] OT - Thread_delete> pthread_cancel (0x3)
@0,644,725us: [+4 T:0x40018060 S:0xbefffc1c] OT - Thread_delete> pthread_join (0x0)
@0,644,866us: [+0 T:0x40018060 S:0xbefffbf4] OM - Memory_free> Enter(0x3e4f0, 0x64)
@0,645,062us: [+0 T:0x40018060 S:0xbefffbf4] OM - Memory_free> return (0x1)
@0,645,212us: [+0 T:0x40018060 S:0xbefffc34] OT - Thread_delete> Exit (task=0x3e4f0)
@0,645,350us: [+0 T:0x40018060 S:0xbefffc24] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x3e4a0]
@0,645,513us: [+0 T:0x40018060 S:0xbefffbfc] OM - Memory_free> Enter(0x3e4a0, 0x14)
@0,645,667us: [+0 T:0x40018060 S:0xbefffbfc] OM - Memory_free> return (0x1)
@0,645,803us: [+0 T:0x40018060 S:0xbefffc34] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@0,645,931us: [+0 T:0x40018060 S:0xbefffc24] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x3e4b8]
@0,646,065us: [+0 T:0x40018060 S:0xbefffbfc] OM - Memory_free> Enter(0x3e4b8, 0x14)
@0,646,208us: [+0 T:0x40018060 S:0xbefffbfc] OM - Memory_free> return (0x1)
@0,646,339us: [+0 T:0x40018060 S:0xbefffc34] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@0,646,465us: [+0 T:0x40018060 S:0xbefffc0c] OM - Memory_free> Enter(0x3e4d0, 0x18)
@0,646,605us: [+0 T:0x40018060 S:0xbefffc0c] OM - Memory_free> return (0x1)
@0,646,740us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x184ac()...
@0,646,904us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x1535c()...
@0,647,055us: [+0 T:0x40018060 S:0xbefffc24] OM - Memory_free> Enter(0x3e420, 0x18)
@0,647,203us: [+0 T:0x40018060 S:0xbefffc24] OM - Memory_free> return (0x1)
@0,647,338us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x17710()...
@0,647,495us: [+0 T:0x40018060 S:0xbefffc0c] OM - Memory_free> Enter(0x3e3d0, 0x18)
@0,647,644us: [+0 T:0x40018060 S:0xbefffc0c] OM - Memory_free> return (0x1)
@0,647,781us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x18e28()...
@0,647,919us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x19990()...
@0,648,056us: [+2 T:0x40018060 S:0xbefffc4c] OG - Global_exit> calling function *0x18834()...
