@0,260,861us: [+4 T:0x4001f0d0] OG - Global_init> This program was built with the following packages:
@0,261,166us: [+4 T:0x4001f0d0] OG -     package gnu.targets.arm.rtsv5T (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/gnu/targets/arm/rtsv5T/) [1, 0, 0, 0]
@0,261,197us: [+4 T:0x4001f0d0] OG -     package ti.c6accel (/home/zfang/dm3730-dvsdk/c6accel_1_01_00_06/soc/packages/ti/c6accel/) [1, 0, 0]
@0,261,227us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.aachedec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/aachedec/) [1, 0, 0]
@0,261,258us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.deinterlacer (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/deinterlacer/) [1, 0, 0]
@0,261,289us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.g711dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711dec/) [1, 0, 0]
@0,261,319us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.g711enc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711enc/) [1, 0, 0]
@0,261,655us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.jpegdec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
@0,261,716us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.jpegenc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
@0,261,716us: [+4 T:0x4001f0d0] OG -     package ti.sdo.linuxutils.sdma (/home/zfang/dm3730-dvsdk/linuxutils_2_26_01_02/packages/ti/sdo/linuxutils/sdma/) [1, 0, 0]
@0,261,746us: [+4 T:0x4001f0d0] OG -     package ti.sdo.linuxutils.cmem (/home/zfang/dm3730-dvsdk/linuxutils_2_26_01_02/packages/ti/sdo/linuxutils/cmem/) [2, 2, 0]
@0,261,777us: [+4 T:0x4001f0d0] OG -     package ti.sdo.fc.global (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/global/) [1, 0, 0]
@0,261,807us: [+4 T:0x4001f0d0] OG -     package ti.sdo.fc.scpy (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/scpy/) [1, 0, 0]
@0,261,807us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.global (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/global/) [1, 0, 0]
@0,261,838us: [+4 T:0x4001f0d0] OG -     package ti.xdais.dm (/home/zfang/dm3730-dvsdk/xdais_6_26_01_03/packages/ti/xdais/dm/) [1, 0, 5]
@0,261,838us: [+4 T:0x4001f0d0] OG -     package ti.sdo.utils.trace (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/utils/trace/) [1, 0, 0]
@0,261,868us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.utils.xdm (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
@0,261,899us: [+4 T:0x4001f0d0] OG -     package dsplink.gpp (/home/zfang/dm3730-dvsdk/dsplink_1_65_00_02/dsplink/gpp/) [5, 0, 0]
@0,261,899us: [+4 T:0x4001f0d0] OG -     package ti.bios.power (/home/zfang/dm3730-dvsdk/local-power-manager_1_24_02_09/packages/ti/bios/power/) [1, 1, 1]
@0,261,929us: [+4 T:0x4001f0d0] OG -     package ti.xdais (/home/zfang/dm3730-dvsdk/xdais_6_26_01_03/packages/ti/xdais/) [1, 2.0, 1]
@0,261,960us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.node (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/node/) [1, 0, 0]
@0,261,960us: [+4 T:0x4001f0d0] OG -     package ti.sdo.fc.memutils (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/memutils/) [1, 0, 0]
@0,261,991us: [+4 T:0x4001f0d0] OG -     package ti.sdo.fc.utils (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/utils/) [1, 0, 2]
@0,262,021us: [+4 T:0x4001f0d0] OG -     package ti.sdo.fc.dman3 (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/dman3/) [1, 0, 4]
@0,262,052us: [+4 T:0x4001f0d0] OG -     package ti.sdo.fc.acpy3 (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
@0,262,082us: [+4 T:0x4001f0d0] OG -     package gnu.targets (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/gnu/targets/) [1, 0, 1]
@0,262,113us: [+4 T:0x4001f0d0] OG -     package gnu.targets.arm (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/gnu/targets/arm/) [1, 0, 0, 0]
@0,262,204us: [+4 T:0x4001f0d0] OG -     package ti.catalog.arm (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
@0,262,204us: [+4 T:0x4001f0d0] OG -     package ti.catalog (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
@0,262,235us: [+4 T:0x4001f0d0] OG -     package ti.catalog.c6000 (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
@0,262,265us: [+4 T:0x4001f0d0] OG -     package ti.platforms.evm3530 (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
@0,262,265us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.osal (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/osal/) [2, 0, 2]
@0,262,296us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.ipc (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/ipc/) [2, 0, 1]
@0,262,326us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.osal.linux (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
@0,262,357us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.ipc.dsplink (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
@0,262,357us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.alg (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/alg/) [1, 0, 1]
@0,262,387us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/) [1, 0, 6]
@0,262,418us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.universal (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/universal/) [1, 0, 0]
@0,262,418us: [+4 T:0x4001f0d0] OG -     package ti.c6accel.ce (/home/zfang/dm3730-dvsdk/c6accel_1_01_00_06/soc/packages/ti/c6accel/ce/) [1, 0, 0]
@0,262,448us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.audio1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/audio1/) [1, 0, 1]
@0,262,479us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.aachedec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/aachedec/ce/) [1, 0, 0]
@0,262,479us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.deinterlacer.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/deinterlacer/ce/) [1, 0, 0]
@0,262,509us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.speech1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/speech1/) [1, 0, 1]
@0,262,540us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.g711dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711dec/ce/) [1, 0, 0]
@0,262,540us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.g711enc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711enc/ce/) [1, 0, 0]
@0,262,570us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.video2 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/video2/) [1, 0, 2]
@0,262,601us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.h264dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264dec/) []
@0,262,601us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.h264dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264dec/ce/) []
@0,262,631us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.video1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/video1/) [1, 0, 2]
@0,262,662us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.h264enc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264enc/) []
@0,262,692us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.h264enc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264enc/ce/) []
@0,262,692us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.image1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/image1/) [1, 0, 1]
@0,262,723us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.jpegdec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
@0,262,784us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.jpegenc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
@0,262,784us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.mpeg2dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg2dec/) []
@0,262,815us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.mpeg2dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg2dec/ce/) []
@0,262,845us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.mpeg4dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4dec/) []
@0,262,845us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.mpeg4dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4dec/ce/) []
@0,262,876us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.mpeg4enc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4enc/) []
@0,262,906us: [+4 T:0x4001f0d0] OG -     package ti.sdo.codecs.mpeg4enc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4enc/ce/) []
@0,262,906us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.speech (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/speech/) [1, 0, 2]
@0,262,937us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.audio (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/audio/) [1, 0, 2]
@0,262,967us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.video (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/video/) [1, 0, 3]
@0,262,967us: [+4 T:0x4001f0d0] OG -     package ti.sdo.ce.image (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/image/) [1, 0, 3]
@0,262,998us: [+4 T:0x4001f0d0] OG -     package ti.sdo.dmai (/home/zfang/dm3730-dvsdk/dmai_2_20_00_15/packages/ti/sdo/dmai/) [1, 0, 0]
@0,263,028us: [+4 T:0x4001f0d0] OG -     package video_decode_test_dm3730_config (/home/zfang/dm3730-dvsdk/dmai_2_20_00_15/packages/ti/sdo/dmai/apps/video_decode_test/linux/video_decode_test_dm3730_config/) []
@0,263,211us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,263,272us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x571c0]
@0,263,272us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,263,303us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x571d8]
@0,263,333us: [+0 T:0x4001f0d0] OT - Thread_create> Enter (fxn=0x21dec, attrs=0x0)
@0,263,517us: [+0 T:0x4001f0d0] OT - Thread_create> Exit (task=0x57210)
@0,263,608us: [+0 T:0x4001f0d0] ti.sdo.ce.alg - ALG_init> Enter
@0,263,639us: [+0 T:0x4001f0d0] ti.sdo.ce.alg - ALG_init> Exit
@0,263,700us: [+6 T:0x4001f0d0] CE - Engine_init> CE debugging on (CE_DEBUG=2; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@0,263,761us: [+0 T:0x4001f0d0] CS - Server_init()
@0,263,761us: [+0 T:0x4001f0d0] CS - Server_init> Global_useLinkArbiter = 0
@0,263,822us: [+2 T:0x4001f0d0] ti.sdo.dmai - [Dmai] Dmai log level set to '2'. Note that calling CERuntime_init after this point may cause unexpected change to DMAI tracing behavior.
@0,263,852us: [+0 T:0x4001f0d0] CE - Engine_open> Enter('codecServer', 0x0, 0xbeec3adc)
@0,263,883us: [+0 T:0x4001f0d0] CE - rserverOpen('cs.x64P'), count = 0
@0,263,913us: [+0 T:0x4001f0d0] OP - Processor_create> Enter(imageName='cs.x64P', linkCfg='(null)', attrs=0xbeec3ac0)
@0,264,005us: [+0 T:0x4001f0d0] OP - doCmd> Enter (cmdId=1, proc=0x57540)
@0,264,035us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x571c0]
@0,264,066us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x571c0]
@0,264,096us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x571d8] timeout[0xffffffff]
@0,264,158us: [+1 T:0x40b0e490] OP - daemon> thread created.
@0,264,219us: [+0 T:0x40b0e490] OP - getCmd_d> Enter (proc=0x40b0ddd8)
@0,264,219us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x571c0] timeout[0xffffffff]
@0,264,310us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x571c0] status[0]
@0,264,341us: [+0 T:0x40b0e490] OP - getCmd_d> Exit (result=1)
@0,264,341us: [+0 T:0x40b0e490] OP - Processor_create_d> Enter(proc=0x57540)
@0,264,371us: [+0 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_on> Enter(handle=0x5755c)
@0,264,402us: [+2 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_on> Opening Local Power Manager for the DSP on /dev/lpm0...
@0,264,432us: [+2 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_on> Turning on DSP power...
@0,264,554us: [+2 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_on> return (0)
@0,264,554us: [+2 T:0x40b0e490] OP - Processor_create_d> Initializing DSP PROC...
@0,264,585us: [+2 T:0x40b0e490] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'cs.x64P']
@0,264,615us: [+2 T:0x40b0e490] OP - Processor_create_d> Number of CMEM blocks: 1
@0,264,646us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for DDR2, physAddr = 0x87a00000, dspAddr = 0x87a00000, size = 0x600000
@0,264,676us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x87a00000, sizeInBytes=0x600000, shared=1, syncd=0
@0,264,707us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for DSPLINKMEM, physAddr = 0x85901000, dspAddr = 0x85901000, size = 0xff000
@0,264,737us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x85901000, sizeInBytes=0xff000, shared=1, syncd=0
@0,264,768us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for RESET_VECTOR, physAddr = 0x85900000, dspAddr = 0x85900000, size = 0x1000
@0,264,798us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x85900000, sizeInBytes=0x1000, shared=1, syncd=0
@0,264,829us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for L4PER, physAddr = 0x49000000, dspAddr = 0x49000000, size = 0x100000
@0,264,829us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='L4PER', startAddress=0x49000000, sizeInBytes=0x100000, shared=0, syncd=0
@0,264,859us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for IRAM, physAddr = 0x5c7f8000, dspAddr = 0x107f8000, size = 0x8000
@0,264,890us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #4 to Link configuration: name='IRAM', startAddress=0x5c7f8000, sizeInBytes=0x8000, shared=1, syncd=0
@0,264,921us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for L1DSRAM, physAddr = 0x5cf04000, dspAddr = 0x10f04000, size = 0x10000
@0,264,951us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #5 to Link configuration: name='L1DSRAM', startAddress=0x5cf04000, sizeInBytes=0x10000, shared=1, syncd=0
@0,264,951us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for L1PSRAM, physAddr = 0x5ce00000, dspAddr = 0x10e00000, size = 0x4000
@0,264,982us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #6 to Link configuration: name='L1PSRAM', startAddress=0x5ce00000, sizeInBytes=0x4000, shared=1, syncd=0
@0,265,012us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for DDRALGHEAP, physAddr = 0x85a00000, dspAddr = 0x85a00000, size = 0x2000000
@0,265,043us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #7 to Link configuration: name='DDRALGHEAP', startAddress=0x85a00000, sizeInBytes=0x2000000, shared=0, syncd=0
@0,265,073us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for L4CORE, physAddr = 0x48000000, dspAddr = 0x48000000, size = 0x1000000
@0,265,104us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding DSP segment #8 to Link configuration: name='L4CORE', startAddress=0x48000000, sizeInBytes=0x1000000, shared=0, syncd=0
@0,265,104us: [+2 T:0x40b0e490] OP - Processor_create_d> Adding memTable entry for CMEM, physAddr = 0x0, dspAddr = 0x0, size = 0x0
@0,265,165us: [+2 T:0x40b0e490] OP - Processor_create_d> DODSPCTRL was=0; now=0
@0,265,226us: [+3 T:0x40b0e490] OP - LINKCFG_Object generated for PROC_setup(0x54eac) ...
@0,265,256us: [+3 T:0x40b0e490] OP - linkCfg->gppObject->
@0,265,287us: [+3 T:0x40b0e490] OP -   name = "ARM9"
@0,265,317us: [+3 T:0x40b0e490] OP -   maxMsgqs = 0x82
@0,265,317us: [+3 T:0x40b0e490] OP -   maxChnlQueue = 0x10
@0,265,348us: [+3 T:0x40b0e490] OP -   poolTableId = 0xffffffff
@0,265,378us: [+3 T:0x40b0e490] OP -   numPools = 0x0
@0,265,378us: [+3 T:0x40b0e490] OP - 
@0,265,409us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->dspObject->
@0,265,439us: [+3 T:0x40b0e490] OP -   name = "OMAP3530"
@0,265,439us: [+3 T:0x40b0e490] OP -   dspArch = 0x2
@0,265,470us: [+3 T:0x40b0e490] OP -   loaderName = "COFF"
@0,265,500us: [+3 T:0x40b0e490] OP -   autoStart = FALSE
@0,265,500us: [+3 T:0x40b0e490] OP -   execName = "DEFAULT.OUT"
@0,265,531us: [+3 T:0x40b0e490] OP -   doDspCtrl = DSP_BootMode_Boot_NoPwr
@0,265,561us: [+3 T:0x40b0e490] OP -   resumeAddr = 0x85900020
@0,265,561us: [+3 T:0x40b0e490] OP -   resetVector = 0x85900000
@0,265,592us: [+3 T:0x40b0e490] OP -   resetCodeSize = 0x1000
@0,265,623us: [+3 T:0x40b0e490] OP -   maduSize = 0x1
@0,265,623us: [+3 T:0x40b0e490] OP -   cpuFreq = 0x6ddd0
@0,265,653us: [+3 T:0x40b0e490] OP -   endian = 0x3
@0,265,684us: [+3 T:0x40b0e490] OP -   wordSwap = 0x0
@0,265,684us: [+3 T:0x40b0e490] OP -   memTableId = 0x0
@0,265,714us: [+3 T:0x40b0e490] OP -   memEntries = 0xa
@0,265,745us: [+3 T:0x40b0e490] OP -   linkDrvId = 0x0
@0,265,745us: [+3 T:0x40b0e490] OP -   arg1 = 0xffffffff
@0,265,775us: [+3 T:0x40b0e490] OP -   arg2 = 0xffffffff
@0,265,806us: [+3 T:0x40b0e490] OP -   arg3 = 0x0
@0,265,806us: [+3 T:0x40b0e490] OP -   arg4 = 0x0
@0,265,836us: [+3 T:0x40b0e490] OP -   arg5 = 0xffffffff
@0,265,867us: [+3 T:0x40b0e490] OP - 
@0,265,867us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->linkDrvObjects->
@0,265,897us: [+3 T:0x40b0e490] OP -   name = "SHMDRV"
@0,265,928us: [+3 T:0x40b0e490] OP -   hshkPollCount = 0x989680
@0,265,928us: [+3 T:0x40b0e490] OP -   memEntry = 0x1
@0,265,958us: [+3 T:0x40b0e490] OP -   ipsTableId = 0x0
@0,265,989us: [+3 T:0x40b0e490] OP -   numIpsEntries = 0x1
@0,265,989us: [+3 T:0x40b0e490] OP -   poolTableId = 0x0
@0,266,019us: [+3 T:0x40b0e490] OP -   numPools = 0x1
@0,266,050us: [+3 T:0x40b0e490] OP -   dataTableId = 0x0
@0,266,050us: [+3 T:0x40b0e490] OP -   numDataDrivers = 0x1
@0,266,080us: [+3 T:0x40b0e490] OP -   mqtId = 0x0
@0,266,111us: [+3 T:0x40b0e490] OP -   ringIoTableId = 0x0
@0,266,111us: [+3 T:0x40b0e490] OP -   mplistTableId = 0x0
@0,266,141us: [+3 T:0x40b0e490] OP -   mpcsTableId = 0x0
@0,266,172us: [+3 T:0x40b0e490] OP - 
@0,266,172us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->memTables[0][i].
@0,266,202us: [+3 T:0x40b0e490] OP - entry #0:
@0,266,233us: [+3 T:0x40b0e490] OP -   entry = 0x0
@0,266,233us: [+3 T:0x40b0e490] OP -   name = "DDR2"
@0,266,263us: [+3 T:0x40b0e490] OP -   physAddr = 0x87a00000
@0,266,294us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x87a00000
@0,266,294us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,266,324us: [+3 T:0x40b0e490] OP -   size = 0x600000
@0,266,355us: [+3 T:0x40b0e490] OP -   shared = TRUE
@0,266,355us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,266,386us: [+3 T:0x40b0e490] OP - entry #1:
@0,266,416us: [+3 T:0x40b0e490] OP -   entry = 0x1
@0,266,416us: [+3 T:0x40b0e490] OP -   name = "DSPLINKMEM"
@0,266,447us: [+3 T:0x40b0e490] OP -   physAddr = 0x85901000
@0,266,477us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x85901000
@0,266,477us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,266,508us: [+3 T:0x40b0e490] OP -   size = 0xff000
@0,266,538us: [+3 T:0x40b0e490] OP -   shared = TRUE
@0,266,538us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,266,569us: [+3 T:0x40b0e490] OP - entry #2:
@0,266,599us: [+3 T:0x40b0e490] OP -   entry = 0x2
@0,266,599us: [+3 T:0x40b0e490] OP -   name = "RESET_VECTOR"
@0,266,630us: [+3 T:0x40b0e490] OP -   physAddr = 0x85900000
@0,266,660us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x85900000
@0,266,660us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,266,721us: [+3 T:0x40b0e490] OP -   size = 0x1000
@0,266,752us: [+3 T:0x40b0e490] OP -   shared = TRUE
@0,266,752us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,266,782us: [+3 T:0x40b0e490] OP - entry #3:
@0,266,813us: [+3 T:0x40b0e490] OP -   entry = 0x3
@0,266,813us: [+3 T:0x40b0e490] OP -   name = "L4PER"
@0,266,843us: [+3 T:0x40b0e490] OP -   physAddr = 0x49000000
@0,266,874us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x49000000
@0,266,874us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,266,904us: [+3 T:0x40b0e490] OP -   size = 0x100000
@0,266,935us: [+3 T:0x40b0e490] OP -   shared = FALSE
@0,266,935us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,266,965us: [+3 T:0x40b0e490] OP - entry #4:
@0,266,996us: [+3 T:0x40b0e490] OP -   entry = 0x4
@0,266,996us: [+3 T:0x40b0e490] OP -   name = "IRAM"
@0,267,026us: [+3 T:0x40b0e490] OP -   physAddr = 0x5c7f8000
@0,267,057us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x107f8000
@0,267,057us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,267,088us: [+3 T:0x40b0e490] OP -   size = 0x8000
@0,267,118us: [+3 T:0x40b0e490] OP -   shared = TRUE
@0,267,118us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,267,149us: [+3 T:0x40b0e490] OP - entry #5:
@0,267,179us: [+3 T:0x40b0e490] OP -   entry = 0x5
@0,267,179us: [+3 T:0x40b0e490] OP -   name = "L1DSRAM"
@0,267,210us: [+3 T:0x40b0e490] OP -   physAddr = 0x5cf04000
@0,267,210us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x10f04000
@0,267,240us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,267,271us: [+3 T:0x40b0e490] OP -   size = 0x10000
@0,267,271us: [+3 T:0x40b0e490] OP -   shared = TRUE
@0,267,301us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,267,332us: [+3 T:0x40b0e490] OP - entry #6:
@0,267,332us: [+3 T:0x40b0e490] OP -   entry = 0x6
@0,267,362us: [+3 T:0x40b0e490] OP -   name = "L1PSRAM"
@0,267,393us: [+3 T:0x40b0e490] OP -   physAddr = 0x5ce00000
@0,267,393us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x10e00000
@0,267,423us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,267,454us: [+3 T:0x40b0e490] OP -   size = 0x4000
@0,267,454us: [+3 T:0x40b0e490] OP -   shared = TRUE
@0,267,484us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,267,515us: [+3 T:0x40b0e490] OP - entry #7:
@0,267,515us: [+3 T:0x40b0e490] OP -   entry = 0x7
@0,267,545us: [+3 T:0x40b0e490] OP -   name = "DDRALGHEAP"
@0,267,576us: [+3 T:0x40b0e490] OP -   physAddr = 0x85a00000
@0,267,576us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x85a00000
@0,267,606us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,267,637us: [+3 T:0x40b0e490] OP -   size = 0x2000000
@0,267,637us: [+3 T:0x40b0e490] OP -   shared = FALSE
@0,267,667us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,267,698us: [+3 T:0x40b0e490] OP - entry #8:
@0,267,698us: [+3 T:0x40b0e490] OP -   entry = 0x8
@0,267,728us: [+3 T:0x40b0e490] OP -   name = "L4CORE"
@0,267,759us: [+3 T:0x40b0e490] OP -   physAddr = 0x48000000
@0,267,759us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x48000000
@0,267,790us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0xffffffff
@0,267,820us: [+3 T:0x40b0e490] OP -   size = 0x1000000
@0,267,820us: [+3 T:0x40b0e490] OP -   shared = FALSE
@0,267,851us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,267,881us: [+3 T:0x40b0e490] OP - entry #9:
@0,267,881us: [+3 T:0x40b0e490] OP -   entry = 0x0
@0,267,912us: [+3 T:0x40b0e490] OP -   name = "CMEM_BLOCK0"
@0,267,942us: [+3 T:0x40b0e490] OP -   physAddr = 0x83700000
@0,267,942us: [+3 T:0x40b0e490] OP -   dspVirtAddr = 0x83700000
@0,267,973us: [+3 T:0x40b0e490] OP -   gppVirtAddr = 0x0
@0,268,003us: [+3 T:0x40b0e490] OP -   size = 0x2200000
@0,268,003us: [+3 T:0x40b0e490] OP -   shared = FALSE
@0,268,034us: [+3 T:0x40b0e490] OP -   syncd = FALSE
@0,268,064us: [+3 T:0x40b0e490] OP - 
@0,268,064us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->ipsTables[0][i].
@0,268,095us: [+3 T:0x40b0e490] OP - entry #0:
@0,268,125us: [+3 T:0x40b0e490] OP -   name = "IPS"
@0,268,125us: [+3 T:0x40b0e490] OP -   numIpsEvents = 0x20
@0,268,156us: [+3 T:0x40b0e490] OP -   memEntry = 0x1
@0,268,186us: [+3 T:0x40b0e490] OP -   gppIntId = 0x1a
@0,268,217us: [+3 T:0x40b0e490] OP -   dspIntId = 0x37
@0,268,247us: [+3 T:0x40b0e490] OP -   dspIntVectorId = 0x5
@0,268,247us: [+3 T:0x40b0e490] OP -   arg1 = 0x2faf080
@0,268,278us: [+3 T:0x40b0e490] OP -   arg2 = 0x0
@0,268,308us: [+3 T:0x40b0e490] OP - 
@0,268,308us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->poolTables[0][i].
@0,268,339us: [+3 T:0x40b0e490] OP - 
@0,268,369us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->dataTables[0][i].
@0,268,369us: [+3 T:0x40b0e490] OP - entry #0:
@0,268,400us: [+3 T:0x40b0e490] OP -   name = "ZCPYDATA"
@0,268,430us: [+3 T:0x40b0e490] OP -   baseChnlId = 0x0
@0,268,430us: [+3 T:0x40b0e490] OP -   numChannels = 0x10
@0,268,461us: [+3 T:0x40b0e490] OP -   maxBufSize = 0x4000
@0,268,491us: [+3 T:0x40b0e490] OP -   memEntry = 0x1
@0,268,491us: [+3 T:0x40b0e490] OP -   poolId = 0x0
@0,268,522us: [+3 T:0x40b0e490] OP -   queuePerChnl = 0x1
@0,268,553us: [+3 T:0x40b0e490] OP -   ipsId = 0x0
@0,268,553us: [+3 T:0x40b0e490] OP -   ipsEventNo = 0x1
@0,268,583us: [+3 T:0x40b0e490] OP -   arg1 = 0x0
@0,268,614us: [+3 T:0x40b0e490] OP -   arg2 = 0x0
@0,268,614us: [+3 T:0x40b0e490] OP - 
@0,268,644us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->mqtObjects->
@0,268,675us: [+3 T:0x40b0e490] OP -   name = "ZCPYMQT"
@0,268,675us: [+3 T:0x40b0e490] OP -   memEntry = 0x1
@0,268,705us: [+3 T:0x40b0e490] OP -   maxMsgSize = 0xffffffff
@0,268,736us: [+3 T:0x40b0e490] OP -   ipsId = 0x0
@0,268,736us: [+3 T:0x40b0e490] OP -   ipsEventNo = 0x0
@0,268,766us: [+3 T:0x40b0e490] OP -   arg1 = 0x0
@0,268,797us: [+3 T:0x40b0e490] OP -   arg2 = 0x0
@0,268,797us: [+3 T:0x40b0e490] OP - 
@0,268,827us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->ringIoObjects->
@0,268,858us: [+3 T:0x40b0e490] OP -   name = "RINGIOTABLE"
@0,268,858us: [+3 T:0x40b0e490] OP -   memEntry = 0x1
@0,268,888us: [+3 T:0x40b0e490] OP -   maxEntries = 0x40
@0,268,919us: [+3 T:0x40b0e490] OP -   ipsId = 0x0
@0,268,919us: [+3 T:0x40b0e490] OP -   ipsEventNo = 0x2
@0,268,949us: [+3 T:0x40b0e490] OP - 
@0,268,980us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->mplistObjects->
@0,268,980us: [+3 T:0x40b0e490] OP -   name = "MPLISTTABLE"
@0,269,010us: [+3 T:0x40b0e490] OP -   memEntry = 0x1
@0,269,041us: [+3 T:0x40b0e490] OP -   maxEntries = 0x40
@0,269,041us: [+3 T:0x40b0e490] OP -   ipsId = 0xffffffff
@0,269,071us: [+3 T:0x40b0e490] OP -   ipsEventNo = 0xffffffff
@0,269,102us: [+3 T:0x40b0e490] OP - 
@0,269,102us: [+3 T:0x40b0e490] OP - linkCfg->dspConfigs[0]->mpcsObjects->
@0,269,132us: [+3 T:0x40b0e490] OP -   name = "MPCS"
@0,269,224us: [+3 T:0x40b0e490] OP -   memEntry = 0x1
@0,269,255us: [+3 T:0x40b0e490] OP -   maxEntries = 0x100
@0,269,255us: [+3 T:0x40b0e490] OP -   ipsId = 0xffffffff
@0,269,285us: [+3 T:0x40b0e490] OP -   ipsEventNo = 0xffffffff
@0,269,926us: [+2 T:0x40b0e490] OP - Processor_create_d> Attaching to DSP PROC...
@0,272,215us: [+2 T:0x40b0e490] OP - Processor_create_d> Opening MSGQ pool...
@0,272,429us: [+2 T:0x40b0e490] OP - Processor_create_d> Loading cs.x64P on DSP (1 args)...
@0,321,167us: [+2 T:0x40b0e490] OP - Processor_create_d> Starting DSP PROC...
@0,340,973us: [+2 T:0x40b0e490] OP - Processor_create_d> Opening remote transport...
@0,341,522us: [+0 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_connect> Enter (handle=0x57568)
@0,341,613us: [+2 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_connect> Calling LPM_connect to connect to the DSP power handler...
@0,341,674us: [+0 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_connect> return (0)
@0,341,735us: [+2 T:0x40b0e490] OP - Processor_create_d> return (1)
@0,341,735us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x571d8]
@0,341,797us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x571d8]
@0,341,827us: [+0 T:0x40b0e490] OP - getCmd_d> Enter (proc=0x40b0ddd8)
@0,341,827us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x571c0] timeout[0xffffffff]
@0,341,888us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x571d8] status[0]
@0,341,919us: [+0 T:0x4001f0d0] OP - doCmd> Exit (result=1)
@0,341,919us: [+0 T:0x4001f0d0] OP - Processor_create> return (0x57540)
@0,342,010us: [+0 T:0x4001f0d0] CE - rserverOpen('cs.x64P'): 0x55814 done.
@0,342,529us: [+0 T:0x4001f0d0] CE - checkServer(0x57508)
@0,342,712us: [+0 T:0x4001f0d0] CE - rmsInit> RMS initialized(0x57508); CE_DEBUG on, setting DSP trace mask to *+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3
@0,342,743us: [+0 T:0x4001f0d0] CE - Engine_setTrace> Enter(engine=0x57508, mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
@0,342,834us: [+1 T:0x4001f0d0] CE - Engine_setTrace> Requesting DSP set trace ...
@0,344,360us: [+0 T:0x4001f0d0] CE - Engine_setTrace> return(0)
@0,344,391us: [+4 T:0x4001f0d0] CE - Engine_open> engine->server = 0x55814
[DSP] @0x0000028b:[T:0x00000000] server - main> Welcome to DSP server's main().
[DSP] @0,006,192tk: [+0 T:0x87c2d494] OG - Global_setSpecialTrace> enter(mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
[DSP] @0,006,280tk: [+4 T:0x87c2d494] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,006,331tk: [+4 T:0x87c2d494] OG -     package ti.targets.rts6000 (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/targets/rts6000/) [1, 0, 0, 0]
[DSP] @0,006,401tk: [+4 T:0x87c2d494] OG -     package ti.c6accel (/home/zfang/dm3730-dvsdk/c6accel_1_01_00_06/soc/packages/ti/c6accel/) [1, 0, 0]
[DSP] @0,006,463tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.aachedec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/aachedec/) [1, 0, 0]
[DSP] @0,006,536tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.deinterlacer (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/deinterlacer/) [1, 0, 0]
[DSP] @0,006,611tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.g711dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711dec/) [1, 0, 0]
[DSP] @0,006,685tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.g711enc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711enc/) [1, 0, 0]
[DSP] @0,006,757tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.jpegdec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
[DSP] @0,006,829tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.jpegenc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
[DSP] @0,006,901tk: [+4 T:0x87c2d494] OG -     package ti.sdo.fc.global (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/global/) [1, 0, 0]
[DSP] @0,006,971tk: [+4 T:0x87c2d494] OG -     package ti.sdo.utils.trace (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/utils/trace/) [1, 0, 0]
[DSP] @0,007,043tk: [+4 T:0x87c2d494] OG -     package ti.xdais (/home/zfang/dm3730-dvsdk/xdais_6_26_01_03/packages/ti/xdais/) [1, 2.0, 1]
[DSP] @0,007,102tk: [+4 T:0x87c2d494] OG -     package ti.rtdx (/home/zfang/dm3730-dvsdk/dspbios_5_41_03_17/packages/ti/rtdx/) [2, 0, 0, 5]
[DSP] @0,007,162tk: [+4 T:0x87c2d494] OG -     package ti.psl (/home/zfang/dm3730-dvsdk/dspbios_5_41_03_17/packages/ti/psl/) [5, 0, 0, 0]
[DSP] @0,007,221tk: [+4 T:0x87c2d494] OG -     package ti.pmi (/home/zfang/dm3730-dvsdk/dspbios_5_41_03_17/packages/ti/pmi/) [1, 0, 0, 0]
[DSP] @0,007,280tk: [+4 T:0x87c2d494] OG -     package ti.pscl (/home/zfang/dm3730-dvsdk/dspbios_5_41_03_17/packages/ti/pscl/) [1, 0, 0, 0]
[DSP] @0,007,340tk: [+4 T:0x87c2d494] OG -     package ti.bios (/home/zfang/dm3730-dvsdk/dspbios_5_41_03_17/packages/ti/bios/) [5, 2, 5, 28]
[DSP] @0,007,400tk: [+4 T:0x87c2d494] OG -     package ti.sdo.fc.dskt2 (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
[DSP] @0,007,469tk: [+4 T:0x87c2d494] OG -     package ti.sdo.fc.dman3 (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/dman3/) [1, 0, 4]
[DSP] @0,007,539tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.global (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/global/) [1, 0, 0]
[DSP] @0,007,606tk: [+4 T:0x87c2d494] OG -     package ti.xdais.dm (/home/zfang/dm3730-dvsdk/xdais_6_26_01_03/packages/ti/xdais/dm/) [1, 0, 5]
[DSP] @0,007,682tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.utils.xdm (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
[DSP] @0,007,753tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.node (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/node/) [1, 0, 0]
[DSP] @0,007,819tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2, 0, 1]
[DSP] @0,007,893tk: [+4 T:0x87c2d494] OG -     package ti.sdo.fc.memutils (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/memutils/) [1, 0, 0]
[DSP] @0,007,964tk: [+4 T:0x87c2d494] OG -     package ti.sdo.fc.acpy3 (/home/zfang/dm3730-dvsdk/framework-components_2_26_00_01/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
[DSP] @0,008,033tk: [+4 T:0x87c2d494] OG -     package dsplink.dsp (/home/zfang/dm3730-dvsdk/dsplink_1_65_00_02/dsplink/dsp/) [1, 4, 0]
[DSP] @0,008,091tk: [+4 T:0x87c2d494] OG -     package ti.bios.utils (/home/zfang/dm3730-dvsdk/biosutils_1_02_02/packages/ti/bios/utils/) [2, 0, 2, 02]
[DSP] @0,008,155tk: [+4 T:0x87c2d494] OG -     package ti.catalog.c6000 (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
[DSP] @0,008,222tk: [+4 T:0x87c2d494] OG -     package ti.catalog (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
[DSP] @0,008,283tk: [+4 T:0x87c2d494] OG -     package ti.catalog.arm (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
[DSP] @0,008,348tk: [+4 T:0x87c2d494] OG -     package ti.platforms.evm3530 (/home/zfang/dm3730-dvsdk/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
[DSP] @0,008,417tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.osal (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/osal/) [2, 0, 2]
[DSP] @0,008,484tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.osal.bios (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
[DSP] @0,008,553tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.ipc (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/ipc/) [2, 0, 1]
[DSP] @0,008,618tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.ipc.bios (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
[DSP] @0,008,687tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.alg (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/alg/) [1, 0, 1]
[DSP] @0,008,751tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/) [1, 0, 6]
[DSP] @0,008,814tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.bioslog (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
[DSP] @0,008,882tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.universal (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/universal/) [1, 0, 0]
[DSP] @0,008,951tk: [+4 T:0x87c2d494] OG -     package ti.c6accel.ce (/home/zfang/dm3730-dvsdk/c6accel_1_01_00_06/soc/packages/ti/c6accel/ce/) [1, 0, 0]
[DSP] @0,009,016tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.audio1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/audio1/) [1, 0, 1]
[DSP] @0,009,083tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.aachedec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/aachedec/ce/) [1, 0, 0]
[DSP] @0,009,158tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.deinterlacer.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/deinterlacer/ce/) [1, 0, 0]
[DSP] @0,009,235tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.speech1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/speech1/) [1, 0, 1]
[DSP] @0,009,303tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.g711dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711dec/ce/) [1, 0, 0]
[DSP] @0,009,377tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.g711enc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/g711enc/ce/) [1, 0, 0]
[DSP] @0,009,451tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.video2 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/video2/) [1, 0, 2]
[DSP] @0,009,519tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.h264dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264dec/) []
[DSP] @0,009,588tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.h264dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264dec/ce/) []
[DSP] @0,009,660tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.video1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/video1/) [1, 0, 2]
[DSP] @0,009,728tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.h264enc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264enc/) []
[DSP] @0,009,797tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.h264enc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/h264enc/ce/) []
[DSP] @0,009,869tk: [+4 T:0x87c2d494] OG -     package ti.sdo.ce.image1 (/home/zfang/dm3730-dvsdk/codec-engine_2_26_02_11/packages/ti/sdo/ce/image1/) [1, 0, 1]
[DSP] @0,009,936tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.jpegdec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
[DSP] @0,010,029tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.jpegenc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
[DSP] @0,010,106tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.mpeg2dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg2dec/) []
[DSP] @0,010,176tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.mpeg2dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg2dec/ce/) []
[DSP] @0,010,249tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.mpeg4dec (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4dec/) []
[DSP] @0,010,319tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.mpeg4dec.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4dec/ce/) []
[DSP] @0,010,392tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.mpeg4enc (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4enc/) []
[DSP] @0,010,462tk: [+4 T:0x87c2d494] OG -     package ti.sdo.codecs.mpeg4enc.ce (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/codecs/mpeg4enc/ce/) []
[DSP] @0,010,535tk: [+4 T:0x87c2d494] OG -     package ti.sdo.server.cs (/home/zfang/dm3730-dvsdk/codecs-omap3530_4_02_00_00/packages/ti/sdo/server/cs/) [1, 0, 0]
[DSP] @0,010,603tk: [+0 T:0x87c2d494] OG - Global_setSpecialTrace> return
@0,350,769us: [+0 T:0x4001f0d0] CE - Engine_fwriteTrace> returning count [10525]
@0,350,799us: [+0 T:0x4001f0d0] CE - Engine_initFromServer(0x57508)
@0,350,830us: [+0 T:0x4001f0d0] CE - Engine_getNumServerAlgs(0x57508 0xbeec3a78)
@0,351,104us: [+0 T:0x4001f0d0] CE - Engine_getNumServerAlgs number of server algs = 12
@0,351,135us: [+0 T:0x4001f0d0] CE - Engine_getNumServerAlgs exit 0
@0,351,165us: [+2 T:0x4001f0d0] CE - Engine_initFromServer> Number of remote algs statically configured in engine: 12
@0,351,196us: [+2 T:0x4001f0d0] CE - Engine_initFromServer> Number of statically configured remote algs = number of server algs: 12
@0,351,196us: [+0 T:0x4001f0d0] CE - Engine_initFromServer> Returning 0
@0,351,227us: [+0 T:0x4001f0d0] CE - Engine_open> return(357640)
@0,351,257us: [+0 T:0x4001f0d0] CE - Engine_getNumAlgs('codecServer', 0xbeec3b1c)
iNumAlgs[12]
@0,351,349us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0x57508, name='h264dec', params=0xbeec3b3c)
@0,351,410us: [+0 T:0x4001f0d0] CV - VISA_create(0x57508, 'h264dec', 0xbeec3b3c, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
@0,351,440us: [+0 T:0x4001f0d0] CV - VISA_create2(0x57508, 'h264dec', 0xbeec3b3c, 0x1c, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
@0,351,501us: [+0 T:0x4001f0d0] CE - Engine_createNode(0x57508, 'h264dec', 2340, 0xbeec3b3c, 0x1c, 0xbeec3980)
@0,351,532us: [+0 T:0x4001f0d0] CE - Engine> allocNode Enter(engine=0x57508, impId='h264dec')
@0,351,562us: [+0 T:0x4001f0d0] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_1656_1, 0x57bc0, NULL)
@0,480,469us: [+4 T:0x4001f0d0] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x57be0, algName='h264dec', rmsNode=0x87c31f68, algHandle=0x87c32058)
[DSP] @0,034,234tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,034,288tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c31f68)
[DSP] @0,034,332tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0xa)
[DSP] @0,034,368tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c31f80)
[DSP] @0,034,416tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,034,455tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c31f90)
[DSP] @0,034,500tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,034,541tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c31fb0)
[DSP] @0,034,620tk: [+0 T:0x87c2d494] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0x0, name='h264dec', params=0x859048c0)
[DSP] @0,034,697tk: [+0 T:0x87c2d494] CV - VISA_create(0x0, 'h264dec', 0x859048c0, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
[DSP] @0,034,764tk: [+0 T:0x87c2d494] CV - VISA_create2(0x0, 'h264dec', 0x859048c0, 0x1c, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
[DSP] @0,034,842tk: [+0 T:0x87c2d494] CE - Engine_open> Enter('local', 0x87c3116c, 0x859048c0)
[DSP] @0,034,896tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x34)
[DSP] @0,034,933tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c32020)
[DSP] @0,034,984tk: [+4 T:0x87c2d494] CE - Engine_open> engine->server = 0x0
[DSP] @0,035,023tk: [+0 T:0x87c2d494] CE - Engine_open> return(-2017255392)
[DSP] @0,035,086tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x34)
[DSP] @0,035,125tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c32058)
[DSP] @0,035,172tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x87c9846c, idma3Fxns=0x87c98498, iresFxns=0x0, params=0x859048c0, attrs=0x87c31288)
[DSP] @0,035,259tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,035,296tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c32090)
[DSP] @0,434,384tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x87c32090)
[DSP] @0,434,467tk: [+5 T:0x87c2d494] CV - VISA_create> local codec created (name='h264dec', handle=0x87c32090)
[DSP] @0,434,527tk: [+0 T:0x87c2d494] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x87c32058)
[DSP] @0,434,591tk: [+4 T:0x87c2d494] OT - Thread_create > name: "h264dec#0", pri:  -1, stack size:  24576, stack seg: 0
@0,482,086us: [+0 T:0x4001f0d0] CE - Engine_fwriteTrace> returning count [2300]
@0,482,117us: [+2 T:0x4001f0d0] CE - Engine_createNode> Returning 0x57bb8
@0,482,147us: [+5 T:0x4001f0d0] CV - VISA_create> remote codec created (name='h264dec', localQueueID=0x10001, remoteQueueID=0x0002)
@0,482,178us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x57b70)
@0,482,208us: [+2 T:0x4001f0d0] ti.sdo.dmai - [Vdec2] Video decoder instance created
@0,482,239us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Enter (handle=0x57b70, id=1, dynParams=0xbeec3b20 (size=0x1c), status=0xbeec3a3c (size=0xb8)
@0,482,269us: [+4 T:0x4001f0d0] CV - VISA_getMaxMsgSize(0x57b70): returning 0x1000
@0,482,300us: [+5 T:0x4001f0d0] CV - VISA_allocMsg> Allocating message for messageId=0x0002f58e
@0,482,330us: [+0 T:0x4001f0d0] CV - VISA_call(visa=0x57b70, msg=0x4131f880): messageId=0x0002f58e, command=0x1
[DSP] @0,442,135tk: [+5 T:0x87c325dc] CN - NODE> 0x87c31f90(h264dec#0) call(algHandle=0x87c32058, msg=0x85905880); messageId=0x0002f58e
[DSP] @0,442,233tk: [+0 T:0x87c325dc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Enter (handle=0x87c32058, id=1, dynParams=0x859058b4 (size=0x1c), status=0x859058d0 (size=0xb8)
[DSP] @0,442,332tk: [+5 T:0x87c325dc] CV - VISA_enter(visa=0x87c32058): algHandle = 0x87c32090
[DSP] @0,442,388tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x87c32090)
[DSP] @0,442,450tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @0,442,577tk: [+5 T:0x87c325dc] CV - VISA_exit(visa=0x87c32058): algHandle = 0x87c32090
[DSP] @0,442,630tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x87c32090)
[DSP] @0,442,690tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @0,442,735tk: [+0 T:0x87c325dc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Exit (handle=0x87c32058, retVal=0x0)
[DSP] @0,442,795tk: [+5 T:0x87c325dc] CN - NODE> returned from call(algHandle=0x87c32058, msg=0x85905880); messageId=0x0002f58e
@0,483,673us: [+0 T:0x4001f0d0] CE - Engine_fwriteTrace> returning count [1144]
@0,483,704us: [+0 T:0x4001f0d0] CV - VISA_call Completed: messageId=0x0002f58e, command=0x1, return(status=0)
@0,483,734us: [+5 T:0x4001f0d0] CV - VISA_freeMsg(0x57b70, 0x4131f880): Freeing message with messageId=0x0002f58e
@0,483,734us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Exit (handle=0x57b70, retVal=0x0)
@0,483,765us: [+2 T:0x4001f0d0] ti.sdo.dmai - [Vdec2] Made XDM_SETPARAMS control call
@0,483,795us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Enter (handle=0x57b70, id=5, dynParams=0x57afc (size=0x1c), status=0xbeec395c (size=0xb8)
@0,483,826us: [+4 T:0x4001f0d0] CV - VISA_getMaxMsgSize(0x57b70): returning 0x1000
@0,483,826us: [+5 T:0x4001f0d0] CV - VISA_allocMsg> Allocating message for messageId=0x0002f58f
@0,483,856us: [+0 T:0x4001f0d0] CV - VISA_call(visa=0x57b70, msg=0x4131f880): messageId=0x0002f58f, command=0x1
[DSP] @0,446,904tk: [+5 T:0x87c325dc] CN - NODE> 0x87c31f90(h264dec#0) call(algHandle=0x87c32058, msg=0x85905880); messageId=0x0002f58f
[DSP] @0,446,978tk: [+0 T:0x87c325dc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Enter (handle=0x87c32058, id=5, dynParams=0x859058b4 (size=0x1c), status=0x859058d0 (size=0xb8)
[DSP] @0,447,067tk: [+5 T:0x87c325dc] CV - VISA_enter(visa=0x87c32058): algHandle = 0x87c32090
[DSP] @0,447,118tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x87c32090)
[DSP] @0,447,172tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @0,447,240tk: [+5 T:0x87c325dc] CV - VISA_exit(visa=0x87c32058): algHandle = 0x87c32090
[DSP] @0,447,291tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x87c32090)
[DSP] @0,447,342tk: [+0 T:0x87c325dc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @0,447,384tk: [+0 T:0x87c325dc] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Exit (handle=0x87c32058, retVal=0x0)
[DSP] @0,447,441tk: [+5 T:0x87c325dc] CN - NODE> returned from call(algHandle=0x87c32058, msg=0x85905880); messageId=0x0002f58f
@0,485,107us: [+0 T:0x4001f0d0] CE - Engine_fwriteTrace> returning count [1144]
@0,485,138us: [+0 T:0x4001f0d0] CV - VISA_call Completed: messageId=0x0002f58f, command=0x1, return(status=0)
@0,485,168us: [+5 T:0x4001f0d0] CV - VISA_freeMsg(0x57b70, 0x4131f880): Freeing message with messageId=0x0002f58f
@0,485,199us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_control> Exit (handle=0x57b70, retVal=0x0)
@0,485,199us: [+2 T:0x4001f0d0] ti.sdo.dmai - [Vdec2] Made XDM_GETBUFINFO control call
in main create codec success
start thread
@0,485,474us: [+0 T:0x41b8e490] CE - Engine_open> Enter('codecServer', 0x0, 0x41b8dda4)
@0,485,504us: [+0 T:0x41b8e490] CE - rserverOpen('cs.x64P'), count = 1
@0,485,535us: [+0 T:0x41b8e490] CE - rserverOpen('cs.x64P'): 0x55814 done.
@0,486,145us: [+0 T:0x41b8e490] CE - checkServer(0x57c80)
@0,486,450us: [+4 T:0x41b8e490] CE - Engine_open> engine->server = 0x55814
@0,486,725us: [+0 T:0x41b8e490] CE - Engine_fwriteTrace> returning count [0]
@0,486,755us: [+0 T:0x41b8e490] CE - Engine_initFromServer(0x57c80)
@0,486,847us: [+0 T:0x41b8e490] CE - Engine_getNumServerAlgs(0x57c80 0x41b8dd40)
@0,487,121us: [+0 T:0x41b8e490] CE - Engine_getNumServerAlgs number of server algs = 12
@0,487,152us: [+0 T:0x41b8e490] CE - Engine_getNumServerAlgs exit 0
@0,487,182us: [+2 T:0x41b8e490] CE - Engine_initFromServer> Number of remote algs statically configured in engine: 12
@0,487,213us: [+2 T:0x41b8e490] CE - Engine_initFromServer> Number of statically configured remote algs = number of server algs: 12
@0,487,213us: [+0 T:0x41b8e490] CE - Engine_initFromServer> Returning 0
@0,487,243us: [+0 T:0x41b8e490] CE - Engine_open> return(359552)
@0,487,274us: [+0 T:0x41b8e490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0x57c80, name='h264dec:5', params=0x41b8ddf8)
@0,487,305us: [+0 T:0x41b8e490] CV - VISA_create(0x57c80, 'h264dec:5', 0x41b8ddf8, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
@0,487,335us: [+0 T:0x41b8e490] CV - VISA_create2(0x57c80, 'h264dec:5', 0x41b8ddf8, 0x1c, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
@0,487,396us: [+3 T:0x41b8e490] CV - VISA_create2> name: h264dec  priority: 5 single heap: 0  # messages: 1
@0,487,457us: [+0 T:0x41b8e490] CE - Engine_createNode(0x57c80, 'h264dec', 2340, 0x41b8ddf8, 0x1c, 0x41b8dc48)
@0,487,488us: [+0 T:0x41b8e490] CE - Engine> allocNode Enter(engine=0x57c80, impId='h264dec')
@0,487,518us: [+0 T:0x41b8e490] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_1656_3, 0x57e98, NULL)
@0,505,859us: [+6 T:0x41b8e490] CE - Engine_createNode> Remote node creation FAILED (0x80008008).
[DSP] @0,459,083tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,459,139tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c38630)
[DSP] @0,459,182tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0xa)
[DSP] @0,459,220tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c38648)
[DSP] @0,459,266tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,459,305tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c38658)
[DSP] @0,459,352tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,459,395tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c38678)
[DSP] @0,459,454tk: [+0 T:0x87c2d494] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> Enter (engine=0x0, name='h264dec', params=0x859068c0)
[DSP] @0,459,520tk: [+0 T:0x87c2d494] CV - VISA_create(0x0, 'h264dec', 0x859068c0, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
[DSP] @0,459,585tk: [+0 T:0x87c2d494] CV - VISA_create2(0x0, 'h264dec', 0x859068c0, 0x1c, 0x2340, 'ti.sdo.ce.video2.IVIDDEC2')
[DSP] @0,459,686tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x34)
[DSP] @0,459,726tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c386a0)
[DSP] @0,459,772tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x87c9846c, idma3Fxns=0x87c98498, iresFxns=0x0, params=0x859068c0, attrs=0x87c31288)
[DSP] @0,459,858tk: [+0 T:0x87c2d494] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,459,897tk: [+0 T:0x87c2d494] OM - Memory_alloc> return (0x87c386d8)
[DSP] @0,513,884tk: [+7 T:0x87c2d494] 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,514,043tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x87c386d8)
[DSP] @0,514,099tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c386d8, size=16)
[DSP] @0,514,151tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @0,514,187tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit
[DSP] @0,514,231tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x0)
[DSP] @0,514,280tk: [+6 T:0x87c2d494] CV - VISA_create2> FAILED to create local codec.
[DSP] @0,514,323tk: [+0 T:0x87c2d494] CV - VISA_delete(0x87c386a0)
[DSP] @0,514,363tk: [+5 T:0x87c2d494] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
[DSP] @0,514,421tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c386a0, size=52)
[DSP] @0,514,470tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @0,514,513tk: [+0 T:0x87c2d494] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x0)
[DSP] @0,514,590tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c38678, size=36)
[DSP] @0,514,637tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @0,514,671tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c38658, size=32)
[DSP] @0,514,717tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @0,514,763tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c38648, size=10)
[DSP] @0,514,811tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @0,514,845tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c38630, size=24)
[DSP] @0,514,891tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
@0,508,117us: [+0 T:0x41b8e490] CE - Engine_fwriteTrace> returning count [3351]
@0,508,147us: [+2 T:0x41b8e490] CE - Engine_createNode> Returning 0x0
@0,508,178us: [+6 T:0x41b8e490] CV - VISA_create2> FAILED to create remote codec (0x8).
@0,508,208us: [+0 T:0x41b8e490] CV - VISA_delete(0x57e48)
@0,508,208us: [+5 T:0x41b8e490] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
@0,508,269us: [+0 T:0x41b8e490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_create> return (0x0)
@0,508,269us: [+7 T:0x41b8e490] ti.sdo.dmai - [Vdec2] Failed to open video decode algorithm
@0,508,391us: [+0 T:0x41b8e490] CE - Engine_close(0x57c80)
@0,508,514us: [+0 T:0x41b8e490] CE - Engine_fwriteTrace> returning count [0]
@0,508,544us: [+0 T:0x41b8e490] CS - Server_disconnectTrace('0x57c80', 0x0)
@0,508,544us: [+0 T:0x41b8e490] CS - Server_disconnectTrace> return(0)
@0,508,666us: [+0 T:0x41b8e490] CE - rserverClose(0x55814), count = 2
@0,508,727us: [+0 T:0x41b8e490] CE - rserverClose(0x55814) done.
@0,508,727us: [+0 T:0x41b8e490] CE - Engine_close exit
end thread
@3,485,701us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> Enter (handle=0x57b70)
@3,885,816us: [+0 T:0x4001f0d0] CV - VISA_delete(0x57b70)
@3,885,846us: [+5 T:0x4001f0d0] CV - VISA_delete> deleting codec (localQueue=0x10001, remoteQueue=0x2)
@3,885,877us: [+0 T:0x4001f0d0] CE - Engine_ctrlNode(0x57bb8, 0x57ba8, 0x0)
@3,886,029us: [+0 T:0x4001f0d0] CE - Engine_ctrlNode> Returning 0x0
@3,886,090us: [+0 T:0x4001f0d0] CE - Engine_deleteNode(0x57bb8)
@3,886,884us: [+5 T:0x4001f0d0] CE - Engine_deleteNode(0x57bb8): algName = h264dec, algHandle = 0x87c32058, stack size = 24576, stack used = 1423(6%)
@3,887,098us: [+0 T:0x4001f0d0] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> return
@3,887,159us: [+0 T:0x4001f0d0] CE - Engine_close(0x57508)
[DSP] @11,078,902tk: [+0 T:0x87c325dc] CN - NODE_EXECFXN(0x87c31f90): h264dec#0 exiting per request ...
[DSP] @11,080,239tk: [+0 T:0x87c2d494] CN - NODE_delete(0x87c31f90): h264dec#0
[DSP] @11,080,328tk: [+0 T:0x87c2d494] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> Enter (handle=0x87c32058)
[DSP] @11,080,383tk: [+0 T:0x87c2d494] CV - VISA_delete(0x87c32058)
[DSP] @11,080,423tk: [+5 T:0x87c2d494] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
[DSP] @11,080,478tk: [+5 T:0x87c2d494] CV - VISA_delete> deleting codec 0x87c32090
[DSP] @11,080,522tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x87c32090)
[DSP] @11,080,801tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c32090, size=16)
[DSP] @11,080,855tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @11,080,892tk: [+0 T:0x87c2d494] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit
[DSP] @11,080,937tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c32058, size=52)
[DSP] @11,080,983tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @11,081,019tk: [+0 T:0x87c2d494] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_delete> return
[DSP] @11,081,066tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c31fb0, size=36)
[DSP] @11,081,112tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @11,081,147tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c31f90, size=32)
[DSP] @11,081,192tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @11,081,232tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c31f80, size=10)
[DSP] @11,081,278tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
[DSP] @11,081,312tk: [+0 T:0x87c2d494] OM - Memory_free> Enter(addr=0x87c31f68, size=24)
[DSP] @11,081,358tk: [+0 T:0x87c2d494] OM - Memory_free> return (0x1)
@3,888,685us: [+0 T:0x4001f0d0] CE - Engine_fwriteTrace> returning count [1790]
@3,888,716us: [+0 T:0x4001f0d0] CS - Server_disconnectTrace('0x57508', 0x0)
@3,888,747us: [+0 T:0x4001f0d0] CS - Server_disconnectTrace> return(0)
@3,888,869us: [+0 T:0x4001f0d0] CE - rserverClose(0x55814), count = 1
@3,888,930us: [+0 T:0x4001f0d0] OP - Processor_delete> Enter(proc=0x57540)
@3,888,960us: [+0 T:0x4001f0d0] OP - doCmd> Enter (cmdId=2, proc=0x57540)
@3,888,960us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x571c0]
@3,889,021us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x571c0] status[0]
@3,889,052us: [+0 T:0x40b0e490] OP - getCmd_d> Exit (result=2)
@3,889,082us: [+0 T:0x40b0e490] OP - Processor_delete_d> Enter (proc=0x57540)
@3,889,113us: [+0 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_disconnect> Enter (handle=0x57568)
@3,889,113us: [+2 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_disconnect> Calling LPM_disconnect to disconnect from the DSP power handler...
@3,889,174us: [+0 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_disconnect> return (0)
@3,889,204us: [+2 T:0x40b0e490] OP - Processor_delete_d> Closing remote transport...
@3,889,327us: [+2 T:0x40b0e490] OP - Processor_delete_d> Stopping DSP...
@3,889,388us: [+2 T:0x40b0e490] OP - Processor_delete_d> Closing pool...
@3,889,479us: [+2 T:0x40b0e490] OP - Processor_delete_d> Detaching from DSP...
@3,891,097us: [+2 T:0x40b0e490] OP - Processor_delete_d> Destroying DSP... (object, that is)
@3,891,342us: [+0 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_off> Enter (handle=0x57568)
@3,891,403us: [+2 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_off> Turning off DSP power...
@3,891,464us: [+2 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_off> Closing Local Power Manager object...
@3,891,494us: [+0 T:0x40b0e490] ti.sdo.ce.ipc.Power - Power_off> return (0)
@3,891,525us: [+0 T:0x40b0e490] OP - Processor_delete_d> return
@3,891,555us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x571d8]
@3,891,586us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x571d8]
@3,891,616us: [+0 T:0x40b0e490] OP - getCmd_d> Enter (proc=0x40b0ddd8)
@3,891,616us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x571c0] timeout[0xffffffff]
@3,891,677us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x571c0]
@3,891,708us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x571d8] timeout[0xffffffff]
@3,891,708us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x571d8] status[0]
@3,891,738us: [+0 T:0x4001f0d0] OP - doCmd> Exit (result=1)
@3,891,769us: [+1 T:0x4001f0d0] OP - Processor_delete(0x57540) freeing object ...
@3,891,799us: [+0 T:0x4001f0d0] OP - Processor_delete> return.
@3,891,799us: [+0 T:0x4001f0d0] CE - rserverClose(0x55814) done.
@3,891,830us: [+0 T:0x4001f0d0] CE - Engine_close exit
End of application. ret[0].
@3,891,922us: [+0 T:0x4001f0d0] OP - doCmd> Enter (cmdId=3, proc=0x0)
@3,891,952us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x571c0]
@3,891,983us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x571c0]
@3,892,013us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x571d8] timeout[0xffffffff]
@3,892,044us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x571c0] status[0]
@3,892,074us: [+0 T:0x40b0e490] OP - getCmd_d> Exit (result=3)
@3,892,105us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x571d8]
@3,892,105us: [+0 T:0x40b0e490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x571d8]
@3,892,227us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x571d8] status[0]
@3,892,257us: [+0 T:0x4001f0d0] OP - doCmd> Exit (result=1)
@3,892,288us: [+0 T:0x4001f0d0] OT - Thread_delete> Enter (task=0x57210)
@3,892,380us: [+4 T:0x4001f0d0] OT - Thread_delete> pthread_cancel (0x3)
@3,892,410us: [+4 T:0x4001f0d0] OT - Thread_delete> pthread_join (0x0)
@3,892,441us: [+0 T:0x4001f0d0] OT - Thread_delete> Exit (task=0x57210)
@3,892,471us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x571c0]
@3,892,502us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@3,892,502us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x571d8]
@3,892,532us: [+0 T:0x4001f0d0] ti.sdo.ce.osal.Sem - Leaving Sem_delete>