Decode demo started. @0,657,125us: [+4 T:0x4001fdf0 S:0xbec37914] OG - Global_init> This program was built with the following packages: @0,657,673us: [+4 T:0x4001fdf0 S:0xbec37914] 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,657,894us: [+4 T:0x4001fdf0 S:0xbec37914] 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,658,051us: [+4 T:0x4001fdf0 S:0xbec37914] 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,1297253287000] @0,658,297us: [+4 T:0x4001fdf0 S:0xbec37914] 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,658,445us: [+4 T:0x4001fdf0 S:0xbec37914] 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,658,586us: [+4 T:0x4001fdf0 S:0xbec37914] 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,658,728us: [+4 T:0x4001fdf0 S:0xbec37914] 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,658,865us: [+4 T:0x4001fdf0 S:0xbec37914] 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,659,003us: [+4 T:0x4001fdf0 S:0xbec37914] 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,659,145us: [+4 T:0x4001fdf0 S:0xbec37914] OG - package dsplink.gpp (/opt/dvsdk_2_00_00_22_1080p/dsplink-1_61_03-prebuilt/packages/dsplink/gpp/) [5,0,0,1239931267000] @0,659,280us: [+4 T:0x4001fdf0 S:0xbec37914] 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,659,540us: [+4 T:0x4001fdf0 S:0xbec37914] OG - package ti.xdais (/opt/dvsdk_2_00_00_22_1080p/xdais_6_25_01_08/packages/ti/xdais/) [1,2,1,0] @0,659,694us: [+4 T:0x4001fdf0 S:0xbec37914] 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,659,839us: [+4 T:0x4001fdf0 S:0xbec37914] 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,659,981us: [+4 T:0x4001fdf0 S:0xbec37914] 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,660,120us: [+4 T:0x4001fdf0 S:0xbec37914] 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,660,259us: [+4 T:0x4001fdf0 S:0xbec37914] 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,660,395us: [+4 T:0x4001fdf0 S:0xbec37914] OG - package gnu.targets (/opt/dvsdk_2_00_00_22_1080p/xdctools_3_10_03/packages/gnu/targets/) [1,0,1,1225517427930] @0,660,530us: [+4 T:0x4001fdf0 S:0xbec37914] 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,660,668us: [+4 T:0x4001fdf0 S:0xbec37914] 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,660,805us: [+4 T:0x4001fdf0 S:0xbec37914] 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,660,944us: [+4 T:0x4001fdf0 S:0xbec37914] 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,661,141us: [+4 T:0x4001fdf0 S:0xbec37914] 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,661,346us: [+4 T:0x4001fdf0 S:0xbec37914] 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,661,501us: [+4 T:0x4001fdf0 S:0xbec37914] 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,661,644us: [+4 T:0x4001fdf0 S:0xbec37914] 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,661,786us: [+4 T:0x4001fdf0 S:0xbec37914] 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,661,921us: [+4 T:0x4001fdf0 S:0xbec37914] 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,662,059us: [+4 T:0x4001fdf0 S:0xbec37914] 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,662,200us: [+4 T:0x4001fdf0 S:0xbec37914] 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,1297253287000] @0,662,342us: [+4 T:0x4001fdf0 S:0xbec37914] 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,662,485us: [+4 T:0x4001fdf0 S:0xbec37914] 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,662,624us: [+4 T:0x4001fdf0 S:0xbec37914] 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,662,762us: [+4 T:0x4001fdf0 S:0xbec37914] 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,670,082us: [+4 T:0x4001fdf0 S:0xbec37914] 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,670,257us: [+4 T:0x4001fdf0 S:0xbec37914] 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,670,404us: [+4 T:0x4001fdf0 S:0xbec37914] 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,670,544us: [+4 T:0x4001fdf0 S:0xbec37914] 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,670,682us: [+4 T:0x4001fdf0 S:0xbec37914] 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,670,815us: [+4 T:0x4001fdf0 S:0xbec37914] 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,670,954us: [+4 T:0x4001fdf0 S:0xbec37914] OG - package ti.sdo.dmai (/opt/dvsdk_2_00_00_22_1080p/dmai_1_20_00_06/packages/ti/sdo/dmai/) [1,0,0,1297264327000] @0,671,088us: [+4 T:0x4001fdf0 S:0xbec37914] OG - package ti.sdo.simplewidget (/opt/dvsdk_2_00_00_22_1080p/swpackages/ti/sdo/simplewidget/) [] @0,671,224us: [+4 T:0x4001fdf0 S:0xbec37914] 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,671,360us: [+4 T:0x4001fdf0 S:0xbec37914] 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,671,497us: [+4 T:0x4001fdf0 S:0xbec37914] OG - package decode_config (/root/nir_build/Build/MGU/ILN/MGU/decode/decode_config/) [] @0,671,791us: [+0 T:0x4001fdf0 S:0xbec3791c] OG - Global_atexit> enter (fxn=0x8339c) @0,671,977us: [+0 T:0x4001fdf0 S:0xbec3791c] OG - Global_atexit> enter (fxn=0x827e8) @0,672,222us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> Enter(0x18) @0,672,386us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> return (0xd90f0) @0,672,814us: [+0 T:0x4001fdf0 S:0xbec3790c] OG - Global_atexit> enter (fxn=0x80718) @0,673,069us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> Enter(0x18) @0,673,244us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> return (0xd9140) @0,673,393us: [+0 T:0x4001fdf0 S:0xbec37904] OG - Global_atexit> enter (fxn=0x7f5c4) @0,673,556us: [+0 T:0x4001fdf0 S:0xbec3790c] OG - Global_atexit> enter (fxn=0x81e4c) @0,673,794us: [+0 T:0x4001fdf0 S:0xbec37904] ti.sdo.ce.osal.Sem - Sem_create> count: 0 @0,673,948us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> Enter(0x14) @0,674,095us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> return (0xd91c0) @0,674,265us: [+0 T:0x4001fdf0 S:0xbec37904] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0xd91c0] @0,674,413us: [+0 T:0x4001fdf0 S:0xbec37904] ti.sdo.ce.osal.Sem - Sem_create> count: 0 @0,674,547us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> Enter(0x14) @0,674,689us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> return (0xd91d8) @0,674,827us: [+0 T:0x4001fdf0 S:0xbec37904] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0xd91d8] @0,674,961us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> Enter(0x18) @0,675,099us: [+0 T:0x4001fdf0 S:0xbec378ec] OM - Memory_alloc> return (0xd91f0) @0,675,241us: [+0 T:0x4001fdf0 S:0xbec378e4] OT - Thread_create> Enter (fxn=0x7dd9c, attrs=0x0) @0,675,382us: [+0 T:0x4001fdf0 S:0xbec378cc] OM - Memory_alloc> Enter(0x64) @0,675,521us: [+0 T:0x4001fdf0 S:0xbec378cc] OM - Memory_alloc> return (0xd9210) @0,676,274us: [+0 T:0x4001fdf0 S:0xbec378e4] OT - Thread_create> Exit (task=0xd9210) @0,676,466us: [+0 T:0x4001fdf0 S:0xbec3791c] OG - Global_atexit> enter (fxn=0x7d78c) @0,676,645us: [+0 T:0x4001fdf0 S:0xbec3791c] OG - Global_atexit> enter (fxn=0x7fb10) @0,676,895us: [+0 T:0x4001fdf0 S:0xbec37904] ti.sdo.ce.alg - ALG_init> Enter @0,677,051us: [+0 T:0x4001fdf0 S:0xbec378f4] OG - Global_atexit> enter (fxn=0x7d3d8) @0,677,207us: [+0 T:0x4001fdf0 S:0xbec37924] ti.sdo.ce.alg - ALG_init> Exit @0,677,344us: [+0 T:0x4001fdf0 S:0xbec3791c] OG - Global_atexit> enter (fxn=0x7c804) @0,677,505us: [+0 T:0x4001fdf0 S:0xbec378f4] OM - Memory_alloc> Enter(0x18) @0,677,658us: [+0 T:0x4001fdf0 S:0xbec378f4] OM - Memory_alloc> return (0xd93f0) @0,677,805us: [+0 T:0x4001fdf0 S:0xbec3791c] OG - Global_atexit> enter (fxn=0x8233c) @0,678,039us: [+6 T:0x4001fdf0 S:0xbec37914] CE - Engine_init> CE debugging on (CE_DEBUG=3; allowed CE_DEBUG levels: 1=min, 2=good, 3=max) @0,678,204us: [+0 T:0x4001fdf0 S:0xbec37904] OG - Global_atexit> enter (fxn=0x79c98) @0,678,356us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> Enter(0x18) @0,678,507us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> return (0xd9430) @0,678,650us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> Enter(0x18) @0,678,794us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> return (0xd9450) @0,678,936us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> Enter(0x18) @0,679,081us: [+0 T:0x4001fdf0 S:0xbec378e4] OM - Memory_alloc> return (0xd9470) @0,679,320us: [+0 T:0x4001fdf0 S:0xbec3791c] CS - Server_init() @0,679,842us: [+0 T:0x4001fdf0 S:0xbec3791c] CS - Server_init> Global_useLinkArbiter = 0 @0,680,003us: [+0 T:0x4001fdf0 S:0xbec3791c] OG - Global_atexit> enter (fxn=0x77f78) @0,680,255us: [+0 T:0x4001fdf0 S:0xbec3792c] OG - Global_atexit> enter (fxn=0x63adc) TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil) Video STD started @0,683,369us: [+1 T:0x40c98490 S:0x40c97d64] OP - daemon> thread created. @0,683,575us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Enter (proc=0x40c97dd8) @0,683,738us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91c0] timeout[0xffffffff] @0,684,636us: [+0 T:0x42498490 S:0x42497bec] OM - Memory_alloc> Enter(0x7a120) @0,684,885us: [+0 T:0x42498490 S:0x42497ba4] OM - Memory_contigAlloc> Enter(size=500000, align=-1, cached=FALSE, heap=FALSE) @0,685,317us: [+4 T:0x42498490 S:0x42497ba4] OM - Memory_contigAlloc> CMEM_alloc(500000) = 0x42499000. @0,685,528us: [+4 T:0x42498490 S:0x42497ba4] OM - Memory_contigAlloc> CMEM_getPhys(0x42499000) = 0x886b1000. @0,685,695us: [+1 T:0x42498490 S:0x42497b5c] OM - Memory__addContigBuf> Enter(virtAddr=0x42499000, size=500000, physAddr=0x886b1000) @0,685,853us: [+1 T:0x42498490 S:0x42497b5c] OM - Memory__addContigBuf> creating new contigBuf object @0,685,994us: [+0 T:0x42498490 S:0x42497b44] OM - Memory_alloc> Enter(0x10) @0,686,147us: [+0 T:0x42498490 S:0x42497b44] OM - Memory_alloc> return (0xd9bc0) @0,686,290us: [+1 T:0x42498490 S:0x42497b5c] OM - Memory__addContigBuf> returning: cb->phys=0x886b1000, cb->size=500000, cb->virt=0x42499000 @0,686,443us: [+0 T:0x42498490 S:0x42497ba4] OM - Memory_contigAlloc> return (0x42499000) @0,686,586us: [+0 T:0x42498490 S:0x42497bec] OM - Memory_alloc> return (0x42499000) @0,686,733us: [+0 T:0x42498490 S:0x42497bcc] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x42499000, size=4) @0,686,884us: [+1 T:0x42498490 S:0x42497bcc] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x42499000, size=4) @0,687,028us: [+1 T:0x42498490 S:0x42497bcc] OM - Memory__getPhysicalAddress> found in cb(Sc=0x42499000, Ec=0x42513120, Ss=0x42499000, Es=0x42499004, PSc=0x886b1000) @0,687,188us: [+1 T:0x42498490 S:0x42497bcc] OM - Memory__getPhysicalAddress> returning physAddr=0x886b1000 @0,687,332us: [+0 T:0x42498490 S:0x42497bcc] OM - Memory_getBufferPhysicalAddress> return (0x886b1000) @0,687,474us: [+2 T:0x42498490 S:0x42497c04] ti.sdo.dmai - [Buffer] Alloc Buffer of size 500000 at 0x42499000 (0x886b1000 phys) @0,687,702us: [+0 T:0x42498490 S:0x42497bcc] CE - Engine_open> Enter('decode', 0x0, 0x42497c3c) @0,687,875us: [+0 T:0x42498490 S:0x42497bb4] OM - Memory_alloc> Enter(0x2c) @0,688,033us: [+0 T:0x42498490 S:0x42497bb4] OM - Memory_alloc> return (0xd9bd8) @0,693,228us: [+0 T:0x42498490 S:0x42497bcc] CE - rserverOpen('decodeCombo.x64P'), count = 0 @0,693,407us: [+0 T:0x42498490 S:0x42497b94] OP - Processor_create> Enter(imageName='decodeCombo.x64P', linkCfg='(null)', attrs=0x42497c20) @0,693,847us: [+0 T:0x42498490 S:0x42497b7c] OM - Memory_alloc> Enter(0x24) @0,694,038us: [+0 T:0x42498490 S:0x42497b7c] OM - Memory_alloc> return (0xd9c08) @0,694,196us: [+0 T:0x42498490 S:0x42497b74] OP - doCmd> Enter (cmdId=1, proc=0xd9c08) @0,694,342us: [+0 T:0x42498490 S:0x42497b64] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91c0] @0,694,544us: [+0 T:0x42498490 S:0x42497b74] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91c0] @0,694,706us: [+0 T:0x42498490 S:0x42497b54] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91d8] timeout[0xffffffff] @0,694,930us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91c0] status[0] @0,695,108us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Exit (result=1) @0,695,260us: [+0 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Enter(proc=0xd9c08) @0,695,404us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Initializing DSP PROC... @0,695,556us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'decodeCombo.x64P'] @0,695,710us: [+0 T:0x40c98490 S:0x40c97d4c] OM - Memory_alloc> Enter(0xe0) @0,695,868us: [+0 T:0x40c98490 S:0x40c97d4c] OM - Memory_alloc> return (0xd9c30) @0,696,020us: [+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 @0,696,197us: [+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 @0,696,365us: [+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 @0,696,591us: [+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 @0,696,769us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> DODSPCTRL was=1; now=0 @0,700,060us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Attaching to DSP PROC... @0,712,810us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Opening MSGQ pool... @0,713,389us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Loading decodeCombo.x64P on DSP (1 args)... @0,887,220us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Starting DSP PROC... @0,963,714us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> Opening remote transport... @0,999,975us: [+2 T:0x40c98490 S:0x40c97d64] OP - Processor_create_d> return (1) @1,000,176us: [+0 T:0x40c98490 S:0x40c97d54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91d8] @1,000,390us: [+0 T:0x42498490 S:0x42497b54] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91d8] status[0] @1,000,564us: [+0 T:0x42498490 S:0x42497b74] OP - doCmd> Exit (result=1) @1,000,709us: [+0 T:0x42498490 S:0x42497b94] OP - Processor_create> return (0xd9c08) @1,000,858us: [+0 T:0x42498490 S:0x42497bcc] CE - rserverOpen('decodeCombo.x64P'): 0xd83e8 done. @1,001,012us: [+0 T:0x42498490 S:0x42497bb4] OM - Memory_alloc> Enter(0x24) @1,001,167us: [+0 T:0x42498490 S:0x42497bb4] OM - Memory_alloc> return (0xd9e68) @1,001,342us: [+0 T:0x42498490 S:0x42497ba4] OC - Comm_create> Enter(queueName='decode_878_0', queue=0xd9be8, attrs=0x0) @1,001,499us: [+0 T:0x42498490 S:0x42497b8c] OM - Memory_alloc> Enter(0x4) @1,001,652us: [+0 T:0x42498490 S:0x42497b8c] OM - Memory_alloc> return (0xd9e90) @1,002,123us: [+0 T:0x42498490 S:0x42497ba4] OC - Comm_create> return (0xd9e90) @1,002,324us: [+0 T:0x42498490 S:0x42497bac] OM - Memory_free> Enter(0xd9e68, 0x24) @1,002,560us: [+0 T:0x42498490 S:0x42497bac] OM - Memory_free> return (0x1) @1,002,727us: [+0 T:0x42498490 S:0x42497bac] OC - Comm_alloc> Enter(poolId=0x0, msg=0xd9bf4, size=576) @1,002,939us: [+0 T:0x42498490 S:0x42497bac] OC - Comm_alloc> msg=0x42d4a880, returning (0) @1,003,108us: [+0 T:0x42498490 S:0x42497b94] OC - Comm_locate> Enter(queueName='rmsq', queue=0xd9be4) @1,003,461us: [+0 T:0x40c98490 S:0x40c97d64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91d8] @1,003,664us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Enter (proc=0x40c97dd8) @1,003,824us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91c0] timeout[0xffffffff] @1,004,201us: [+0 T:0x42498490 S:0x42497b94] OC - Comm_locate> return (0) @1,004,403us: [+0 T:0x42498490 S:0x42497bcc] CE - checkServer(0xd9bd8) @1,004,584us: [+0 T:0x42498490 S:0x42497b9c] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,004,805us: [+0 T:0x42498490 S:0x42497b9c] OC - Comm_put> return (0) @1,005,013us: [+0 T:0x42498490 S:0x42497b94] OC - Comm_get> Enter(queue=0x10000, msg=0x42497c38, timeout=-1) @1,005,327us: [+0 T:0x42498490 S:0x42497b94] OC - Comm_get> MSGQ_get() status=0x8000, return (0) @1,005,524us: [+0 T:0x42498490 S:0x42497bcc] CE - rmsInit> RMS initialized(0xd9bd8); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3 @1,005,695us: [+0 T:0x42498490 S:0x42497ba4] CE - Engine_setTrace> Enter(engine=0xd9bd8, mask='*+01234567,GT_prefix=12345,GT_time=3') @1,005,877us: [+1 T:0x42498490 S:0x42497ba4] CE - Engine_setTrace> Requesting DSP set trace ... @1,006,023us: [+0 T:0x42498490 S:0x42497b74] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,006,231us: [+0 T:0x42498490 S:0x42497b74] OC - Comm_put> return (0) @1,006,400us: [+0 T:0x42498490 S:0x42497b6c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497bec, timeout=-1) @1,008,856us: [+0 T:0x42498490 S:0x42497b6c] OC - Comm_get> MSGQ_get() status=0x8000, return (0) @1,009,067us: [+0 T:0x42498490 S:0x42497ba4] CE - Engine_setTrace> return(0) @1,009,251us: [+0 T:0x42498490 S:0x42497b34] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,009,598us: [+0 T:0x42498490 S:0x42497b34] OC - Comm_put> return (0) @1,025,925us: [+0 T:0x42498490 S:0x42497b2c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497bcc, timeout=-1) @1,026,271us: [+0 T:0x42498490 S:0x42497b2c] OC - Comm_get> MSGQ_get() status=0x8000, return (0) [DSP] @0,098,833tk: [+0 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3') [DSP] @0,098,944tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> This program was built with the following packages: [DSP] @0,099,020tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.targets.rts6000 (/opt/dvsdk_2_00_00_22_1080p/xdctools_3_10_03/packages/ti/targets/rts6000/) [1,0,0,0,1225517497925] [DSP] @0,099,131tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,099,250tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,099,368tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,099,485tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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,1297253287000] [DSP] @0,099,602tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.hdvicp (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/hdvicp/) [1,0,0,1289818336000] [DSP] @0,099,718tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,099,832tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.ires.hdvicp (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/ires/hdvicp/) [1,0,1,1240266763264] [DSP] @0,099,951tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.rtdx (/opt/dvsdk_2_00_00_22_1080p/bios_5_33_06/packages/ti/rtdx/) [2,0,0,4,1220389102790] [DSP] @0,100,048tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.psl (/opt/dvsdk_2_00_00_22_1080p/bios_5_33_06/packages/ti/psl/) [5,0,0,0,0] [DSP] @0,100,138tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.pmi (/opt/dvsdk_2_00_00_22_1080p/bios_5_33_06/packages/ti/pmi/) [0,0,0,0,1247787708590] [DSP] @0,100,241tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.bios (/opt/dvsdk_2_00_00_22_1080p/bios_5_33_06/packages/ti/bios/) [5,2,5,16,1247787696953] [DSP] @0,100,339tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.dskt2 (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/dskt2/) [1,0,4,1240266678055] [DSP] @0,100,452tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.hdintc (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/hdintc/) [1,0,4,1240266707594] [DSP] @0,100,566tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,100,683tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.edma3.rm (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/fctools/packages/ti/sdo/edma3/rm/) [1,3,4,1225865844769] [DSP] @0,100,800tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.ires.nullresource (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/ires/nullresource/) [1,0,0,1240266782634] [DSP] @0,100,926tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.rman (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/rman/) [2,0,0,1240266813533] [DSP] @0,101,038tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.edma3 (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/edma3/) [2,0,0,1240266681138] [DSP] @0,101,151tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.ires.edma3chan (/opt/dvsdk_2_00_00_22_1080p/framework_components_2_23_01/packages/ti/sdo/fc/ires/edma3chan/) [1,0,0,1240266737833] [DSP] @0,101,273tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.global (/opt/dvsdk_2_00_00_22_1080p/@1,037,345us: [+0 T:0x42498490 S:0x42497b34] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,037,581us: [+0 T:0x42498490 S:0x42497b34] OC - Comm_put> return (0) @1,037,787us: [+0 T:0x42498490 S:0x42497b2c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497bcc, timeout=-1) @1,038,101us: [+0 T:0x42498490 S:0x42497b2c] OC - Comm_get> MSGQ_get() status=0x8000, return (0) codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464] [DSP] @0,101,384tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,101,479tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,101,596tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,101,709tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.xdais (/opt/dvsdk_2_00_00_22_1080p/xdais_6_25_01_08/packages/ti/xdais/) [1,2,1,0] [DSP] @0,101,802tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,101,909tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.ipc.dsplink.dsp (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1240276720026] [DSP] @0,102,029tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,102,142tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,102,255tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package dsplink.dsp (/opt/dvsdk_2_00_00_22_1080p/dsplink-1_61_03-prebuilt/packages/dsplink/dsp/) [1,4,0,1239931280000] [DSP] @0,102,362tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.bios.utils (/opt/dvsdk_2_00_00_22_1080p/biosutils_1_01_00/packages/ti/bios/utils/) [2,0,1,0,0] [DSP] @0,102,462tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,102,567tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,102,676tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,102,783tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.osal.bios (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/osal/bios/) [2,0,1,1240276734107] [DSP] @0,102,897tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,103,003tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.ipc.bios (/opt/dvsdk_2_00_00_22_1080p/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1240276705217] [DSP] @0,103,116tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,103,222tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,103,324tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,103,435tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,103,545tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,103,667tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,103,777tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codec@1,049,038us: [+0 T:0x42498490 S:0x42497b34] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,049,267us: [+0 T:0x42498490 S:0x42497b34] OC - Comm_put> return (0) @1,049,560us: [+0 T:0x42498490 S:0x42497b2c] OC - Comm_get> Enter(queue=0x10000, msg=0x42497bcc, timeout=-1) @1,049,878us: [+0 T:0x42498490 S:0x42497b2c] OC - Comm_get> MSGQ_get() status=0x8000, return (0) s.aachedec.ce (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/codecs/aachedec/ce/) [1,0,0,1289818321000] [DSP] @0,103,899tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,104,009tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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] [DSP] @0,104,130tk: [+4 T:0x8ba0006c S:0x8ba03fe4] 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,1297253287000] [DSP] @0,104,250tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.servers.decode (/opt/dvsdk_2_00_00_22_1080p/dm6467_dvsdk_combos_2_05/packages/ti/sdo/servers/decode/) [] [DSP] @0,104,357tk: [+0 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> return [DSP] @0,106,616tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5 [DSP] @0,106,685tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032 [DSP] @0,171,542tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5 [DSP] @0,171,609tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032 [DSP] @0,198,661tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5 [DSP] @0,198,733tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032 @1,054,149us: [+0 T:0x42498490 S:0x42497b64] CE - Engine_fwriteTrace> returning count [9922] @1,054,306us: [+0 T:0x42498490 S:0x42497bcc] CE - Engine_open> return(891864) @1,054,595us: [+0 T:0x42498490 S:0x42497b1c] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0xd9bd8, name='h264dec', params=0x42497dac) @1,054,804us: [+0 T:0x42498490 S:0x42497aec] CV - VISA_create(0xd9bd8, 'h264dec', 0x42497dac, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2') @1,054,974us: [+0 T:0x42498490 S:0x424979ec] CV - VISA_create2(0xd9bd8, 'h264dec', 0x42497dac, 0x1c, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2') @1,055,158us: [+0 T:0x42498490 S:0x424979d4] OM - Memory_alloc> Enter(0x30) @1,055,319us: [+0 T:0x42498490 S:0x424979d4] OM - Memory_alloc> return (0xda070) @1,055,469us: [+0 T:0x42498490 S:0x42497974] CE - Engine_createNode(0xd9bd8, 'h264dec', 2484, 0x42497dac, 0x1c, 0x42497ae4) @1,055,630us: [+0 T:0x42498490 S:0x42497974] CE - Engine> allocNode Enter(engine=0xd9bd8, impId='h264dec') @1,055,777us: [+0 T:0x42498490 S:0x4249795c] OM - Memory_alloc> Enter(0x20) @1,055,927us: [+0 T:0x42498490 S:0x4249795c] OM - Memory_alloc> return (0xd9e68) @1,056,100us: [+0 T:0x42498490 S:0x42497974] CE - Engine> allocNode(). Calling Comm_create(gppfromnode_878_1, 0xd9e70, NULL) @1,056,252us: [+0 T:0x42498490 S:0x4249794c] OC - Comm_create> Enter(queueName='gppfromnode_878_1', queue=0xd9e70, attrs=0x0) @1,056,461us: [+0 T:0x42498490 S:0x42497934] OM - Memory_alloc> Enter(0x4) @1,056,629us: [+0 T:0x42498490 S:0x42497934] OM - Memory_alloc> return (0xda0a8) @1,057,079us: [+0 T:0x42498490 S:0x4249794c] OC - Comm_create> return (0xda0a8) @1,057,290us: [+0 T:0x42498490 S:0x42497954] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,057,514us: [+0 T:0x42498490 S:0x42497954] OC - Comm_put> return (0) @1,057,683us: [+0 T:0x42498490 S:0x4249794c] OC - Comm_get> Enter(queue=0x10000, msg=0x424979fc, timeout=-1) @1,133,686us: [+0 T:0x42498490 S:0x4249794c] OC - Comm_get> MSGQ_get() status=0x8000, return (0) @1,134,046us: [+0 T:0x42498490 S:0x4249794c] OC - Comm_delete> Enter (comm=0xda0a8) @1,138,403us: [+0 T:0x42498490 S:0x4249792c] OM - Memory_free> Enter(0xda0a8, 0x4) @1,138,762us: [+0 T:0x42498490 S:0x4249792c] OM - Memory_free> return (0x1) @1,140,871us: [+0 T:0x42498490 S:0x4249796c] OC - Comm_delete> return @1,141,255us: [+0 T:0x42498490 S:0x42497954] OM - Memory_free> Enter(0xd9e68, 0x20) @1,143,301us: [+0 T:0x42498490 S:0x42497954] OM - Memory_free> return (0x1) @1,143,619us: [+6 T:0x42498490 S:0x42497974] CE - Engine_createNode> Remote node creation FAILED (0x80008008). @1,145,671us: [+0 T:0x42498490 S:0x424978dc] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,146,052us: [+0 T:0x42498490 S:0x424978dc] OC - Comm_put> return (0) @1,148,145us: [+0 T:0x42498490 S:0x424978d4] OC - Comm_get> Enter(queue=0x10000, msg=0x42497974, timeout=-1) @1,150,568us: [+0 T:0x42498490 S:0x424978d4] OC - Comm_get> MSGQ_get() status=0x8000, return (0) [DSP] @0,217,792tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 0 [DSP] @0,217,864tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> Enter(size=0x18) [DSP] @0,217,932tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> return (0x8fa718a0) [DSP] @0,217,994tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> Enter(size=0xa) [DSP] @0,218,054tk: [+0 T:0x8ba0006c S:0x8ba03f1c] OM - Memory_alloc> return (0x8fa718b8) [DSP] @0,218,120tk: [+0 T:0x8ba0006c S:0x8ba03ee4] OM - Memory_alloc> Enter(size=0x20) [DSP] @0,218,177tk: [+0 T:0x8ba0006c S:0x8ba03ee4] OM - Memory_alloc> return (0x8fa718c8) [DSP] @0,218,240tk: [+0 T:0x8ba0006c S:0x8ba03eb4] OM - Memory_alloc> Enter(size=0x24) [DSP] @0,218,297tk: [+0 T:0x8ba0006c S:0x8ba03eb4] OM - Memory_alloc> return (0x8fa718e8) [DSP] @0,218,385tk: [+0 T:0x8ba0006c S:0x8ba03ecc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0x0, name='h264dec', params=0x8fe038c0) [DSP] @0,218,481tk: [+0 T:0x8ba0006c S:0x8ba03e94] CV - VISA_create(0x0, 'h264dec', 0x8fe038c0, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2') [DSP] @0,218,586tk: [+0 T:0x8ba0006c S:0x8ba03d84] CV - VISA_create2(0x0, 'h264dec', 0x8fe038c0, 0x1c, 0x2484, 'ti.sdo.ce.video2.IVIDDEC2') [DSP] @0,218,690tk: [+0 T:0x8ba0006c S:0x8ba03d1c] CE - Engine_open> Enter('local', 0x8ba03d6c, 0x8fe038c0) [DSP] @0,218,769tk: [+0 T:0x8ba0006c S:0x8ba03cfc] OM - Memory_alloc> Enter(size=0x2c) [DSP] @0,218,828tk: [+0 T:0x8ba0006c S:0x8ba03cfc] OM - Memory_alloc> return (0x8fa71958) [DSP] @0,218,900tk: [+0 T:0x8ba0006c S:0x8ba03d1c] CE - Engine_open> return(-1884874408) [DSP] @0,218,974tk: [+0 T:0x8ba0006c S:0x8ba03d64] OM - Memory_alloc> Enter(size=0x30) [DSP] @0,219,031tk: [+0 T:0x8ba0006c S:0x8ba03d64] OM - Memory_alloc> return (0x8fa71988) [DSP] @0,219,094tk: [+0 T:0x8ba0006c S:0x8ba03d3c] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fa6b39c, idma3Fxns=0x0, iresFxns=0x8fa6b374, params=0x8fe038c0, attrs=0x8ba03e80) [DSP] @0,219,214tk: [+0 T:0x8ba0006c S:0x8ba03d1c] OM - Memory_alloc> Enter(size=0x10) [DSP] @0,219,271tk: [+0 T:0x8ba0006c S:0x8ba03d1c] OM - Memory_alloc> return (0x8fa719b8) [DSP] @0,389,712tk: [+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,389,879tk: [+0 T:0x8ba0006c S:0x8ba03d1c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x8fa719b8) [DSP] @0,389,955tk: [+0 T:0x8ba0006c S:0x8ba03cec] OM - Memory_free> Enter(addr=0x8fa719b8, size=16) [DSP] @0,390,023tk: [+0 T:0x8ba0006c S:0x8ba03cec] OM - Memory_free> return (0x1) [DSP] @0,390,077tk: [+0 T:0x8ba0006c S:0x8ba03d1c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit [DSP] @0,390,142tk: [+0 T:0x8ba0006c S:0x8ba03d3c] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x0) [DSP] @0,390,210tk: [+2 T:0x8ba0006c S:0x8ba03d84] CV - VISA_create2> FAILED to create local codec. [DSP] @0,390,286tk: [+0 T:0x8ba0006c S:0x8ba03d54] CV - VISA_delete(0x8fa71988) [DSP] @0,390,344tk: [+5 T:0x8ba0006c S:0x8ba03d54] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff) [DSP] @0,390,423tk: [+0 T:0x8ba0006c S:0x8ba03d24] OM - Memory_free> Enter(addr=0x8fa71988, size=48) [DSP] @0,390,491tk: [+0 T:0x8ba0006c S:0x8ba03d24] OM - Memory_free> return (0x1) [DSP] @0,390,547tk: [+0 T:0x8ba0006c S:0x8ba03ecc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x0) [DSP] @0,390,621tk: [+0 T:0x8ba0006c S:0x8ba03ebc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> Enter (handle=0x0) [DSP] @0,390,691tk: [+0 T:0x8ba0006c S:0x8ba03e8c] CV - VISA_delete(0x0) [DSP] @0,390,740tk: [+0 T:0x8ba0006c S:0x8ba03ebc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> return [DSP] @0,390,808tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_free> Enter(addr=0x8fa718e8, size=36) [DSP] @0,390,876tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_free> return (0x1) [DSP] @0,390,930tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_free> Enter(addr=0x8fa718c8, size=32) [DSP] @0,390,997tk: [+0 T:0x8ba0006c S:0x8ba03eac] OM - Memory_free> return (0x1) [DSP] @0,391,054tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free@1,234,118us: [+0 T:0x42498490 S:0x424978dc] OC - Comm_put> Enter(queue=0x0, msg=0x42d4a880) @1,236,485us: [+0 T:0x42498490 S:0x424978dc] OC - Comm_put> return (0) @1,236,815us: [+0 T:0x42498490 S:0x424978d4] OC - Comm_get> Enter(queue=0x10000, msg=0x42497974, timeout=-1) @1,239,079us: [+0 T:0x42498490 S:0x424978d4] OC - Comm_get> MSGQ_get() status=0x8000, return (0) > Enter(addr=0x8fa718b8, size=10) [DSP] @0,391,124tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free> return (0x1) [DSP] @0,391,178tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free> Enter(addr=0x8fa718a0, size=24) [DSP] @0,391,245tk: [+0 T:0x8ba0006c S:0x8ba03f2c] OM - Memory_free> return (0x1) [DSP] @0,423,236tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5 [DSP] @0,423,306tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032 [DSP] @0,628,479tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe038a8, 4056): cmd = 5 [DSP] @0,628,548tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032 @1,253,976us: [+0 T:0x42498490 S:0x4249790c] CE - Engine_fwriteTrace> returning count [4971] @1,256,025us: [+2 T:0x42498490 S:0x42497974] CE - Engine_createNode> Returning 0x0 @1,256,348us: [+2 T:0x42498490 S:0x424979ec] CV - VISA_create2> FAILED to create remote codec (0x8). @1,258,394us: [+0 T:0x42498490 S:0x424979c4] CV - VISA_delete(0xda070) @1,258,706us: [+5 T:0x42498490 S:0x424979c4] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff) @1,260,841us: [+0 T:0x42498490 S:0x424979a4] OM - Memory_free> Enter(0xda070, 0x30) @1,261,165us: [+0 T:0x42498490 S:0x424979a4] OM - Memory_free> return (0x1) @1,263,208us: [+0 T:0x42498490 S:0x42497b1c] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x0) @1,263,530us: [+7 T:0x42498490 S:0x42497b44] ti.sdo.dmai - [Vdec2] Failed to open video decode algorithm Handle Hpd thread ready @1,286,332us: [+0 T:0x4001fdf0 S:0xbec37894] CE - Engine_open> Enter('decode', 0x0, 0xbec37904) @1,289,581us: [+0 T:0x4001fdf0 S:0xbec3787c] OM - Memory_alloc> Enter(0x2c) @1,289,924us: [+0 T:0x4001fdf0 S:0xbec3787c] OM - Memory_alloc> return (0xe16b8) @1,291,971us: [+0 T:0x4001fdf0 S:0xbec37894] CE - rserverOpen('decodeCombo.x64P'), count = 1 @1,292,294us: [+0 T:0x4001fdf0 S:0xbec37894] CE - rserverOpen('decodeCombo.x64P'): 0xd83e8 done. @1,393,427us: [+0 T:0x4001fdf0 S:0xbec3787c] OM - Memory_alloc> Enter(0x24) @1,393,780us: [+0 T:0x4001fdf0 S:0xbec3787c] OM - Memory_alloc> return (0xe16e8) @1,395,856us: [+0 T:0x4001fdf0 S:0xbec3786c] OC - Comm_create> Enter(queueName='decode_878_2', queue=0xe16c8, attrs=0x0) @1,396,192us: [+0 T:0x4001fdf0 S:0xbec37854] OM - Memory_alloc> Enter(0x4) @1,398,247us: [+0 T:0x4001fdf0 S:0xbec37854] OM - Memory_alloc> return (0xe1710) @1,400,962us: [+0 T:0x4001fdf0 S:0xbec3786c] OC - Comm_create> return (0xe1710) @1,403,046us: [+0 T:0x4001fdf0 S:0xbec37874] OM - Memory_free> Enter(0xe16e8, 0x24) @1,403,387us: [+0 T:0x4001fdf0 S:0xbec37874] OM - Memory_free> return (0x1) @1,405,431us: [+0 T:0x4001fdf0 S:0xbec37874] OC - Comm_alloc> Enter(poolId=0x0, msg=0xe16d4, size=576) @1,405,794us: [+0 T:0x4001fdf0 S:0xbec37874] OC - Comm_alloc> msg=0x42d4b880, returning (0) @1,407,848us: [+0 T:0x4001fdf0 S:0xbec3785c] OC - Comm_locate> Enter(queueName='rmsq', queue=0xe16c4) @1,410,645us: [+0 T:0x4001fdf0 S:0xbec3785c] OC - Comm_locate> return (0) @1,412,871us: [+0 T:0x4001fdf0 S:0xbec37894] CE - checkServer(0xe16b8) @1,414,928us: [+0 T:0x4001fdf0 S:0xbec37864] OC - Comm_put> Enter(queue=0x0, msg=0x42d4b880) @1,415,316us: [+0 T:0x4001fdf0 S:0xbec37864] OC - Comm_put> return (0) @1,417,399us: [+0 T:0x4001fdf0 S:0xbec3785c] OC - Comm_get> Enter(queue=0x10001, msg=0xbec37900, timeout=-1) @1,419,811us: [+0 T:0x4001fdf0 S:0xbec3785c] OC - Comm_get> MSGQ_get() status=0x8000, return (0) @1,420,182us: [+0 T:0x4001fdf0 S:0xbec377fc] OC - Comm_put> Enter(queue=0x0, msg=0x42d4b880) @1,422,448us: [+0 T:0x4001fdf0 S:0xbec377fc] OC - Comm_put> return (0) @1,424,520us: [+0 T:0x4001fdf0 S:0xbec377f4] OC - Comm_get> Enter(queue=0x10001, msg=0xbec37894, timeout=-1) @1,424,986us: [+0 T:0x4001fdf0 S:0xbec377f4] OC - Comm_get> MSGQ_get() status=0x8000, return (0) [DSP] @1,048,000tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 6 [DSP] @1,064,543tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8fe048a8, 4056): cmd = 5 [DSP] @1,064,609tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032 @1,433,993us: [+0 T:0x4001fdf0 S:0xbec3782c] CE - Engine_fwriteTrace> returning count [294] @1,434,321us: [+0 T:0x4001fdf0 S:0xbec37894] CE - Engine_open> return(923320) @2,145,213us: [+2 T:0x41498490 S:0x41497c24] ti.sdo.dmai - [Display] Video output set to size 1280x720 pitch 1280 @2,151,916us: [+2 T:0x41498490 S:0x41497aac] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers @2,152,521us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43636000, size=4) @2,152,715us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43636000, size=4) @2,152,875us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> returning physAddr=0x0 @2,153,042us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43636000) = 0x87000000. @2,153,216us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> Enter(virtAddr=0x43636000, size=4, physAddr=0x87000000) @2,153,377us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> creating new contigBuf object @2,153,519us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> Enter(0x10) @2,153,673us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> return (0xe16e8) @2,153,824us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> returning: cb->phys=0x87000000, cb->size=4, cb->virt=0x43636000 @2,153,974us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> return (0x87000000) @2,154,119us: [+2 T:0x41498490 S:0x41497ab4] ti.sdo.dmai - [Buffer] Set user pointer 0x43636000 (physical 0x87000000) @2,481,770us: [+2 T:0x41498490 S:0x41497ad4] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x43636000 has physical address 0x87000000 @2,482,322us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43a2b000, size=4) @2,482,516us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43a2b000, size=4) @2,482,738us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> returning physAddr=0x0 @2,482,916us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43a2b000) = 0x86c00000. @2,483,094us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> Enter(virtAddr=0x43a2b000, size=4, physAddr=0x86c00000) @2,483,261us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> creating new contigBuf object @2,483,404us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> Enter(0x10) @2,483,558us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> return (0xd99b0) @2,483,706us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> returning: cb->phys=0x86c00000, cb->size=4, cb->virt=0x43a2b000 @2,483,863us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> return (0x86c00000) @2,484,008us: [+2 T:0x41498490 S:0x41497ab4] ti.sdo.dmai - [Buffer] Set user pointer 0x43a2b000 (physical 0x86c00000) @2,812,163us: [+2 T:0x41498490 S:0x41497ad4] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x43a2b000 has physical address 0x86c00000 @2,812,719us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43e20000, size=4) @2,812,915us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43e20000, size=4) @2,813,079us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory__getPhysicalAddress> returning physAddr=0x0 @2,813,250us: [+1 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> CMEM_getPhys(0x43e20000) = 0x86800000. @2,813,423us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> Enter(virtAddr=0x43e20000, size=4, physAddr=0x86800000) @2,813,589us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> creating new contigBuf object @2,813,731us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> Enter(0x10) @2,813,883us: [+0 T:0x41498490 S:0x41497a1c] OM - Memory_alloc> return (0xd99c8) @2,814,029us: [+1 T:0x41498490 S:0x41497a34] OM - Memory__addContigBuf> returning: cb->phys=0x86800000, cb->size=4, cb->virt=0x43e20000 @2,814,199us: [+0 T:0x41498490 S:0x41497a7c] OM - Memory_getBufferPhysicalAddress> return (0x86800000) @2,814,355us: [+2 T:0x41498490 S:0x41497ab4] ti.sdo.dmai - [Buffer] Set user pointer 0x43e20000 (physical 0x86800000) @3,142,741us: [+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 @5,416,287us: [+0 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> enter @5,418,112us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x63adc()... @5,418,310us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x77f78()... @5,418,477us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x79c98()... @5,418,666us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> Enter(0xd9430, 0x18) @5,418,836us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> return (0x1) @5,418,988us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> Enter(0xd9450, 0x18) @5,419,141us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> return (0x1) @5,419,283us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> Enter(0xd9470, 0x18) @5,419,570us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> return (0x1) @5,419,733us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x8233c()... @5,419,889us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x7c804()... @5,420,044us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x7d3d8()... @5,420,198us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x7fb10()... @5,420,348us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x7d78c()... @5,420,492us: [+0 T:0x4001fdf0 S:0xbec37544] OP - doCmd> Enter (cmdId=3, proc=0x0) @5,420,637us: [+0 T:0x4001fdf0 S:0xbec37534] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91c0] @5,420,816us: [+0 T:0x4001fdf0 S:0xbec37544] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91c0] @5,420,978us: [+0 T:0x4001fdf0 S:0xbec37524] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xd91d8] timeout[0xffffffff] @5,427,785us: [+0 T:0x40c98490 S:0x40c97d44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91c0] status[0] @5,427,982us: [+0 T:0x40c98490 S:0x40c97d64] OP - getCmd_d> Exit (result=3) @5,428,140us: [+0 T:0x40c98490 S:0x40c97d54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xd91d8] @5,428,320us: [+0 T:0x40c98490 S:0x40c97d64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xd91d8] @5,428,759us: [+0 T:0x4001fdf0 S:0xbec37524] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xd91d8] status[0] @5,428,958us: [+0 T:0x4001fdf0 S:0xbec37544] OP - doCmd> Exit (result=1) @5,429,115us: [+0 T:0x4001fdf0 S:0xbec3754c] OT - Thread_delete> Enter (task=0xd9210) @5,429,315us: [+4 T:0x4001fdf0 S:0xbec3754c] OT - Thread_delete> pthread_cancel (0x3) @5,429,628us: [+4 T:0x4001fdf0 S:0xbec3754c] OT - Thread_delete> pthread_join (0x0) @5,429,797us: [+0 T:0x4001fdf0 S:0xbec3752c] OM - Memory_free> Enter(0xd9210, 0x64) @5,429,958us: [+0 T:0x4001fdf0 S:0xbec3752c] OM - Memory_free> return (0x1) @5,430,107us: [+0 T:0x4001fdf0 S:0xbec37564] OT - Thread_delete> Exit (task=0xd9210) @5,430,251us: [+0 T:0x4001fdf0 S:0xbec37554] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0xd91c0] @5,430,430us: [+0 T:0x4001fdf0 S:0xbec37534] OM - Memory_free> Enter(0xd91c0, 0x14) @5,430,594us: [+0 T:0x4001fdf0 S:0xbec37534] OM - Memory_free> return (0x1) @5,430,742us: [+0 T:0x4001fdf0 S:0xbec37564] ti.sdo.ce.osal.Sem - Leaving Sem_delete> @5,430,879us: [+0 T:0x4001fdf0 S:0xbec37554] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0xd91d8] @5,431,022us: [+0 T:0x4001fdf0 S:0xbec37534] OM - Memory_free> Enter(0xd91d8, 0x14) @5,431,178us: [+0 T:0x4001fdf0 S:0xbec37534] OM - Memory_free> return (0x1) @5,431,323us: [+0 T:0x4001fdf0 S:0xbec37564] ti.sdo.ce.osal.Sem - Leaving Sem_delete> @5,431,462us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> Enter(0xd91f0, 0x18) @5,431,612us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> return (0x1) @5,431,758us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x81e4c()... @5,431,953us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x7f5c4()... @5,432,120us: [+0 T:0x4001fdf0 S:0xbec37554] OM - Memory_free> Enter(0xd9140, 0x18) @5,432,281us: [+0 T:0x4001fdf0 S:0xbec37554] OM - Memory_free> return (0x1) @5,432,428us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x80718()... @5,432,588us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> Enter(0xd90f0, 0x18) @5,432,764us: [+0 T:0x4001fdf0 S:0xbec37544] OM - Memory_free> return (0x1) @5,432,922us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x827e8()... @5,433,074us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x8339c()... @5,433,223us: [+2 T:0x4001fdf0 S:0xbec37574] OG - Global_exit> calling function *0x82748()...