Decode demo started.
@0,961,953us: [+4 T:0x4001fdf0 S:0xbebd7914] OG - Global_init> This program was built with the following packages:
@0,962,542us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package gnu.targets.rts470MV (/opt/dvsdk_2_00_00_22_1080p/xdctools_3_10_03/packages/gnu/targets/rts470MV/) [1,0,0,0,1225517438755]
@0,962,759us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.mpeg2dec (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg2dec/) [1,0,0,1289818336000]
@0,962,912us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.h264dec (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264dec/) [1,0,0,1289818336000]
@0,963,054us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.aachedec (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/aachedec/) [1,0,0,1289818319000]
@0,963,293us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.g711dec (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711dec/) [1,0,0,1289818328000]
@0,963,439us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.global (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464]
@0,963,581us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.xdais.dm (/opt/dvsdk_2_00_00_22_1080p/xdais_6_25_01_08/packages/ti/xdais/dm/) [1,0,5,0]
@0,963,715us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.utils.trace (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890]
@0,963,854us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490]
@0,963,991us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package dsplink.gpp (/opt/dvsdk_2_00_00_22_1080p/dsplink-1_61_03-prebuilt/packages/dsplink/gpp/) [5,0,0,1239931267000]
@0,964,127us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.linuxutils.cmem (/opt/dvsdk_2_00_00_22_1080p/linuxutils_2_23_01/packages/ti/sdo/linuxutils/cmem/) [2,2,0,1240253001679]
@0,964,277us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.xdais (/opt/dvsdk_2_00_00_22_1080p/xdais_6_25_01_08/packages/ti/xdais/) [1,2,1,0]
@0,964,415us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.node (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858]
@0,964,553us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.fc.global (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/global/) [1,0,0,1240266696499]
@0,964,692us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662]
@0,964,827us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.fc.memutils (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007]
@0,964,964us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108]
@0,965,101us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package gnu.targets (/opt/dvsdk_2_00_00_22_1080p/xdctools_3_10_03/packages/gnu/targets/) [1,0,1,1225517427930]
@0,965,236us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.catalog.c470 (/opt/dvsdk_2_00_00_22_1080p/xdctools_3_10_03/packages/ti/catalog/c470/) [1,0,1,0,0]
@0,965,371us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.catalog.c6000 (/opt/dvsdk_2_00_00_22_1080p/xdctools_3_10_03/packages/ti/catalog/c6000/) [1,0,0,0,0]
@0,965,506us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.platforms.evmDM6467 (/opt/dvsdk_2_00_00_22_1080p/xdctools_3_10_03/packages/ti/platforms/evmDM6467/) [1,0,0,0,0]
@0,965,640us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.osal (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,1240276730877]
@0,965,777us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.osal.linux (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/osal/linux/) [2,0,1,1240276736840]
@0,965,975us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961]
@0,966,126us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.ipc.dsplink (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/) [2,0,1,1240276714152]
@0,966,270us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.alg (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798]
@0,966,409us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491]
@0,966,545us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.video2 (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/video2/) [1,0,2,1240276933444]
@0,966,682us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.mpeg2dec.ce (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg2dec/ce/) [1,0,0,1289818336000]
@0,966,820us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.h264dec.ce (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264dec/ce/) [1,0,0,1289818336000]
@0,966,958us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.audio1 (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/audio1/) [1,0,1,1240276296900]
@0,967,093us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.aachedec.ce (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/aachedec/ce/) [1,0,0,1289818321000]
@0,967,234us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.speech1 (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/speech1/) [1,0,1,1240276763928]
@0,967,369us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.codecs.g711dec.ce (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711dec/ce/) [1,0,0,1289818330000]
@0,967,521us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.speech (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/speech/) [1,0,2,1240276762193]
@0,967,661us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.audio (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/audio/) [1,0,2,1240276296374]
@0,967,799us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.video (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/video/) [1,0,3,1240276930771]
@0,967,937us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.video1 (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/video1/) [1,0,2,1240276935900]
@0,968,071us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.image (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/image/) [1,0,3,1240276700525]
@0,968,212us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.image1 (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/image1/) [1,0,1,1240276698808]
@0,968,348us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.dmai (/opt/dvsdk_2_00_00_22_1080p/dmai_1_20_00_06/packages/ti/sdo/dmai/) [1,0,0,1296748306000]
@0,968,483us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.simplewidget (/opt/dvsdk_2_00_00_22_1080p/swpackages/ti/sdo/simplewidget/) []
@0,968,618us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/bioslog/) [1,0,1,1240276303166]
@0,968,754us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package ti.sdo.ce.utils.trace (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/utils/trace/) [1,0,1,1240276915917]
@0,968,888us: [+4 T:0x4001fdf0 S:0xbebd7914] OG -     package decode_config (/root/nir_build/Build/MGU/ILN/MGU/decode/decode_config/) []
@0,969,144us: [+0 T:0x4001fdf0 S:0xbebd791c] OG - Global_atexit> enter (fxn=0x83324)
@0,969,331us: [+0 T:0x4001fdf0 S:0xbebd791c] OG - Global_atexit> enter (fxn=0x82770)
@0,969,698us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> Enter(0x18)
@0,969,872us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> return (0xd90f0)
@0,970,305us: [+0 T:0x4001fdf0 S:0xbebd790c] OG - Global_atexit> enter (fxn=0x806a0)
@0,970,561us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> Enter(0x18)
@0,970,733us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> return (0xd9140)
@0,970,882us: [+0 T:0x4001fdf0 S:0xbebd7904] OG - Global_atexit> enter (fxn=0x7f54c)
@0,971,050us: [+0 T:0x4001fdf0 S:0xbebd790c] OG - Global_atexit> enter (fxn=0x81dd4)
@0,971,293us: [+0 T:0x4001fdf0 S:0xbebd7904] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,971,450us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> Enter(0x14)
@0,971,598us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> return (0xd91c0)
@0,971,769us: [+0 T:0x4001fdf0 S:0xbebd7904] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0xd91c0]
@0,971,919us: [+0 T:0x4001fdf0 S:0xbebd7904] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,972,057us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> Enter(0x14)
@0,972,203us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> return (0xd91d8)
@0,972,344us: [+0 T:0x4001fdf0 S:0xbebd7904] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0xd91d8]
@0,972,482us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> Enter(0x18)
@0,972,624us: [+0 T:0x4001fdf0 S:0xbebd78ec] OM - Memory_alloc> return (0xd91f0)
@0,972,766us: [+0 T:0x4001fdf0 S:0xbebd78e4] OT - Thread_create> Enter (fxn=0x7dd24, attrs=0x0)
@0,972,907us: [+0 T:0x4001fdf0 S:0xbebd78cc] OM - Memory_alloc> Enter(0x64)
@0,973,047us: [+0 T:0x4001fdf0 S:0xbebd78cc] OM - Memory_alloc> return (0xd9210)
@0,973,804us: [+0 T:0x4001fdf0 S:0xbebd78e4] OT - Thread_create> Exit (task=0xd9210)
@0,974,000us: [+0 T:0x4001fdf0 S:0xbebd791c] OG - Global_atexit> enter (fxn=0x7d714)
@0,974,185us: [+0 T:0x4001fdf0 S:0xbebd791c] OG - Global_atexit> enter (fxn=0x7fa98)
@0,974,437us: [+0 T:0x4001fdf0 S:0xbebd7904] ti.sdo.ce.alg - ALG_init> Enter
@0,974,595us: [+0 T:0x4001fdf0 S:0xbebd78f4] OG - Global_atexit> enter (fxn=0x7d360)
@0,974,747us: [+0 T:0x4001fdf0 S:0xbebd7924] ti.sdo.ce.alg - ALG_init> Exit
@0,974,887us: [+0 T:0x4001fdf0 S:0xbebd791c] OG - Global_atexit> enter (fxn=0x7c78c)
@0,975,052us: [+0 T:0x4001fdf0 S:0xbebd78f4] OM - Memory_alloc> Enter(0x18)
@0,975,217us: [+0 T:0x4001fdf0 S:0xbebd78f4] OM - Memory_alloc> return (0xd93f0)
@0,975,364us: [+0 T:0x4001fdf0 S:0xbebd791c] OG - Global_atexit> enter (fxn=0x822c4)
@0,975,598us: [+6 T:0x4001fdf0 S:0xbebd7914] CE - Engine_init> CE debugging on (CE_DEBUG=3; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@0,975,764us: [+0 T:0x4001fdf0 S:0xbebd7904] OG - Global_atexit> enter (fxn=0x79c20)
@0,975,916us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> Enter(0x18)
@0,976,070us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> return (0xd9430)
@0,976,220us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> Enter(0x18)
@0,976,371us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> return (0xd9450)
@0,976,518us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> Enter(0x18)
@0,976,666us: [+0 T:0x4001fdf0 S:0xbebd78e4] OM - Memory_alloc> return (0xd9470)
@0,976,905us: [+0 T:0x4001fdf0 S:0xbebd791c] CS - Server_init()
@0,977,058us: [+0 T:0x4001fdf0 S:0xbebd791c] CS - Server_init> Global_useLinkArbiter = 0
@0,977,209us: [+0 T:0x4001fdf0 S:0xbebd791c] OG - Global_atexit> enter (fxn=0x77f00)
@0,977,459us: [+0 T:0x4001fdf0 S:0xbebd792c] OG - Global_atexit> enter (fxn=0x63a64)
TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil)
Video STD started
@1,010,852us: [+0 T:0x42498490 S:0x42497ca4] OM - Memory_alloc> Enter(0x7a120)
@1,011,055us: [+0 T:0x42498490 S:0x42497c5c] OM - Memory_contigAlloc> Enter(size=500000, align=-1, cached=FALSE, heap=FALSE)
@1,011,483us: [+4 T:0x42498490 S:0x42497c5c] OM - Memory_contigAlloc> CMEM_alloc(500000) = 0x42499000.
@1,011,760us: [+4 T:0x42498490 S:0x42497c5c] OM - Memory_contigAlloc> CMEM_getPhys(0x42499000) = 0x886b1000.
@1,011,940us: [+1 T:0x42498490 S:0x42497c14] OM - Memory__addContigBuf> Enter(virtAddr=0x42499000, size=500000, physAddr=0x886b1000)
@1,012,101us: [+1 T:0x42498490 S:0x42497c14] OM - Memory__addContigBuf> creating new contigBuf object
@1,012,246us: [+0 T:0x42498490 S:0x42497bfc] OM - Memory_alloc> Enter(0x10)
@1,012,402us: [+0 T:0x42498490 S:0x42497bfc] OM - Memory_alloc> return (0xd9bc0)
@1,012,552us: [+1 T:0x42498490 S:0x42497c14] OM - Memory__addContigBuf> returning: cb->phys=0x886b1000, cb->size=500000, cb->virt=0x42499000
@1,012,707us: [+0 T:0x42498490 S:0x42497c5c] OM - Memory_contigAlloc> return (0x42499000)
@1,012,855us: [+0 T:0x42498490 S:0x42497ca4] OM - Memory_alloc> return (0x42499000)
@1,013,007us: [+0 T:0x42498490 S:0x42497c84] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x42499000, size=4)
@1,013,161us: [+1 T:0x42498490 S:0x42497c84] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x42499000, size=4)
@1,013,315us: [+1 T:0x42498490 S:0x42497c84] OM - Memory__getPhysicalAddress> found in cb(Sc=0x42499000, Ec=0x42513120, Ss=0x42499000, Es=0x42499004, PSc=0x886b1000)
@1,013,482us: [+1 T:0x42498490 S:0x42497c84] OM - Memory__getPhysicalAddress> returning physAddr=0x886b1000
@1,013,631us: [+0 T:0x42498490 S:0x42497c84] OM - Memory_getBufferPhysicalAddress> return (0x886b1000)
@1,013,779us: [+2 T:0x42498490 S:0x42497cbc] ti.sdo.dmai - [Buffer] Alloc Buffer of size 500000 at 0x42499000 (0x886b1000 phys)
@1,014,008us: [+0 T:0x42498490 S:0x42497c84] CE - Engine_open> Enter('decode', 0x0, 0x42497cf4)
@1,014,184us: [+0 T:0x42498490 S:0x42497c6c] OM - Memory_alloc> Enter(0x2c)
@1,014,348us: [+0 T:0x42498490 S:0x42497c6c] OM - Memory_alloc> return (0xd9bd8)
@1,014,502us: [+0 T:0x42498490 S:0x42497c84] CE - rserverOpen('decodeCombo.x64P'), count = 0
@1,014,695us: [+0 T:0x42498490 S:0x42497c4c] OP - Processor_create> Enter(imageName='decodeCombo.x64P', linkCfg='(null)', attrs=0x42497cd8)
@1,015,137us: [+0 T:0x42498490 S:0x42497c34] OM - Memory_alloc> Enter(0x24)
@1,015,333us: [+0 T:0x42498490 S:0x42497c34] OM - Memory_alloc> return (0xd9c08)
@1,015,496us: [+0 T:0x42498490 S:0x42497c2c] OP - doCmd> Enter (cmdId=1, proc=0xd9c08)
@1,015,647us: [+0 T:0x42498490 S:0x42497c1c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91c0]
@1,015,877us: [+0 T:0x42498490 S:0x42497c2c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91c0]
@1,016,047us: [+0 T:0x42498490 S:0x42497c0c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91d8] timeout[0xffffffff]
@1,016,353us: [+1 T:0x40c98490 S:0x40c97d64] OP - daemon> thread created.
@1,016,539us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Enter (proc=0x40c97dd8)
@1,016,697us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91c0] timeout[0xffffffff]
@1,016,854us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91c0] status[0]
@1,017,007us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Exit (result=1)
@1,017,153us: [+0 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Enter(proc=0xd9c08)
@1,017,303us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Initializing DSP PROC...
@1,017,456us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'decodeCombo.x64P']
@1,017,614us: [+0 T:0x40c98490 S:0x40c97d4c] OM - Memory_alloc> Enter(0xe0)
@1,017,779us: [+0 T:0x40c98490 S:0x40c97d4c] OM - Memory_alloc> return (0xd9c30)
@1,017,937us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fa00000, sizeInBytes=0x400000, shared=1, syncd=0
@1,018,118us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000, sizeInBytes=0x100000, shared=1, syncd=0
@1,018,292us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESETCTRL', startAddress=0x8ff00000, sizeInBytes=0x80, shared=1, syncd=0
@1,018,525us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x8ba00000, sizeInBytes=0x4000000, shared=0, syncd=0
@1,018,709us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> DODSPCTRL was=1; now=0
@1,021,889us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Attaching to DSP PROC...
@1,032,868us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Opening MSGQ pool...
@1,033,445us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Loading decodeCombo.x64P on DSP (1 args)...
@1,220,683us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Starting DSP PROC...
@1,309,486us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Opening remote transport...
@1,329,967us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> return (1)
@1,330,170us: [+0 T:0x40c98490 S:0x40c97d54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91d8]
@1,330,383us: [+0 T:0x42498490 S:0x42497c0c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91d8] status[0]
@1,330,555us: [+0 T:0x42498490 S:0x42497c2c] OP - doCmd> Exit (result=1)
@1,330,702us: [+0 T:0x42498490 S:0x42497c4c] OP - Processor_create> return (0xd9c08)
@1,330,852us: [+0 T:0x42498490 S:0x42497c84] CE - rserverOpen('decodeCombo.x64P'): 0xd83e8 done.
@1,331,007us: [+0 T:0x42498490 S:0x42497c6c] OM - Memory_alloc> Enter(0x24)
@1,331,163us: [+0 T:0x42498490 S:0x42497c6c] OM - Memory_alloc> return (0xd9e68)
@1,331,335us: [+0 T:0x42498490 S:0x42497c5c] OC - Comm_create> Enter(queueName='decode_846_0', queue=0xd9be8, attrs=0x0)
@1,331,491us: [+0 T:0x42498490 S:0x42497c44] OM - Memory_alloc> Enter(0x4)
@1,331,642us: [+0 T:0x42498490 S:0x42497c44] OM - Memory_alloc> return (0xd9e90)
@1,332,079us: [+0 T:0x42498490 S:0x42497c5c] OC - Comm_create> return (0xd9e90)
@1,332,277us: [+0 T:0x42498490 S:0x42497c64] OM - Memory_free> Enter(0xd9e68, 0x24)
@1,332,511us: [+0 T:0x42498490 S:0x42497c64] OM - Memory_free> return (0x1)
@1,332,679us: [+0 T:0x42498490 S:0x42497c64] OC - Comm_alloc> Enter(poolId=0x0, msg=0xd9bf4, size=576)
@1,332,888us: [+0 T:0x42498490 S:0x42497c64] OC - Comm_alloc> msg=0x42d4a880, returning (0)
@1,333,051us: [+0 T:0x42498490 S:0x42497c4c] OC - Comm_locate> Enter(queueName='rmsq', queue=0xd9be4)
@1,333,397us: [+0 T:0x40c98490 S:0x40c97d64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91d8]
@1,333,600us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Enter (proc=0x40c97dd8)
@1,333,761us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91c0] timeout[0xffffffff]
@1,334,136us: [+0 T:0x42498490 S:0x42497c4c] OC - Comm_locate> return (0)
@1,334,336us: [+0 T:0x42498490 S:0x42497c84] CE - checkServer(0xd9bd8)
@1,334,514us: [+0 T:0x42498490 S:0x42497c54] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,334,732us: [+0 T:0x42498490 S:0x42497c54] OC - Comm_put> return (0)
@1,334,936us: [+0 T:0x42498490 S:0x42497c4c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497cf0, timeout=-1)
@1,335,240us: [+0 T:0x42498490 S:0x42497c4c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@1,335,433us: [+0 T:0x42498490 S:0x42497c84] CE - rmsInit> RMS initialized(0xd9bd8); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3
@1,335,602us: [+0 T:0x42498490 S:0x42497c5c] CE - Engine_setTrace> Enter(engine=0xd9bd8, mask='*+01234567,GT_prefix=12345,GT_time=3')
@1,335,781us: [+1 T:0x42498490 S:0x42497c5c] CE - Engine_setTrace> Requesting DSP set trace ...
@1,335,921us: [+0 T:0x42498490 S:0x42497c2c] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,336,123us: [+0 T:0x42498490 S:0x42497c2c] OC - Comm_put> return (0)
@1,336,283us: [+0 T:0x42498490 S:0x42497c24] OC - Comm_get> Enter(queue=0x10000, msg=0x42497ca4, timeout=-1)
@1,338,170us: [+0 T:0x42498490 S:0x42497c24] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@1,338,375us: [+0 T:0x42498490 S:0x42497c5c] CE - Engine_setTrace> return(0)
@1,338,556us: [+0 T:0x42498490 S:0x42497bec] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,338,773us: [+0 T:0x42498490 S:0x42497bec] OC - Comm_put> return (0)
@1,355,554us: [+0 T:0x42498490 S:0x42497be4] OC - Comm_get> Enter(queue=0x10000, msg=0x42497c84, timeout=-1)
@1,355,900us: [+0 T:0x42498490 S:0x42497be4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @0,061,948tk: [+0 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3')
[DSP] @0,062,044tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,062,105tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.targets.rts6000 (/opt/dvsdk_2_00_00_22_standard/xdctools_3_10_03/packages/ti/targets/rts6000/) [1,0,0,0,1225517497925]
[DSP] @0,062,187tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.mpeg2dec (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg2dec/) [1,0,0,1297787617000]
[DSP] @0,062,275tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.aachedec (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/aachedec/) [1,0,0,1297787588000]
[DSP] @0,062,363tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.g711dec (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711dec/) [1,0,0,1297787597000]
[DSP] @0,062,449tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.h264dec (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264dec/) [1,0,0,1297853866000]
[DSP] @0,062,536tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.hdvicp (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/hdvicp/) [1,0,0,1297787615000]
[DSP] @0,062,622tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.utils.trace (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890]
[DSP] @0,062,708tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.global (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/global/) [1,0,0,1240266696499]
[DSP] @0,062,793tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.utils.gtinfra (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/utils/gtinfra/) [1,0,0,1240266906169]
[DSP] @0,062,883tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.ires.hdvicp (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/ires/hdvicp/) [1,0,1,1240266763264]
[DSP] @0,062,971tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.rtdx (/opt/dvsdk_2_00_00_22_standard/bios_5_33_06/packages/ti/rtdx/) [2,0,0,4,1220389102790]
[DSP] @0,063,044tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.psl (/opt/dvsdk_2_00_00_22_standard/bios_5_33_06/packages/ti/psl/) [5,0,0,0,0]
[DSP] @0,063,111tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.pmi (/opt/dvsdk_2_00_00_22_standard/bios_5_33_06/packages/ti/pmi/) [0,0,0,0,1247787708590]
[DSP] @0,063,191tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.bios (/opt/dvsdk_2_00_00_22_standard/bios_5_33_06/packages/ti/bios/) [5,2,5,16,1247787696953]
[DSP] @0,063,264tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.dskt2 (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/dskt2/) [1,0,4,1240266678055]
[DSP] @0,063,348tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.hdintc (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/hdintc/) [1,0,4,1240266707594]
[DSP] @0,063,432tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.memutils (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007]
[DSP] @0,063,518tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.edma3.rm (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/fctools/packages/ti/sdo/edma3/rm/) [1,3,4,1225865844769]
[DSP] @0,063,605tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.ires.nullresource (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/ires/nullresource/) [1,0,0,1240266782634]
[DSP] @0,063,698tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.rman (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/rman/) [2,0,0,1240266813533]
[DSP] @0,063,781tk: [+4 T:0x8ba0006c S:0x8ba03fe4]@1,366,994us: [+0 T:0x42498490 S:0x42497bec] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,367,227us: [+0 T:0x42498490 S:0x42497bec] OC - Comm_put> return (0)
@1,367,433us: [+0 T:0x42498490 S:0x42497be4] OC - Comm_get> Enter(queue=0x10000, msg=0x42497c84, timeout=-1)
@1,367,747us: [+0 T:0x42498490 S:0x42497be4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
 OG -     package ti.sdo.fc.edma3 (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/edma3/) [2,0,0,1240266681138]
[DSP] @0,063,865tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.ires.edma3chan (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/ires/edma3chan/) [1,0,0,1240266737833]
[DSP] @0,063,955tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.global (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464]
[DSP] @0,064,037tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.xdais.dm (/opt/dvsdk_2_00_00_22_standard/xdais_6_23/packages/ti/xdais/dm/) [1,0,5,1236972452910]
[DSP] @0,064,111tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490]
[DSP] @0,064,195tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.xdais (/opt/dvsdk_2_00_00_22_standard/xdais_6_23/packages/ti/xdais/) [1,2,1,1236972427008]
[DSP] @0,064,267tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.node (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858]
[DSP] @0,064,347tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1240276720026]
[DSP] @0,064,435tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662]
[DSP] @0,064,519tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_2_00_00_22_standard/framework_components_2_23_01/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108]
[DSP] @0,064,603tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package dsplink.dsp (/opt/dvsdk_2_00_00_22_standard/dsplink-1_61_03-prebuilt/packages/dsplink/dsp/) [1,4,0,1239931280000]
[DSP] @0,064,683tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.bios.utils (/opt/dvsdk_2_00_00_22_standard/biosutils_1_01_00/packages/ti/bios/utils/) [2,0,1,0,0]
[DSP] @0,064,758tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.catalog.c6000 (/opt/dvsdk_2_00_00_22_standard/xdctools_3_10_03/packages/ti/catalog/c6000/) [1,0,0,0,0]
[DSP] @0,064,834tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.platforms.evmDM6467 (/opt/dvsdk_2_00_00_22_standard/xdctools_3_10_03/packages/ti/platforms/evmDM6467/) [1,0,0,0,0]
[DSP] @0,064,915tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.osal (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,1240276730877]
[DSP] @0,064,995tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.osal.bios (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/osal/bios/) [2,0,1,1240276734107]
[DSP] @0,065,079tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961]
[DSP] @0,065,158tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.ipc.bios (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1240276705217]
[DSP] @0,065,242tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.alg (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798]
[DSP] @0,065,321tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491]
[DSP] @0,065,397tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/bioslog/) [1,0,1,1240276303166]
[DSP] @0,065,480tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.video2 (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/video2/) [1,0,2,1240276933444]
[DSP] @0,065,565tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.mpeg2dec.ce (/opt/dvsdk_2_00_00_22_stan@1,378,677us: [+0 T:0x42498490 S:0x42497bec] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,378,902us: [+0 T:0x42498490 S:0x42497bec] OC - Comm_put> return (0)
@1,379,106us: [+0 T:0x42498490 S:0x42497be4] OC - Comm_get> Enter(queue=0x10000, msg=0x42497c84, timeout=-1)
@1,379,509us: [+0 T:0x42498490 S:0x42497be4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
dard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg2dec/ce/) [1,0,0,1297787619000]
[DSP] @0,065,654tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.audio1 (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/audio1/) [1,0,1,1240276296900]
[DSP] @0,065,736tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.aachedec.ce (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/aachedec/ce/) [1,0,0,1297787590000]
[DSP] @0,065,826tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.ce.speech1 (/opt/dvsdk_2_00_00_22_standard/codec_engine_2_23_01/packages/ti/sdo/ce/speech1/) [1,0,1,1240276763928]
[DSP] @0,065,908tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.g711dec.ce (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711dec/ce/) [1,0,0,1297787599000]
[DSP] @0,065,997tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.codecs.h264dec.ce (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264dec/ce/) [1,0,0,1297853866000]
[DSP] @0,066,086tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG -     package ti.sdo.servers.decode (/opt/dvsdk_2_00_00_22_standard/dm6467_dvsdk_combos_2_05/packages/ti/sdo/servers/decode/) []
[DSP] @0,066,166tk: [+0 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> return
[DSP] @0,068,085tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,068,143tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,134,098tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,134,153tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,161,183tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,161,239tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@1,384,730us: [+0 T:0x42498490 S:0x42497c1c] CE - Engine_fwriteTrace> returning count [10288]
@1,384,889us: [+0 T:0x42498490 S:0x42497c84] CE - Engine_open> return(891864)
@1,385,178us: [+0 T:0x42498490 S:0x42497bd4] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0xd9bd8, name='h264dec', params=0x42497dac)
@1,385,383us: [+0 T:0x42498490 S:0x42497ba4] CV - VISA_create(0xd9bd8, 'h264dec', 0x42497dac, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2')
@1,385,559us: [+0 T:0x42498490 S:0x42497aa4] CV - VISA_create2(0xd9bd8, 'h264dec', 0x42497dac, 0x1c, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2')
@1,385,743us: [+0 T:0x42498490 S:0x42497a8c] OM - Memory_alloc> Enter(0x30)
@1,385,904us: [+0 T:0x42498490 S:0x42497a8c] OM - Memory_alloc> return (0xda070)
@1,386,053us: [+0 T:0x42498490 S:0x42497a2c] CE - Engine_createNode(0xd9bd8, 'h264dec', 2484, 0x42497dac, 0x1c, 0x42497b9c)
@1,386,219us: [+0 T:0x42498490 S:0x42497a2c] CE - Engine> allocNode Enter(engine=0xd9bd8, impId='h264dec')
@1,386,366us: [+0 T:0x42498490 S:0x42497a14] OM - Memory_alloc> Enter(0x20)
@1,386,564us: [+0 T:0x42498490 S:0x42497a14] OM - Memory_alloc> return (0xd9e68)
@1,386,746us: [+0 T:0x42498490 S:0x42497a2c] CE - Engine> allocNode(). Calling Comm_create(gppfromnode_846_1, 0xd9e70, NULL)
@1,386,898us: [+0 T:0x42498490 S:0x42497a04] OC - Comm_create> Enter(queueName='gppfromnode_846_1', queue=0xd9e70, attrs=0x0)
@1,387,058us: [+0 T:0x42498490 S:0x424979ec] OM - Memory_alloc> Enter(0x4)
@1,387,216us: [+0 T:0x42498490 S:0x424979ec] OM - Memory_alloc> return (0xda0a8)
@1,387,666us: [+0 T:0x42498490 S:0x42497a04] OC - Comm_create> return (0xda0a8)
@1,387,871us: [+0 T:0x42498490 S:0x42497a0c] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,388,092us: [+0 T:0x42498490 S:0x42497a0c] OC - Comm_put> return (0)
@1,388,263us: [+0 T:0x42498490 S:0x42497a04] OC - Comm_get> Enter(queue=0x10000, msg=0x42497ab4, timeout=-1)
@1,466,239us: [+0 T:0x42498490 S:0x42497a04] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@1,466,445us: [+0 T:0x42498490 S:0x42497a04] OC - Comm_delete> Enter (comm=0xda0a8)
@1,466,868us: [+0 T:0x42498490 S:0x424979e4] OM - Memory_free> Enter(0xda0a8, 0x4)
@1,467,074us: [+0 T:0x42498490 S:0x424979e4] OM - Memory_free> return (0x1)
@1,467,240us: [+0 T:0x42498490 S:0x42497a24] OC - Comm_delete> return
@1,467,442us: [+0 T:0x42498490 S:0x42497a0c] OM - Memory_free> Enter(0xd9e68, 0x20)
@1,467,606us: [+0 T:0x42498490 S:0x42497a0c] OM - Memory_free> return (0x1)
@1,467,751us: [+6 T:0x42498490 S:0x42497a2c] CE - Engine_createNode> Remote node creation FAILED (0x80008008).
@1,467,917us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,468,128us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> return (0)
@1,468,329us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497a2c, timeout=-1)
@1,468,639us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @0,182,511tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 0
[DSP] @0,182,573tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,182,623tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> return (0x8fa71920)
[DSP] @0,182,673tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> Enter(size=0xa)
[DSP] @0,182,718tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> return (0x8fa71938)
[DSP] @0,182,773tk: [+0 T:0x8ba0006c S:0x8ba03ee4] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,182,819tk: [+0 T:0x8ba0006c S:0x8ba03ee4] OM - Memory_alloc> return (0x8fa71948)
[DSP] @0,182,869tk: [+0 T:0x8ba0006c S:0x8ba03eb4] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,182,916tk: [+0 T:0x8ba0006c S:0x8ba03eb4] OM - Memory_alloc> return (0x8fa71968)
[DSP] @0,182,989tk: [+0 T:0x8ba0006c S:0x8ba03ecc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0x0, name='h264dec', params=0x8fe038c0)
[DSP] @0,183,069tk: [+0 T:0x8ba0006c S:0x8ba03e94] CV - VISA_create(0x0, 'h264dec', 0x8fe038c0, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2')
[DSP] @0,183,140tk: [+0 T:0x8ba0006c S:0x8ba03d84] CV - VISA_create2(0x0, 'h264dec', 0x8fe038c0, 0x1c, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2')
[DSP] @0,183,222tk: [+0 T:0x8ba0006c S:0x8ba03d1c] CE - Engine_open> Enter('local', 0x8ba03d6c, 0x8fe038c0)
[DSP] @0,183,284tk: [+0 T:0x8ba0006c S:0x8ba03cfc] OM - Memory_alloc> Enter(size=0x2c)
[DSP] @0,183,331tk: [+0 T:0x8ba0006c S:0x8ba03cfc] OM - Memory_alloc> return (0x8fa719d8)
[DSP] @0,183,389tk: [+0 T:0x8ba0006c S:0x8ba03d1c] CE - Engine_open> return(-1884874280)
[DSP] @0,183,452tk: [+0 T:0x8ba0006c S:0x8ba03d64] OM - Memory_alloc> Enter(size=0x30)
[DSP] @0,183,498tk: [+0 T:0x8ba0006c S:0x8ba03d64] OM - Memory_alloc> return (0x8fa71a08)
[DSP] @0,183,551tk: [+0 T:0x8ba0006c S:0x8ba03d3c] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fa6b3a4, idma3Fxns=0x0, iresFxns=0x8fa6b37c, params=0x8fe038c0, attrs=0x8ba03e80)
[DSP] @0,183,647tk: [+0 T:0x8ba0006c S:0x8ba03d1c] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,183,693tk: [+0 T:0x8ba0006c S:0x8ba03d1c] OM - Memory_alloc> return (0x8fa71a38)
[DSP] @0,183,759tk: [+0 T:0x8ba0006c S:0x8ba03cfc] ti.sdo.fc.dskt2 - _DSKT2_init> Enter
[DSP] @0,183,849tk: [+0 T:0x8ba0006c S:0x8ba03cfc] ti.sdo.fc.dskt2 - _DSKT2_init> Exit
[DSP] @0,183,894tk: [+0 T:0x8ba0006c S:0x8ba03d0c] ti.sdo.fc.dskt2 - DSKT2_createAlg> Enter (scratchId=0, fxns=0x8fa6b3a4, parentAlg=0x0, params=0x8fe038c0)
[DSP] @0,183,972tk: [+0 T:0x8ba0006c S:0x8ba03c94] ti.sdo.fc.dskt2 - _DSKT2_init> Enter
[DSP] @0,184,017tk: [+0 T:0x8ba0006c S:0x8ba03c94] ti.sdo.fc.dskt2 - _DSKT2_init> Exit
[DSP] @0,184,062tk: [+0 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Enter (scratchId=0, fxns=0x8fa6b3a4, parentAlg=0x0, params=0x8fe038c0, extHeapId=-1881130816, singleHeap=0)
[DSP] @0,184,158tk: [+2 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> DSKT2_AlgAttrs extHeapId -1 and singleHeap 0
[DSP] @0,184,229tk: [+2 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Num memory recs requested 8
[DSP] @0,184,288tk: [+2 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> memTab allocated at 0x8fa71dd8 size=0xa0
[DSP] @0,184,354tk: [+2 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Num memory recs requested 8
[DSP] @0,184,415tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[0]: size=0x480, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,184,497tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[1]: size=0x1380, align=0x80, space=IALG_DARAM0, attrs=IALG_SCRATCH
[DSP] @0,184,577tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[2]: size=0x1380, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,184,657tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[3]: size=0x4700, align=0x80, space=IALG_DARAM0, attrs=IALG_SCRATCH
[DSP] @0,184,737tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[4]: size=0x880, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,184,816tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.f@1,480,059us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,480,307us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> return (0)
@1,480,518us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497a2c, timeout=-1)
@1,480,827us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
c.dskt2 - DSKT2_createAlg3> Requested memTab[5]: size=0x1980, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,184,897tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[6]: size=0x171100, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,184,978tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Requested memTab[7]: size=0xc39100, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,185,064tk: [+0 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> Enter (scratchId=0, numRecs=8, extHeapId=0)
[DSP] @0,185,131tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Enter (numRecs=8)
[DSP] @0,185,189tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Exit (returnVal=1)
[DSP] @0,185,245tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> Alg requires some Internal Scratch in group 0
[DSP] @0,185,311tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> Allocate as much as possible in the memory space requested
[DSP] @0,185,384tk: [+0 T:0x8ba0006c S:0x8ba03bd4] ti.sdo.fc.dskt2 - _DSKT2_initializeAndUseSharedScratch> Enter (scratchGroupId=0, numRecs=8)
[DSP] @0,185,460tk: [+0 T:0x8ba0006c S:0x8ba03b84] ti.sdo.fc.dskt2 - _DSKT2_getScratchRequestInfo> Enter (ialgSpace=IALG_DARAM0, numRecs=8)
[DSP] @0,185,532tk: [+0 T:0x8ba0006c S:0x8ba03b84] ti.sdo.fc.dskt2 - _DSKT2_getScratchRequestInfo> Exit (sizeBestCase=23168, sizeWorstCase=23424, numScratchRecs=2)
[DSP] @0,185,638tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Enter (scrBuffDesc->base=0x11818000)
[DSP] @0,185,705tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Exit (status=TRUE)
[DSP] @0,185,759tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Enter (scrBuffDesc->base=0x11818000)
[DSP] @0,185,824tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Exit (status=TRUE)
[DSP] @0,185,881tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Enter (scrBuffDesc->base=0x11818000)
[DSP] @0,185,948tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Exit (status=TRUE)
[DSP] @0,186,002tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Enter (scrBuffDesc->base=0x11818000)
[DSP] @0,186,066tk: [+0 T:0x8ba0006c S:0x8ba03bb4] ti.sdo.fc.dskt2 - _DSKT2_useSharedScratch> Exit (status=TRUE)
[DSP] @0,186,126tk: [+0 T:0x8ba0006c S:0x8ba03bd4] ti.sdo.fc.dskt2 - _DSKT2_initializeAndUseSharedScratch> Exit 
[DSP] @0,186,199tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=0, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,186,283tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,186,342tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[0] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba04a00
[DSP] @0,186,428tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x11818000)
[DSP] @0,186,498tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=1 )
[DSP] @0,186,552tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[1] already allocated from Internal Scratch. Addr=0x11818000, Attrs=IALG_SCRATCH
[DSP] @0,186,637tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=2, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,186,752tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,186,811tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[2] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba04e80
[DSP] @0,186,896tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x11819380)
[DSP] @0,186,963tk: [+0 T:0x8ba0006@1,510,609us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,510,840us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> return (0)
@1,511,049us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497a2c, timeout=-1)
@1,511,363us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=1 )
[DSP] @0,187,016tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[3] already allocated from Internal Scratch. Addr=0x11819380, Attrs=IALG_SCRATCH
[DSP] @0,187,101tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=4, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,187,189tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,187,248tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[4] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba06200
[DSP] @0,187,333tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=5, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,187,455tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,187,514tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[5] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba06a80
[DSP] @0,187,599tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=6, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,204,023tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,204,088tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[6] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8ba08400
[DSP] @0,204,175tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Enter (index=7, ialgSpace=IALG_EXTERNAL, extHeapId=0)
[DSP] @0,342,850tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_allocateInDesignatedSpace> Exit (returnVal=1)
[DSP] @0,342,916tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> memTab[7] allocated in persistent memory in Memory space:IALG_EXTERNAL. Addr=0x8bb79500
[DSP] @0,343,005tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Enter (numRecs=8)
[DSP] @0,343,063tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Exit (returnVal=1)
[DSP] @0,343,120tk: [+2 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> Increment scratch group 0`s reference count
[DSP] @0,343,189tk: [+0 T:0x8ba0006c S:0x8ba03c4c] ti.sdo.fc.dskt2 - _DSKT2_incrScratchReferenceCount> Enter (scratchMutexId=0)
[DSP] @0,343,263tk: [+0 T:0x8ba0006c S:0x8ba03c4c] ti.sdo.fc.dskt2 - _DSKT2_incrScratchReferenceCount> Exit
[DSP] @0,343,316tk: [+0 T:0x8ba0006c S:0x8ba03c64] ti.sdo.fc.dskt2 - _DSKT2_assignInstanceMemory> Exit (returnVal=1)
[DSP] @0,343,380tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[0]: base=0x8ba04a00, size=0x480, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,343,469tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[1]: base=0x11818000, size=0x1380, align=0x80, space=IALG_DARAM0, attrs=IALG_SCRATCH
[DSP] @0,343,558tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[2]: base=0x8ba04e80, size=0x1380, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,343,647tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[3]: base=0x11819380, size=0x4700, align=0x80, space=IALG_DARAM0, attrs=IALG_SCRATCH
[DSP] @0,343,736tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[4]: base=0x8ba06200, size=0x880, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,343,825tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[5]: base=0x8ba06a80, size=0x1980, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,343,914tk: [+4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[6]: base=0x8ba08400, size=0x171100, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,344,023tk: [+@1,522,396us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,522,622us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> return (0)
@1,522,825us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497a2c, timeout=-1)
@1,523,135us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
4 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Allocated memTab[7]: base=0x8bb79500, size=0xc39100, align=0x80, space=IALG_EXTERNAL, attrs=IALG_PERSIST
[DSP] @0,344,118tk: [+0 T:0x8ba0006c S:0x8ba03c6c] ti.sdo.fc.dskt2 - _DSKT2_enqueueMemTab> Enter (segId=1, memTabSize=160, numRecs=8, extHeapId=0)
[DSP] @0,344,191tk: [+0 T:0x8ba0006c S:0x8ba03c6c] ti.sdo.fc.dskt2 - _DSKT2_enqueueMemTab> Exit (status=TRUE)
[DSP] @0,359,903tk: [+7 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> algInit call failed -1
[DSP] @0,359,958tk: [+0 T:0x8ba0006c S:0x8ba03c6c] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Enter (scratchMutexId=0, alg=0x8ba04a00)
[DSP] @0,360,022tk: [+2 T:0x8ba0006c S:0x8ba03c6c] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Dequeue alg  information
[DSP] @0,360,076tk: [+0 T:0x8ba0006c S:0x8ba03c34] ti.sdo.fc.dskt2 - _DSKT2_dequeueMemTab> Enter (segId=1, alg=0x8ba04a00)
[DSP] @0,360,142tk: [+0 T:0x8ba0006c S:0x8ba03c34] ti.sdo.fc.dskt2 - _DSKT2_dequeueMemTab> Exit (memTab=0x8fa71dd8)
[DSP] @0,360,210tk: [+2 T:0x8ba0006c S:0x8ba03c6c] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Dequeued alg information, memTab 0x8fa71dd8 memTabSize 160, numRecs 8, extHeapId 0
[DSP] @0,360,289tk: [+2 T:0x8ba0006c S:0x8ba03c6c] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Free instance memory
[DSP] @0,360,343tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_freeInstanceMemory> Enter (scratchMutexId=0, numRecs=8, extHeapId=0)
[DSP] @0,360,412tk: [+0 T:0x8ba0006c S:0x8ba03c14] ti.sdo.fc.dskt2 - _DSKT2_freeAllocatedMemory> Enter (scratchMutexId=0, number=8, extHeapId=0)
[DSP] @0,360,481tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x8ba04a00)
[DSP] @0,360,550tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,360,606tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x11818000)
[DSP] @0,360,674tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=1 )
[DSP] @0,360,727tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x8ba04e80)
[DSP] @0,360,794tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,360,850tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x11819380)
[DSP] @0,360,917tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=1 )
[DSP] @0,360,971tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x8ba06200)
[DSP] @0,361,038tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,361,094tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x8ba06a80)
[DSP] @0,361,161tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,361,217tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x8ba08400)
[DSP] @0,361,285tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,361,341tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratchAddr> Enter (scratchMutexId=0, addr=0x8bb79500)
[DSP] @0,361,408tk: [+0 T:0x8ba0006c S:0x8ba03bf4] ti.sdo.fc.dskt2 - _DSKT2_isSharedScratch> Exit (status=0 )
[DSP] @0,361,465tk: [+0 T:0x8ba0006c S:0x8ba03c14] ti.sdo.fc.dskt2 - _DSKT2_freeAllocatedMemory> Exit (returnVal=1)
[DSP] @0,361,521tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Enter (numRecs=8)
[DSP] @0,361,577tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_usesInternalScratch> Exit (returnVal=1)
[DSP] @0,361,635tk: [+0 T:0x8ba0006c S:0x8ba03c2c] ti.sdo.fc.dskt2 - _DSKT2_decrScratchReferenceCount> Enter (scratchMutexId=0)
[DSP] @0,361,697tk: [+0 T:0x8ba0006c S:0x8ba03c2c] ti.sdo.fc.dskt2 - _DSKT2_decrScratchReferenceCount> Exit
[DSP] @0,361,753tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_exitScr@1,534,373us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880)
@1,534,600us: [+0 T:0x42498490 S:0x42497994] OC - Comm_put> return (0)
@1,534,801us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497a2c, timeout=-1)
@1,535,110us: [+0 T:0x42498490 S:0x4249798c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
atch> Enter (scratchMutexId=0)
[DSP] @0,361,813tk: [+0 T:0x8ba0006c S:0x8ba03c24] ti.sdo.fc.dskt2 - _DSKT2_exitScratch> Exit (status=0)
[DSP] @0,361,866tk: [+0 T:0x8ba0006c S:0x8ba03c44] ti.sdo.fc.dskt2 - _DSKT2_freeInstanceMemory> Exit (returnVal=1)
[DSP] @0,361,923tk: [+0 T:0x8ba0006c S:0x8ba03c6c] ti.sdo.fc.dskt2 - DSKT2_freeAlg> Exit
[DSP] @0,361,969tk: [+0 T:0x8ba0006c S:0x8ba03ca4] ti.sdo.fc.dskt2 - DSKT2_createAlg3> Exit (algHandle=NULL)
[DSP] @0,362,023tk: [+0 T:0x8ba0006c S:0x8ba03d0c] ti.sdo.fc.dskt2 - DSKT2_createAlg> Exit (algHandle=0x0)
[DSP] @0,362,076tk: [+7 T:0x8ba0006c S:0x8ba03d3c] 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,362,204tk: [+0 T:0x8ba0006c S:0x8ba03d1c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x8fa71a38)
[DSP] @0,362,266tk: [+0 T:0x8ba0006c S:0x8ba03cec] OM - Memory_free> Enter(addr=0x8fa71a38, size=16)
[DSP] @0,362,326tk: [+0 T:0x8ba0006c S:0x8ba03cec] OM - Memory_free> return (0x1)
[DSP] @0,362,370tk: [+0 T:0x8ba0006c S:0x8ba03d1c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit
[DSP] @0,362,421tk: [+0 T:0x8ba0006c S:0x8ba03d3c] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x0)
[DSP] @0,362,476tk: [+2 T:0x8ba0006c S:0x8ba03d84] CV - VISA_create2> FAILED to create local codec.
[DSP] @0,362,532tk: [+0 T:0x8ba0006c S:0x8ba03d54] CV - VISA_delete(0x8fa71a08)
[DSP] @0,362,580tk: [+5 T:0x8ba0006c S:0x8ba03d54] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
[DSP] @0,362,642tk: [+0 T:0x8ba0006c S:0x8ba03d24] OM - Memory_free> Enter(addr=0x8fa71a08, size=48)
[DSP] @0,362,696tk: [+0 T:0x8ba0006c S:0x8ba03d24] OM - Memory_free> return (0x1)
[DSP] @0,362,744tk: [+0 T:0x8ba0006c S:0x8ba03ecc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x0)
[DSP] @0,362,802tk: [+0 T:0x8ba0006c S:0x8ba03ebc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> Enter (handle=0x0)
[DSP] @0,362,859tk: [+0 T:0x8ba0006c S:0x8ba03e8c] CV - VISA_delete(0x0)
[DSP] @0,362,899tk: [+0 T:0x8ba0006c S:0x8ba03ebc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> return
[DSP] @0,362,954tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_free> Enter(addr=0x8fa71968, size=36)
[DSP] @0,363,009tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_free> return (0x1)
[DSP] @0,363,052tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_free> Enter(addr=0x8fa71948, size=32)
[DSP] @0,363,106tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_free> return (0x1)
[DSP] @0,363,152tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free> Enter(addr=0x8fa71938, size=10)
[DSP] @0,363,207tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free> return (0x1)
[DSP] @0,363,250tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free> Enter(addr=0x8fa71920, size=24)
[DSP] @0,363,304tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free> return (0x1)
[DSP] @0,368,233tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,368,294tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,396,477tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,396,535tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,467,323tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,467,378tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,494,662tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,494,718tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @0,522,455tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5
[DSP] @0,522,511tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@1,545,841us: [+0 T:0x42498490 S:0x424979c4] CE - Engine_fwriteTrace> returning count [20864]
@1,546,004us: [+2 T:0x42498490 S:0x42497a2c] CE - Engine_createNode> Returning 0x0
@1,546,157us: [+2 T:0x42498490 S:0x42497aa4] CV - VISA_create2> FAILED to create remote codec (0x8).
@1,546,308us: [+0 T:0x42498490 S:0x42497a7c] CV - VISA_delete(0xda070)
@1,546,507us: [+5 T:0x42498490 S:0x42497a7c] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
@1,546,669us: [+0 T:0x42498490 S:0x42497a5c] OM - Memory_free> Enter(0xda070, 0x30)
@1,546,824us: [+0 T:0x42498490 S:0x42497a5c] OM - Memory_free> return (0x1)
@1,546,972us: [+0 T:0x42498490 S:0x42497bd4] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x0)
@1,547,121us: [+7 T:0x42498490 S:0x42497bfc] ti.sdo.dmai - [Vdec2] Failed to open video decode algorithm
Handle Hpd thread ready
@1,633,478us: [+0 T:0x4001fdf0 S:0xbebd7894] CE - Engine_open> Enter('decode', 0x0, 0xbebd7904)
@1,633,678us: [+0 T:0x4001fdf0 S:0xbebd787c] OM - Memory_alloc> Enter(0x2c)
@1,633,844us: [+0 T:0x4001fdf0 S:0xbebd787c] OM - Memory_alloc> return (0xe16b8)
@1,633,994us: [+0 T:0x4001fdf0 S:0xbebd7894] CE - rserverOpen('decodeCombo.x64P'), count = 1
@1,634,139us: [+0 T:0x4001fdf0 S:0xbebd7894] CE - rserverOpen('decodeCombo.x64P'): 0xd83e8 done.
@1,634,283us: [+0 T:0x4001fdf0 S:0xbebd787c] OM - Memory_alloc> Enter(0x24)
@1,634,431us: [+0 T:0x4001fdf0 S:0xbebd787c] OM - Memory_alloc> return (0xe16e8)
@1,634,599us: [+0 T:0x4001fdf0 S:0xbebd786c] OC - Comm_create> Enter(queueName='decode_846_2', queue=0xe16c8, attrs=0x0)
@1,634,751us: [+0 T:0x4001fdf0 S:0xbebd7854] OM - Memory_alloc> Enter(0x4)
@1,634,901us: [+0 T:0x4001fdf0 S:0xbebd7854] OM - Memory_alloc> return (0xe1710)
@1,635,398us: [+0 T:0x4001fdf0 S:0xbebd786c] OC - Comm_create> return (0xe1710)
@1,635,595us: [+0 T:0x4001fdf0 S:0xbebd7874] OM - Memory_free> Enter(0xe16e8, 0x24)
@1,635,758us: [+0 T:0x4001fdf0 S:0xbebd7874] OM - Memory_free> return (0x1)
@1,635,901us: [+0 T:0x4001fdf0 S:0xbebd7874] OC - Comm_alloc> Enter(poolId=0x0, msg=0xe16d4, size=576)
@1,636,087us: [+0 T:0x4001fdf0 S:0xbebd7874] OC - Comm_alloc> msg=0x42d4b880, returning (0)
@1,636,245us: [+0 T:0x4001fdf0 S:0xbebd785c] OC - Comm_locate> Enter(queueName='rmsq', queue=0xe16c4)
@1,636,787us: [+0 T:0x4001fdf0 S:0xbebd785c] OC - Comm_locate> return (0)
@1,636,996us: [+0 T:0x4001fdf0 S:0xbebd7894] CE - checkServer(0xe16b8)
@1,637,172us: [+0 T:0x4001fdf0 S:0xbebd7864] OC - Comm_put> Enter(queue=0x0, msg=0x42d4b880)
@1,637,388us: [+0 T:0x4001fdf0 S:0xbebd7864] OC - Comm_put> return (0)
@1,637,590us: [+0 T:0x4001fdf0 S:0xbebd785c] OC - Comm_get> Enter(queue=0x10001, msg=0xbebd7900, timeout=-1)
@1,637,900us: [+0 T:0x4001fdf0 S:0xbebd785c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@1,638,105us: [+0 T:0x4001fdf0 S:0xbebd77fc] OC - Comm_put> Enter(queue=0x0, msg=0x42d4b880)
@1,638,319us: [+0 T:0x4001fdf0 S:0xbebd77fc] OC - Comm_put> return (0)
@1,638,516us: [+0 T:0x4001fdf0 S:0xbebd77f4] OC - Comm_get> Enter(queue=0x10001, msg=0xbebd7894, timeout=-1)
@1,638,818us: [+0 T:0x4001fdf0 S:0xbebd77f4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @0,760,953tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 6
[DSP] @0,763,113tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 5
[DSP] @0,763,168tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@1,639,920us: [+0 T:0x4001fdf0 S:0xbebd782c] CE - Engine_fwriteTrace> returning count [294]
@1,640,082us: [+0 T:0x4001fdf0 S:0xbebd7894] CE - Engine_open> return(923320)
@2,719,602us: [+2 T:0x41498490 S:0x41497c24] ti.sdo.dmai - [Display] Video output set to size 1280x720 pitch 1280
@2,726,215us: [+2 T:0x41498490 S:0x41497aac] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers
@2,726,818us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43636000, size=4)
@2,727,020us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43636000, size=4)
@2,727,189us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@2,727,361us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43636000) = 0x87000000.
@2,727,535us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> Enter(virtAddr=0x43636000, size=4, physAddr=0x87000000)
@2,744,716us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> creating new contigBuf object
@2,744,894us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> Enter(0x10)
@2,745,059us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> return (0xe16e8)
@2,745,213us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> returning: cb->phys=0x87000000, cb->size=4, cb->virt=0x43636000
@2,745,365us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> return (0x87000000)
@2,745,508us: [+2 T:0x41498490 S:0x41497ab4] ti.sdo.dmai - [Buffer] Set user pointer 0x43636000 (physical 0x87000000)
@3,073,089us: [+2 T:0x41498490 S:0x41497ad4] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x43636000 has physical address 0x87000000
@3,073,643us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43a2b000, size=4)
@3,073,844us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43a2b000, size=4)
@3,074,008us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@3,074,182us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43a2b000) = 0x86c00000.
@3,074,359us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> Enter(virtAddr=0x43a2b000, size=4, physAddr=0x86c00000)
@3,074,522us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> creating new contigBuf object
@3,074,668us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> Enter(0x10)
@3,074,829us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> return (0xd99b0)
@3,074,981us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> returning: cb->phys=0x86c00000, cb->size=4, cb->virt=0x43a2b000
@3,075,136us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> return (0x86c00000)
@3,075,288us: [+2 T:0x41498490 S:0x41497ab4] ti.sdo.dmai - [Buffer] Set user pointer 0x43a2b000 (physical 0x86c00000)
@3,403,043us: [+2 T:0x41498490 S:0x41497ad4] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x43a2b000 has physical address 0x86c00000
@3,403,614us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43e20000, size=4)
@3,403,808us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43e20000, size=4)
@3,403,969us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> returning physAddr=0x0
@3,404,139us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43e20000) = 0x86800000.
@3,404,311us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> Enter(virtAddr=0x43e20000, size=4, physAddr=0x86800000)
@3,404,470us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> creating new contigBuf object
@3,404,610us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> Enter(0x10)
@3,404,762us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> return (0xd99c8)
@3,404,909us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> returning: cb->phys=0x86800000, cb->size=4, cb->virt=0x43e20000
@3,405,061us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> return (0x86800000)
@3,405,208us: [+2 T:0x41498490 S:0x41497ab4] ti.sdo.dmai - [Buffer] Set user pointer 0x43e20000 (physical 0x86800000)
@3,732,889us: [+2 T:0x41498490 S:0x41497ad4] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x43e20000 has physical address 0x86800000
Video STD end
Display thread ready
@11,046,378us: [+0 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> enter
@11,048,212us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x63a64()...
@11,048,417us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x77f00()...
@11,048,584us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x79c20()...
@11,048,775us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> Enter(0xd9430, 0x18)
@11,048,953us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> return (0x1)
@11,049,108us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> Enter(0xd9450, 0x18)
@11,049,267us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> return (0x1)
@11,056,726us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> Enter(0xd9470, 0x18)
@11,056,923us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> return (0x1)
@11,057,088us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x822c4()...
@11,057,247us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x7c78c()...
@11,057,403us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x7d360()...
@11,057,558us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x7fa98()...
@11,057,710us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x7d714()...
@11,057,859us: [+0 T:0x4001fdf0 S:0xbebd7544] OP - doCmd> Enter (cmdId=3, proc=0x0)
@11,058,007us: [+0 T:0x4001fdf0 S:0xbebd7534] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91c0]
@11,058,188us: [+0 T:0x4001fdf0 S:0xbebd7544] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91c0]
@11,058,349us: [+0 T:0x4001fdf0 S:0xbebd7524] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91d8] timeout[0xffffffff]
@11,058,549us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91c0] status[0]
@11,058,731us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Exit (result=3)
@11,058,887us: [+0 T:0x40c98490 S:0x40c97d54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91d8]
@11,059,068us: [+0 T:0x40c98490 S:0x40c97d64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91d8]
@11,059,478us: [+0 T:0x4001fdf0 S:0xbebd7524] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91d8] status[0]
@11,059,680us: [+0 T:0x4001fdf0 S:0xbebd7544] OP - doCmd> Exit (result=1)
@11,059,835us: [+0 T:0x4001fdf0 S:0xbebd754c] OT - Thread_delete> Enter (task=0xd9210)
@11,060,036us: [+4 T:0x4001fdf0 S:0xbebd754c] OT - Thread_delete> pthread_cancel (0x0)
@11,060,422us: [+4 T:0x4001fdf0 S:0xbebd754c] OT - Thread_delete> pthread_join (0x0)
@11,060,623us: [+0 T:0x4001fdf0 S:0xbebd752c] OM - Memory_free> Enter(0xd9210, 0x64)
@11,060,791us: [+0 T:0x4001fdf0 S:0xbebd752c] OM - Memory_free> return (0x1)
@11,060,965us: [+0 T:0x4001fdf0 S:0xbebd7564] OT - Thread_delete> Exit (task=0xd9210)
@11,061,121us: [+0 T:0x4001fdf0 S:0xbebd7554] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0xd91c0]
@11,061,305us: [+0 T:0x4001fdf0 S:0xbebd7534] OM - Memory_free> Enter(0xd91c0, 0x14)
@11,061,476us: [+0 T:0x4001fdf0 S:0xbebd7534] OM - Memory_free> return (0x1)
@11,061,630us: [+0 T:0x4001fdf0 S:0xbebd7564] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@11,061,778us: [+0 T:0x4001fdf0 S:0xbebd7554] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0xd91d8]
@11,061,929us: [+0 T:0x4001fdf0 S:0xbebd7534] OM - Memory_free> Enter(0xd91d8, 0x14)
@11,062,083us: [+0 T:0x4001fdf0 S:0xbebd7534] OM - Memory_free> return (0x1)
@11,062,232us: [+0 T:0x4001fdf0 S:0xbebd7564] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@11,062,376us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> Enter(0xd91f0, 0x18)
@11,062,531us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> return (0x1)
@11,062,684us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x81dd4()...
@11,062,874us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x7f54c()...
@11,063,042us: [+0 T:0x4001fdf0 S:0xbebd7554] OM - Memory_free> Enter(0xd9140, 0x18)
@11,063,212us: [+0 T:0x4001fdf0 S:0xbebd7554] OM - Memory_free> return (0x1)
@11,063,369us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x806a0()...
@11,063,538us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> Enter(0xd90f0, 0x18)
@11,063,704us: [+0 T:0x4001fdf0 S:0xbebd7544] OM - Memory_free> return (0x1)
@11,063,860us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x82770()...
@11,064,014us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x83324()...
@11,064,166us: [+2 T:0x4001fdf0 S:0xbebd7574] OG - Global_exit> calling function *0x826d0()...