This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

关于omap3530 jpegenc集成问题

Other Parts Discussed in Thread: OMAP3530

硬件环境:devkit8500d

软件环境:dvsdk4.0.0.3

问题描述:

       按照codecs-omap3530_4_00_00_00开发包的提示内容,我集成了jpegenc库的内容,并成功生成了x64P文件,arm端app调用时,能成功执行IMGENC1_create和IMGENC1_delete,但是在执行IMGENC1_control时,一直返回-1的错误,我arm端app代码如下:

Int main(Int argc, Char *argv[])
{
	Engine_Handle hEngine;
	IMGENC1_Handle hImg;

	printf(" ----------------------- demo -4- start ------------------------ \n");
	
	//初始化engine
	CERuntime_init();
	TraceUtil_start(ENGINE_NAME);
    //创建和启动engine
	hEngine = Engine_open(ENGINE_NAME, NULL, NULL);
	if ( hEngine == NULL)
	{
		printf("Failed to open engine %s\n", ENGINE_NAME);
		exit(-1);
	}
	else 
	{
		printf("Success to open engine %s\n", ENGINE_NAME);
	}

	 GT_set("*=01234567");

    //创建算法
	hImg = IMGENC1_create(hEngine, CODEC_NAME, NULL);
	if ( hImg == NULL)
	{
		printf("Failed to create codec %s\n", CODEC_NAME);
		exit (-1);
	}
	else
	{
		printf("Success to create codec %s\n", CODEC_NAME);
	}

#if 1
	IMGENC1_DynamicParams       encDynParams;
	IMGENC1_Status              encStatus;

	encDynParams.size	= sizeof(IMGENC1_DynamicParams);
	memset(&encStatus, 0, sizeof(IMGENC1_Status));
	encStatus.size		= sizeof(IMGENC1_Status);

	int status = IMGENC1_control(hImg, XDM_GETVERSION, &encDynParams, &encStatus);

	printf("status = %d\n", status);
#endif

#if 0
	///////////////////////////////////////////////////////////////////////////////////////////////////////
	//调用process
	//new buf
	int imageSize = 352*288*3/2;
	XDM_BufDesc inBufs, outBufs;
	XDAS_Int8* in_bufs[1], *out_bufs[1];
	XDAS_Int32 in_bufs_size[1], out_bufs_size[1];
	evaluate_param_t m_param;

	//init param
	m_param.base.size = sizeof(m_param);
	m_param.width	= 352;
	m_param.pitch	= m_param.width;
	m_param.height	= 288;

	imageSize = m_param.pitch * m_param.height;

	//init buf
	in_bufs_size[0] = out_bufs_size[0] = imageSize;
	inBufs.bufs = in_bufs;
	inBufs.bufSizes = in_bufs_size;
	inBufs.numBufs = 1; 
	outBufs.bufs = out_bufs;
	outBufs.bufSizes = out_bufs_size;
	outBufs.numBufs = 1;   
	in_bufs[0]	= (XDAS_Int8*)Memory_contigAlloc(in_bufs_size[0], 16);
	out_bufs[0] = (XDAS_Int8*)Memory_contigAlloc(out_bufs_size[0], 16);
	memset(in_bufs[0], 128, in_bufs_size[0]);
	memset(out_bufs[0], 255, out_bufs_size[0]);

	IMGDEC_OutArgs	outArgs;
	outArgs.size	= sizeof(outArgs);

	//read file
	readFile(SRC_FILE, in_bufs[0], imageSize * sizeof(unsigned char));

    //调用算法处理
	int ret = IMGDEC_process(hImg, &inBufs, &outBufs, (IMGDEC_InArgs *)&m_param, &outArgs);
	

	printf("IMGDEC_process ret:%d\n\n\n\n", ret);
	writeFile("./dst.gray", outBufs.bufs[0], imageSize * sizeof(unsigned char));

	//free buf
	Memory_contigFree(in_bufs[0], in_bufs_size[0]);
	Memory_contigFree(out_bufs[0], out_bufs_size[0]);
	///////////////////////////////////////////////////////////////////////////////////////////////////////
#endif

	//移除算法
	IMGENC1_delete(hImg);
	hImg = NULL;

    //关闭engine
	Engine_close(hEngine);
	TraceUtil_stop();
	hEngine = NULL;

}

在终端中,我使用CE_DEBUG=2 选项来执行app,得到的跟踪内容如下:

CE_DEBUG=2 ./encode 
 ----------------------- demo -4- start ------------------------ 
@0,891,114us: [+4 T:0x40020100] OG - Global_init> This program was built with the following packages:
@0,891,236us: [+4 T:0x40020100] OG -     package gnu.targets.arm.rtsv5T (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/gnu/targets/arm/rtsv5T/) [1, 0, 0, 0]
@0,891,267us: [+4 T:0x40020100] OG -     package ti.sdo.codecs.jpegenc (/opt/dvsdk_4_00_00_22/codecs-omap3530_4_00_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
@0,891,297us: [+4 T:0x40020100] OG -     package codecs.jpegenc (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/) [1, 0, 0]
@0,891,328us: [+4 T:0x40020100] OG -     package ti.sdo.ce.global (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
@0,891,328us: [+4 T:0x40020100] OG -     package ti.xdais.dm (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/dm/) [1, 0, 5]
@0,891,358us: [+4 T:0x40020100] OG -     package ti.sdo.utils.trace (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
@0,891,389us: [+4 T:0x40020100] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
@0,891,419us: [+4 T:0x40020100] OG -     package dsplink.gpp (/opt/dvsdk_4_00_00_22/dsplink_1_65_00_02/dsplink/gpp/) [5, 0, 0]
@0,891,419us: [+4 T:0x40020100] OG -     package ti.sdo.linuxutils.cmem (/opt/dvsdk_4_00_00_22/linuxutils_2_25_05_11/packages/ti/sdo/linuxutils/cmem/) [2, 2, 0]
@0,891,450us: [+4 T:0x40020100] OG -     package ti.bios.power (/opt/dvsdk_4_00_00_22/local-power-manager_1_24_02_09/packages/ti/bios/power/) [1, 1, 1]
@0,891,480us: [+4 T:0x40020100] OG -     package ti.xdais (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/) [1, 2.0, 1]
@0,891,480us: [+4 T:0x40020100] OG -     package ti.sdo.ce.node (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
@0,891,511us: [+4 T:0x40020100] OG -     package ti.sdo.fc.global (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
@0,891,511us: [+4 T:0x40020100] OG -     package ti.sdo.fc.memutils (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
@0,891,541us: [+4 T:0x40020100] OG -     package ti.sdo.fc.utils (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/utils/) [1, 0, 2]
@0,891,572us: [+4 T:0x40020100] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
@0,891,572us: [+4 T:0x40020100] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
@0,891,602us: [+4 T:0x40020100] OG -     package gnu.targets (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/gnu/targets/) [1, 0, 1]
@0,891,602us: [+4 T:0x40020100] OG -     package gnu.targets.arm (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/gnu/targets/arm/) [1, 0, 0, 0]
@0,891,633us: [+4 T:0x40020100] OG -     package ti.catalog.arm (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
@0,891,663us: [+4 T:0x40020100] OG -     package ti.catalog (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
@0,891,663us: [+4 T:0x40020100] OG -     package ti.catalog.c6000 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
@0,891,694us: [+4 T:0x40020100] OG -     package ti.platforms.evm3530 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
@0,891,724us: [+4 T:0x40020100] OG -     package ti.sdo.ce.osal (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
@0,891,724us: [+4 T:0x40020100] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
@0,891,755us: [+4 T:0x40020100] OG -     package ti.sdo.ce.osal.linux (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
@0,891,755us: [+4 T:0x40020100] OG -     package ti.sdo.ce.ipc.dsplink (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
@1,226,167us: [+4 T:0x40020100] OG -     package ti.sdo.ce.alg (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
@1,226,197us: [+4 T:0x40020100] OG -     package ti.sdo.ce (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
@1,226,228us: [+4 T:0x40020100] OG -     package ti.sdo.ce.image1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
@1,226,228us: [+4 T:0x40020100] OG -     package codecs.jpegenc.ce (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/ce/) [1, 0, 0]
@1,226,258us: [+4 T:0x40020100] OG -     package ti.sdo.ce.speech (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/speech/) [1, 0, 2]
@1,226,289us: [+4 T:0x40020100] OG -     package ti.sdo.ce.speech1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/speech1/) [1, 0, 1]
@1,226,289us: [+4 T:0x40020100] OG -     package ti.sdo.ce.audio (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/audio/) [1, 0, 2]
@1,226,319us: [+4 T:0x40020100] OG -     package ti.sdo.ce.audio1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/audio1/) [1, 0, 1]
@1,226,319us: [+4 T:0x40020100] OG -     package ti.sdo.ce.video (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/video/) [1, 0, 3]
@1,226,350us: [+4 T:0x40020100] OG -     package ti.sdo.ce.video1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/video1/) [1, 0, 2]
@1,226,380us: [+4 T:0x40020100] OG -     package ti.sdo.ce.video2 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/video2/) [1, 0, 2]
@1,226,380us: [+4 T:0x40020100] OG -     package ti.sdo.ce.image (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/image/) [1, 0, 3]
@1,226,411us: [+4 T:0x40020100] OG -     package ti.sdo.dmai (/opt/dvsdk_4_00_00_22/dmai_2_20_00_10/packages/ti/sdo/dmai/) [1, 0, 0]
@1,226,411us: [+4 T:0x40020100] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
@1,226,441us: [+4 T:0x40020100] OG -     package ti.sdo.ce.utils.trace (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/trace/) [1, 0, 1]
@1,226,472us: [+4 T:0x40020100] OG -     package encode_config (/home/eric/workplace/chenzh/jpegenc_test/test_x64P/omap3530/encode/encode_config/) []
@1,226,716us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@1,226,746us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x491c0]
@1,226,777us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@1,226,777us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x491d8]
@1,226,807us: [+0 T:0x40020100] OT - Thread_create> Enter (fxn=0x18330, attrs=0x0)
@1,227,052us: [+0 T:0x40020100] OT - Thread_create> Exit (task=0x49210)
@1,227,143us: [+0 T:0x40020100] ti.sdo.ce.alg - ALG_init> Enter
@1,227,143us: [+0 T:0x40020100] ti.sdo.ce.alg - ALG_init> Exit
@1,227,204us: [+6 T:0x40020100] CE - Engine_init> CE debugging on (CE_DEBUG=2; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@1,227,235us: [+0 T:0x40020100] CS - Server_init()
@1,227,265us: [+0 T:0x40020100] CS - Server_init> Global_useLinkArbiter = 0
TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil)
@1,227,326us: [+0 T:0x40020100] CE - Engine_open> Enter('hv_dsplib', 0x0, 0xbe88db6c)
@1,227,357us: [+0 T:0x40020100] CE - rserverOpen('hv_dsplib.x64P'), count = 0
@1,227,387us: [+0 T:0x40020100] OP - Processor_create> Enter(imageName='hv_dsplib.x64P', linkCfg='(null)', attrs=0xbe88db50)
@1,227,479us: [+0 T:0x40020100] OP - doCmd> Enter (cmdId=1, proc=0x49550)
@1,561,677us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x491c0]
@1,561,738us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x491c0]
@1,561,768us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x491d8] timeout[0xffffffff]
@1,561,799us: [+1 T:0x40cd2490] OP - daemon> thread created.
@1,561,829us: [+0 T:0x40cd2490] OP - getCmd_d> Enter (proc=0x40cd1dd8)
@1,561,860us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x491c0] timeout[0xffffffff]
@1,561,860us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x491c0] status[0]
@1,561,890us: [+0 T:0x40cd2490] OP - getCmd_d> Exit (result=1)
@1,561,890us: [+0 T:0x40cd2490] OP - Processor_create_d> Enter(proc=0x49550)
@1,561,921us: [+0 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_on> Enter(handle=0x4956c)
@1,561,951us: [+2 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_on> Opening Local Power Manager for the DSP on /dev/lpm0...
@1,561,982us: [+2 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_on> Turning on DSP power...
@1,562,135us: [+2 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_on> return (0)
@1,562,135us: [+2 T:0x40cd2490] OP - Processor_create_d> Initializing DSP PROC...
@1,562,165us: [+2 T:0x40cd2490] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'hv_dsplib.x64P']
@1,562,196us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x9fc00000, sizeInBytes=0x300000, shared=1, syncd=0
@1,562,226us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x9ff00000, sizeInBytes=0xff000, shared=1, syncd=0
@1,562,257us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x9ffff000, sizeInBytes=0x1000, shared=1, syncd=0
@1,562,287us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='L4PER', startAddress=0x49000000, sizeInBytes=0x100000, shared=0, syncd=0
@1,562,318us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #4 to Link configuration: name='IRAM', startAddress=0x5c7f8000, sizeInBytes=0x8000, shared=1, syncd=0
@1,562,348us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #5 to Link configuration: name='L1DSRAM', startAddress=0x5cf04000, sizeInBytes=0x10000, shared=1, syncd=0
@1,562,379us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #6 to Link configuration: name='DDRALGHEAP', startAddress=0x94000000, sizeInBytes=0xbc00000, shared=0, syncd=0
@1,562,379us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #7 to Link configuration: name='L4CORE', startAddress=0x48000000, sizeInBytes=0x1000000, shared=0, syncd=0
@1,562,409us: [+2 T:0x40cd2490] OP - Processor_create_d> Found 'CMEM' entry, adjusting base and size according to CMEM_getBlock()
@1,562,440us: [+0 T:0x40cd2490] OP - Processor_create_d> Setting CMEM base to 0x90000000, size to 0x4000000
@1,562,470us: [+2 T:0x40cd2490] OP - Processor_create_d> Adding DSP segment #8 to Link configuration: name='CMEM', startAddress=0x90000000, sizeInBytes=0x4000000, shared=0, syncd=0
@1,562,470us: [+2 T:0x40cd2490] OP - Processor_create_d> DODSPCTRL was=0; now=0
@1,562,501us: [+3 T:0x40cd2490] OP - LINKCFG_Object generated for PROC_setup(0x47e4c) ...
@1,562,531us: [+3 T:0x40cd2490] OP - linkCfg->gppObject->
@1,562,562us: [+3 T:0x40cd2490] OP -   name = "ARM9"
@1,562,592us: [+3 T:0x40cd2490] OP -   maxMsgqs = 0x82
@1,562,592us: [+3 T:0x40cd2490] OP -   maxChnlQueue = 0x10
@1,562,623us: [+3 T:0x40cd2490] OP -   poolTableId = 0xffffffff
@1,562,623us: [+3 T:0x40cd2490] OP -   numPools = 0x0
@1,562,653us: [+3 T:0x40cd2490] OP - 
@1,562,653us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->dspObject->
@1,897,187us: [+3 T:0x40cd2490] OP -   name = "OMAP3530"
@1,897,218us: [+3 T:0x40cd2490] OP -   dspArch = 0x2
@1,897,248us: [+3 T:0x40cd2490] OP -   loaderName = "COFF"
@1,897,248us: [+3 T:0x40cd2490] OP -   autoStart = FALSE
@1,897,279us: [+3 T:0x40cd2490] OP -   execName = "DEFAULT.OUT"
@1,897,279us: [+3 T:0x40cd2490] OP -   doDspCtrl = DSP_BootMode_Boot_NoPwr
@1,897,309us: [+3 T:0x40cd2490] OP -   resumeAddr = 0x9ffff020
@1,897,309us: [+3 T:0x40cd2490] OP -   resetVector = 0x9ffff000
@1,897,340us: [+3 T:0x40cd2490] OP -   resetCodeSize = 0x1000
@1,897,370us: [+3 T:0x40cd2490] OP -   maduSize = 0x1
@1,897,370us: [+3 T:0x40cd2490] OP -   cpuFreq = 0x6ddd0
@1,897,401us: [+3 T:0x40cd2490] OP -   endian = 0x3
@1,897,401us: [+3 T:0x40cd2490] OP -   wordSwap = 0x0
@1,897,431us: [+3 T:0x40cd2490] OP -   memTableId = 0x0
@1,897,431us: [+3 T:0x40cd2490] OP -   memEntries = 0x9
@1,897,462us: [+3 T:0x40cd2490] OP -   linkDrvId = 0x0
@1,897,462us: [+3 T:0x40cd2490] OP -   arg1 = 0xffffffff
@1,897,492us: [+3 T:0x40cd2490] OP -   arg2 = 0xffffffff
@1,897,492us: [+3 T:0x40cd2490] OP -   arg3 = 0x0
@1,897,523us: [+3 T:0x40cd2490] OP -   arg4 = 0x0
@1,897,523us: [+3 T:0x40cd2490] OP -   arg5 = 0xffffffff
@1,897,553us: [+3 T:0x40cd2490] OP - 
@1,897,553us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->linkDrvObjects->
@1,897,584us: [+3 T:0x40cd2490] OP -   name = "SHMDRV"
@1,897,614us: [+3 T:0x40cd2490] OP -   hshkPollCount = 0x989680
@1,897,614us: [+3 T:0x40cd2490] OP -   memEntry = 0x1
@1,897,645us: [+3 T:0x40cd2490] OP -   ipsTableId = 0x0
@1,897,645us: [+3 T:0x40cd2490] OP -   numIpsEntries = 0x1
@1,897,675us: [+3 T:0x40cd2490] OP -   poolTableId = 0x0
@1,897,675us: [+3 T:0x40cd2490] OP -   numPools = 0x1
@1,897,706us: [+3 T:0x40cd2490] OP -   dataTableId = 0x0
@1,897,706us: [+3 T:0x40cd2490] OP -   numDataDrivers = 0x1
@1,897,736us: [+3 T:0x40cd2490] OP -   mqtId = 0x0
@1,897,736us: [+3 T:0x40cd2490] OP -   ringIoTableId = 0x0
@1,897,767us: [+3 T:0x40cd2490] OP -   mplistTableId = 0x0
@1,897,767us: [+3 T:0x40cd2490] OP -   mpcsTableId = 0x0
@1,897,797us: [+3 T:0x40cd2490] OP - 
@1,897,797us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->memTables[0][i].
@1,897,828us: [+3 T:0x40cd2490] OP - entry #0:
@1,897,858us: [+3 T:0x40cd2490] OP -   entry = 0x0
@1,897,858us: [+3 T:0x40cd2490] OP -   name = "DDR2"
@1,897,889us: [+3 T:0x40cd2490] OP -   physAddr = 0x9fc00000
@1,897,889us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x9fc00000
@1,897,919us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@1,897,919us: [+3 T:0x40cd2490] OP -   size = 0x300000
@1,897,950us: [+3 T:0x40cd2490] OP -   shared = TRUE
@1,897,950us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@1,897,980us: [+3 T:0x40cd2490] OP - entry #1:
@1,897,980us: [+3 T:0x40cd2490] OP -   entry = 0x1
@1,898,011us: [+3 T:0x40cd2490] OP -   name = "DSPLINKMEM"
@1,898,042us: [+3 T:0x40cd2490] OP -   physAddr = 0x9ff00000
@1,898,042us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x9ff00000
@1,898,072us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@1,898,072us: [+3 T:0x40cd2490] OP -   size = 0xff000
@1,898,103us: [+3 T:0x40cd2490] OP -   shared = TRUE
@1,898,103us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@1,898,133us: [+3 T:0x40cd2490] OP - entry #2:
@1,898,133us: [+3 T:0x40cd2490] OP -   entry = 0x2
@1,898,164us: [+3 T:0x40cd2490] OP -   name = "RESET_VECTOR"
@1,898,164us: [+3 T:0x40cd2490] OP -   physAddr = 0x9ffff000
@1,898,194us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x9ffff000
@1,898,225us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@1,898,225us: [+3 T:0x40cd2490] OP -   size = 0x1000
@1,898,255us: [+3 T:0x40cd2490] OP -   shared = TRUE
@1,898,255us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@1,898,286us: [+3 T:0x40cd2490] OP - entry #3:
@2,232,880us: [+3 T:0x40cd2490] OP -   entry = 0x3
@2,232,880us: [+3 T:0x40cd2490] OP -   name = "L4PER"
@2,232,911us: [+3 T:0x40cd2490] OP -   physAddr = 0x49000000
@2,232,911us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x49000000
@2,232,941us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@2,232,972us: [+3 T:0x40cd2490] OP -   size = 0x100000
@2,232,972us: [+3 T:0x40cd2490] OP -   shared = FALSE
@2,233,002us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@2,233,002us: [+3 T:0x40cd2490] OP - entry #4:
@2,233,033us: [+3 T:0x40cd2490] OP -   entry = 0x4
@2,233,033us: [+3 T:0x40cd2490] OP -   name = "IRAM"
@2,233,063us: [+3 T:0x40cd2490] OP -   physAddr = 0x5c7f8000
@2,233,063us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x107f8000
@2,233,094us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@2,233,125us: [+3 T:0x40cd2490] OP -   size = 0x8000
@2,233,125us: [+3 T:0x40cd2490] OP -   shared = TRUE
@2,233,155us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@2,233,155us: [+3 T:0x40cd2490] OP - entry #5:
@2,233,186us: [+3 T:0x40cd2490] OP -   entry = 0x5
@2,233,186us: [+3 T:0x40cd2490] OP -   name = "L1DSRAM"
@2,233,216us: [+3 T:0x40cd2490] OP -   physAddr = 0x5cf04000
@2,233,216us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x10f04000
@2,233,247us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@2,233,247us: [+3 T:0x40cd2490] OP -   size = 0x10000
@2,233,277us: [+3 T:0x40cd2490] OP -   shared = TRUE
@2,233,277us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@2,233,308us: [+3 T:0x40cd2490] OP - entry #6:
@2,233,338us: [+3 T:0x40cd2490] OP -   entry = 0x6
@2,233,338us: [+3 T:0x40cd2490] OP -   name = "DDRALGHEAP"
@2,233,369us: [+3 T:0x40cd2490] OP -   physAddr = 0x94000000
@2,233,369us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x94000000
@2,233,399us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@2,233,399us: [+3 T:0x40cd2490] OP -   size = 0xbc00000
@2,233,430us: [+3 T:0x40cd2490] OP -   shared = FALSE
@2,233,430us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@2,233,460us: [+3 T:0x40cd2490] OP - entry #7:
@2,233,460us: [+3 T:0x40cd2490] OP -   entry = 0x7
@2,233,491us: [+3 T:0x40cd2490] OP -   name = "L4CORE"
@2,233,491us: [+3 T:0x40cd2490] OP -   physAddr = 0x48000000
@2,233,521us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x48000000
@2,233,552us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@2,233,552us: [+3 T:0x40cd2490] OP -   size = 0x1000000
@2,233,582us: [+3 T:0x40cd2490] OP -   shared = FALSE
@2,233,582us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@2,233,613us: [+3 T:0x40cd2490] OP - entry #8:
@2,233,613us: [+3 T:0x40cd2490] OP -   entry = 0x8
@2,233,643us: [+3 T:0x40cd2490] OP -   name = "CMEM"
@2,233,643us: [+3 T:0x40cd2490] OP -   physAddr = 0x90000000
@2,233,674us: [+3 T:0x40cd2490] OP -   dspVirtAddr = 0x90000000
@2,233,674us: [+3 T:0x40cd2490] OP -   gppVirtAddr = 0xffffffff
@2,233,704us: [+3 T:0x40cd2490] OP -   size = 0x4000000
@2,233,704us: [+3 T:0x40cd2490] OP -   shared = FALSE
@2,233,735us: [+3 T:0x40cd2490] OP -   syncd = FALSE
@2,233,735us: [+3 T:0x40cd2490] OP - 
@2,233,765us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->ipsTables[0][i].
@2,233,796us: [+3 T:0x40cd2490] OP - entry #0:
@2,233,796us: [+3 T:0x40cd2490] OP -   name = "IPS"
@2,233,826us: [+3 T:0x40cd2490] OP -   numIpsEvents = 0x20
@2,233,826us: [+3 T:0x40cd2490] OP -   memEntry = 0x1
@2,233,857us: [+3 T:0x40cd2490] OP -   gppIntId = 0x1a
@2,233,857us: [+3 T:0x40cd2490] OP -   dspIntId = 0x37
@2,233,887us: [+3 T:0x40cd2490] OP -   dspIntVectorId = 0x5
@2,233,887us: [+3 T:0x40cd2490] OP -   arg1 = 0x2faf080
@2,233,918us: [+3 T:0x40cd2490] OP -   arg2 = 0x0
@2,233,918us: [+3 T:0x40cd2490] OP - 
@2,233,949us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->poolTables[0][i].
@2,233,949us: [+3 T:0x40cd2490] OP - 
@2,233,979us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->dataTables[0][i].
@2,568,391us: [+3 T:0x40cd2490] OP - entry #0:
@2,568,391us: [+3 T:0x40cd2490] OP -   name = "ZCPYDATA"
@2,568,421us: [+3 T:0x40cd2490] OP -   baseChnlId = 0x0
@2,568,452us: [+3 T:0x40cd2490] OP -   numChannels = 0x10
@2,568,452us: [+3 T:0x40cd2490] OP -   maxBufSize = 0x4000
@2,568,482us: [+3 T:0x40cd2490] OP -   memEntry = 0x1
@2,568,482us: [+3 T:0x40cd2490] OP -   poolId = 0x0
@2,568,513us: [+3 T:0x40cd2490] OP -   queuePerChnl = 0x1
@2,568,513us: [+3 T:0x40cd2490] OP -   ipsId = 0x0
@2,568,543us: [+3 T:0x40cd2490] OP -   ipsEventNo = 0x1
@2,568,543us: [+3 T:0x40cd2490] OP -   arg1 = 0x0
@2,568,574us: [+3 T:0x40cd2490] OP -   arg2 = 0x0
@2,568,574us: [+3 T:0x40cd2490] OP - 
@2,568,604us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->mqtObjects->
@2,568,604us: [+3 T:0x40cd2490] OP -   name = "ZCPYMQT"
@2,568,635us: [+3 T:0x40cd2490] OP -   memEntry = 0x1
@2,568,635us: [+3 T:0x40cd2490] OP -   maxMsgSize = 0xffffffff
@2,568,665us: [+3 T:0x40cd2490] OP -   ipsId = 0x0
@2,568,696us: [+3 T:0x40cd2490] OP -   ipsEventNo = 0x0
@2,568,696us: [+3 T:0x40cd2490] OP -   arg1 = 0x0
@2,568,726us: [+3 T:0x40cd2490] OP -   arg2 = 0x0
@2,568,726us: [+3 T:0x40cd2490] OP - 
@2,568,757us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->ringIoObjects->
@2,568,757us: [+3 T:0x40cd2490] OP -   name = "RINGIOTABLE"
@2,568,787us: [+3 T:0x40cd2490] OP -   memEntry = 0x1
@2,568,787us: [+3 T:0x40cd2490] OP -   maxEntries = 0x40
@2,568,818us: [+3 T:0x40cd2490] OP -   ipsId = 0x0
@2,568,818us: [+3 T:0x40cd2490] OP -   ipsEventNo = 0x2
@2,568,848us: [+3 T:0x40cd2490] OP - 
@2,568,848us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->mplistObjects->
@2,568,879us: [+3 T:0x40cd2490] OP -   name = "MPLISTTABLE"
@2,568,879us: [+3 T:0x40cd2490] OP -   memEntry = 0x1
@2,568,909us: [+3 T:0x40cd2490] OP -   maxEntries = 0x40
@2,568,940us: [+3 T:0x40cd2490] OP -   ipsId = 0xffffffff
@2,568,940us: [+3 T:0x40cd2490] OP -   ipsEventNo = 0xffffffff
@2,568,970us: [+3 T:0x40cd2490] OP - 
@2,568,970us: [+3 T:0x40cd2490] OP - linkCfg->dspConfigs[0]->mpcsObjects->
@2,569,001us: [+3 T:0x40cd2490] OP -   name = "MPCS"
@2,569,001us: [+3 T:0x40cd2490] OP -   memEntry = 0x1
@2,569,032us: [+3 T:0x40cd2490] OP -   maxEntries = 0x100
@2,569,032us: [+3 T:0x40cd2490] OP -   ipsId = 0xffffffff
@2,569,062us: [+3 T:0x40cd2490] OP -   ipsEventNo = 0xffffffff
@2,570,039us: [+2 T:0x40cd2490] OP - Processor_create_d> Attaching to DSP PROC...
@2,573,487us: [+2 T:0x40cd2490] OP - Processor_create_d> Opening MSGQ pool...
@2,573,762us: [+2 T:0x40cd2490] OP - Processor_create_d> Loading hv_dsplib.x64P on DSP (1 args)...
@2,581,635us: [+2 T:0x40cd2490] OP - Processor_create_d> Starting DSP PROC...
@2,587,769us: [+2 T:0x40cd2490] OP - Processor_create_d> Opening remote transport...
@2,588,319us: [+0 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_connect> Enter (handle=0x49578)
@2,588,380us: [+2 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_connect> Calling LPM_connect to connect to the DSP power handler...
@2,588,471us: [+0 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_connect> return (0)
@2,588,502us: [+2 T:0x40cd2490] OP - Processor_create_d> return (1)
@2,588,532us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x491d8]
@2,588,593us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x491d8] status[0]
@2,588,624us: [+0 T:0x40020100] OP - doCmd> Exit (result=1)
@2,588,624us: [+0 T:0x40020100] OP - Processor_create> return (0x49550)
@2,588,715us: [+0 T:0x40020100] CE - rserverOpen('hv_dsplib.x64P'): 0x486b0 done.
@2,589,173us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x491d8]
@2,589,265us: [+0 T:0x40cd2490] OP - getCmd_d> Enter (proc=0x40cd1dd8)
@2,589,265us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x491c0] timeout[0xffffffff]
@2,589,356us: [+0 T:0x40020100] CE - checkServer(0x49518)
@2,589,539us: [+0 T:0x40020100] CE - rmsInit> RMS initialized(0x49518); 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
@2,923,524us: [+0 T:0x40020100] CE - Engine_setTrace> Enter(engine=0x49518, mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
@2,923,615us: [+1 T:0x40020100] CE - Engine_setTrace> Requesting DSP set trace ...
@2,924,592us: [+0 T:0x40020100] CE - Engine_setTrace> return(0)
@2,924,622us: [+4 T:0x40020100] CE - Engine_open> engine->server = 0x486b0
[DSP] @0x000002be:[T:0x00000000] servers.imgalg - main> Welcome to DSP server's main().
[DSP] @1,049,951tk: [+0 T:0x9fc302d4] 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] @1,050,039tk: [+4 T:0x9fc302d4] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @1,050,092tk: [+4 T:0x9fc302d4] OG -     package ti.targets.rts6000 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/targets/rts6000/) [1, 0, 0, 0]
[DSP] @1,050,158tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.codecs.jpegenc (/opt/dvsdk_4_00_00_22/codecs-omap3530_4_00_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
[DSP] @1,050,230tk: [+4 T:0x9fc302d4] OG -     package codecs.jpegenc (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/) [1, 0, 0]
[DSP] @1,050,292tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.fc.global (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
[DSP] @1,050,361tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.utils.trace (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
[DSP] @1,050,431tk: [+4 T:0x9fc302d4] OG -     package ti.xdais (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/) [1, 2.0, 1]
[DSP] @1,050,489tk: [+4 T:0x9fc302d4] OG -     package ti.rtdx (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/rtdx/) [2, 0, 0, 5]
[DSP] @1,050,547tk: [+4 T:0x9fc302d4] OG -     package ti.psl (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/psl/) [5, 0, 0, 0]
[DSP] @1,050,604tk: [+4 T:0x9fc302d4] OG -     package ti.pmi (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/pmi/) [1, 0, 0, 0]
[DSP] @1,050,662tk: [+4 T:0x9fc302d4] OG -     package ti.pscl (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/pscl/) [1, 0, 0, 0]
[DSP] @1,050,721tk: [+4 T:0x9fc302d4] OG -     package ti.bios (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/bios/) [5, 2, 5, 28]
[DSP] @1,050,779tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.fc.dskt2 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
[DSP] @1,050,847tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.fc.dman3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
[DSP] @1,050,915tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.global (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
[DSP] @1,050,980tk: [+4 T:0x9fc302d4] OG -     package ti.xdais.dm (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/dm/) [1, 0, 5]
[DSP] @1,051,040tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.node (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
[DSP] @1,051,104tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2, 0, 1]
[DSP] @1,051,176tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.utils.xdm (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
[DSP] @1,051,244tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.fc.memutils (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
[DSP] @1,051,314tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.fc.acpy3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
[DSP] @1,051,382tk: [+4 T:0x9fc302d4] OG -     package dsplink.dsp (/opt/dvsdk_4_00_00_22/dsplink_1_65_00_02/dsplink/dsp/) [1, 4, 0]
[DSP] @1,051,439tk: [+4 T:0x9fc302d4] OG -     package ti.bios.utils (/opt/dvsdk_4_00_00_22/biosutils_1_02_02/packages/ti/bios/utils/) [2, 0, 2, 02]
[DSP] @1,051,501tk: [+4 T:0x9fc302d4] OG -     package ti.catalog.c6000 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
[DSP] @1,051,567tk: [+4 T:0x9fc302d4] OG -     package ti.catalog (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
[DSP] @1,051,626tk: [+4 T:0x9fc302d4] OG -     package ti.catalog.arm (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
[DSP] @1,051,690tk: [+4 T:0x9fc302d4] OG -     package ti.platforms.evm3530 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
[DSP] @1,051,757tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.osal (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
[DSP] @1,051,821tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.osal.bios (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
[DSP] @1,051,889tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.ipc (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
[DSP] @1,051,953tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.ipc.bios (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
[DSP] @1,052,020tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.alg (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
[DSP] @1,052,084tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
[DSP] @1,052,143tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.bioslog (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
[DSP] @1,052,210tk: [+4 T:0x9fc302d4] OG -     package ti.sdo.ce.image1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
[DSP] @1,052,275tk: [+4 T:0x9fc302d4] OG -     package codecs.jpegenc.ce (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/ce/) [1, 0, 0]
[DSP] @1,052,340tk: [+4 T:0x9fc302d4] OG -     package servers.hv_dsplib (/home/eric/workplace/chenzh/jpegenc_test/package/servers/hv_dsplib/) [1, 0, 0]
[DSP] @1,052,404tk: [+0 T:0x9fc302d4] OG - Global_setSpecialTrace> return
@3,263,673us: [+0 T:0x40020100] CE - Engine_fwriteTrace> returning count [5951]
@3,263,703us: [+0 T:0x40020100] CE - Engine_initFromServer(0x49518)
@3,263,734us: [+0 T:0x40020100] CE - Engine_getNumServerAlgs(0x49518 0xbe88db08)
@3,263,978us: [+0 T:0x40020100] CE - Engine_getNumServerAlgs number of server algs = 1
@3,264,008us: [+0 T:0x40020100] CE - Engine_getNumServerAlgs exit 0
@3,264,039us: [+2 T:0x40020100] CE - Engine_initFromServer> Number of remote algs statically configured in engine: 1
@3,264,069us: [+2 T:0x40020100] CE - Engine_initFromServer> Number of statically configured remote algs = number of server algs: 1
@3,264,069us: [+0 T:0x40020100] CE - Engine_initFromServer> Returning 0
@3,264,100us: [+0 T:0x40020100] CE - Engine_open> return(300312)
Success to open engine hv_dsplib
@3,264,191us: [+0 T:0x40020100] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x49518, name='jpegenc', params=0x0)
@3,264,222us: [+0 T:0x40020100] CV - VISA_create(0x49518, 'jpegenc', 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
@3,264,252us: [+0 T:0x40020100] CV - VISA_create2(0x49518, 'jpegenc', 0x0, 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
@3,264,283us: [+0 T:0x40020100] OM - Memory_alloc> Enter(0x34)
@3,264,313us: [+0 T:0x40020100] OM - Memory_alloc> return (0x49990)
@3,597,443us: [+0 T:0x40020100] OM - Memory_alloc> Enter(0x4)
@3,597,474us: [+0 T:0x40020100] OM - Memory_alloc> return (0x499c8)
@3,597,474us: [+0 T:0x40020100] OC - Comm_alloc> Enter(poolId=0x0, msg=0x499c8, size=460)
@3,597,504us: [+0 T:0x40020100] OC - Comm_alloc> msg=0x414e3880, returning (0)
@3,597,535us: [+0 T:0x40020100] CE - Engine_createNode(0x49518, 'jpegenc', 460, 0x0, 0x0, 0xbe88daf8)
@3,597,565us: [+0 T:0x40020100] CE - Engine> allocNode Enter(engine=0x49518, impId='jpegenc')
@3,597,596us: [+0 T:0x40020100] OM - Memory_alloc> Enter(0x20)
@3,597,596us: [+0 T:0x40020100] OM - Memory_alloc> return (0x499d8)
@3,597,626us: [+0 T:0x40020100] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_1723_1, 0x499e0, NULL)
@3,597,657us: [+0 T:0x40020100] OC - Comm_create> Enter(queueName='gppfromnode_1723_1', queue=0x499e0, attrs=0x0)
@3,597,657us: [+0 T:0x40020100] OM - Memory_alloc> Enter(0x4)
@3,597,688us: [+0 T:0x40020100] OM - Memory_alloc> return (0x49a00)
@3,597,962us: [+0 T:0x40020100] OC - Comm_create> return (0x49a00)
@3,597,993us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
@3,598,023us: [+0 T:0x40020100] OC - Comm_put> return (0)
@3,598,054us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10000, msg=0xbe88da0c, timeout=-1)
@3,598,756us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@3,598,786us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
@3,598,817us: [+0 T:0x40020100] OC - Comm_put> return (0)
@3,598,847us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10000, msg=0xbe88da0c, timeout=-1)
@3,598,908us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@3,598,908us: [+4 T:0x40020100] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x49a00, algName='jpegenc', rmsNode=0x9fc34db0, algHandle=0x9fc34ea0)
@3,598,939us: [+3 T:0x40020100] CE - Engine_fwriteTrace(0x49518, '[DSP] ', 0x404b35e8)
@3,598,969us: [+3 T:0x40020100] CE - Engine_fwriteTrace(): requesting DSP trace @0x36ea79 ...
@3,599,000us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
@3,599,030us: [+0 T:0x40020100] OC - Comm_put> return (0)
@3,599,030us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10000, msg=0xbe88d984, timeout=-1)
@3,599,091us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@3,599,122us: [+3 T:0x40020100] CE - Engine_fwriteTrace> got 2104 chars @0x36ea79 (0 still avail, max: 32744, lost: 0)
[DSP] @3,157,099tk: [+0 T:0x9fc302d4] OM - Memory_alloc> Enter(size=0x18)
[DSP] @3,157,148tk: [+0 T:0x9fc302d4] OM - Memory_alloc> return (0x9fc34db0)
[DSP] @3,157,189tk: [+0 T:0x9fc302d4] OM - Memory_alloc> Enter(size=0xa)
[DSP] @3,157,225tk: [+0 T:0x9fc302d4] OM - Memory_alloc> return (0x9fc34dc8)
[DSP] @3,157,283tk: [+0 T:0x9fc302d4] OM - Memory_alloc> Enter(size=0x20)
[DSP] @3,157,320tk: [+0 T:0x9fc302d4] OM - Memory_alloc> return (0x9fc34dd8)
[DSP] @3,157,364tk: [+0 T:0x9fc302d4] OM - Memory_alloc> Enter(size=0x24)
[DSP] @3,157,401tk: [+0 T:0x9fc302d4] OM - Memory_alloc> return (0x9fc34df8)
[DSP] @3,157,470tk: [+0 T:0x9fc302d4] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x0, name='jpegenc', params=0x0)
[DSP] @3,157,539tk: [+0 T:0x9fc302d4] CV - VISA_create(0x0, 'jpegenc', 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
[DSP] @3,157,599tk: [+0 T:0x9fc302d4] CV - VISA_create2(0x0, 'jpegenc', 0x0, 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
[DSP] @3,157,671tk: [+0 T:0x9fc302d4] CE - Engine_open> Enter('local', 0x9fc33fac, 0x0)
[DSP] @3,157,718tk: [+0 T:0x9fc302d4] OM - Memory_alloc> Enter(size=0x34)
[DSP] @3,157,755tk: [+0 T:0x9fc302d4] OM - Memory_alloc> return (0x9fc34e68)
[DSP] @3,157,808tk: [+4 T:0x9fc302d4] CE - Engine_open> engine->server = 0x0
[DSP] @3,157,848tk: [+0 T:0x9fc302d4] CE - Engine_open> return(-1614590360)
[DSP] @3,157,932tk: [+0 T:0x9fc302d4] OM - Memory_alloc> Enter(size=0x34)
[DSP] @3,157,969tk: [+0 T:0x9fc302d4] OM - Memory_alloc> return (0x9fc34ea0)
[DSP] @3,158,013tk: [+0 T:0x9fc302d4] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x9fc58d6c, idma3Fxns=0x0, iresFxns=0x0, params=0x0, attrs=0x9fc340c8)
[DSP] @3,158,090tk: [+0 T:0x9fc302d4] OM - Memory_alloc> Enter(size=0x10)
[DSP] @3,158,126tk: [+0 T:0x9fc302d4] OM - Memory_alloc> return (0x9fc34ed8)
[DSP] @3,158,539tk: [+0 T:0x9fc302d4] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x9fc34ed8)
[DSP] @3,158,588tk: [+5 T:0x9fc302d4] CV - VISA_create> local codec created (name='jpegenc', handle=0x9fc34ed8)
[DSP] @3,158,643tk: [+0 T:0x9fc302d4] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x9fc34ea0)
[DSP] @3,158,695tk: [+4 T:0x9fc302d4] OT - Thread_create > name: "jpegenc#0", pri:  -1, stack size:  17192, stack seg: 0
@3,933,564us: [+0 T:0x40020100] CE - Engine_fwriteTrace> returning count [2254]
@3,933,595us: [+2 T:0x40020100] CE - Engine_createNode> Returning 0x499d8
@3,933,625us: [+5 T:0x40020100] CV - VISA_create> remote codec created (name='jpegenc', localQueueID=0x10001, remoteQueueID=0x0002)
@3,933,656us: [+0 T:0x40020100] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x49990)
Success to create codec jpegenc
@3,933,686us: [+0 T:0x40020100] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x49990, id=6, dynParams=0xbe88dc44 (size=0x20), status=0xbe88dba4 (size=0xa0)
@3,933,717us: [+4 T:0x40020100] CV - VISA_getMaxMsgSize(0x49990): returning 0x1000
@3,933,747us: [+5 T:0x40020100] CV - VISA_allocMsg> Allocating message for messageId=0x00020000
@3,933,778us: [+0 T:0x40020100] CV - VISA_call(visa=0x49990, msg=0x414e3880): messageId=0x00020000, command=0x1
@3,933,778us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x2, msg=0x414e3880)
@3,933,808us: [+0 T:0x40020100] OC - Comm_put> return (0)
@3,933,839us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10001, msg=0xbe88db04, timeout=-1)
@3,934,144us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@3,934,174us: [+3 T:0x40020100] CE - Engine_fwriteTrace(0x49518, '[DSP] ', 0x404b35e8)
@3,934,205us: [+3 T:0x40020100] CE - Engine_fwriteTrace(): requesting DSP trace @0x3c07fd ...
@3,934,235us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
@3,934,266us: [+0 T:0x40020100] OC - Comm_put> return (0)
@3,934,266us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10000, msg=0xbe88da7c, timeout=-1)
@3,934,327us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@3,934,357us: [+3 T:0x40020100] CE - Engine_fwriteTrace> got 1091 chars @0x3c07fd (0 still avail, max: 32744, lost: 0)
[DSP] @4,206,464tk: [+5 T:0x9fc3531c] CN - NODE> 0x9fc34dd8(jpegenc#0) call(algHandle=0x9fc34ea0, msg=0x9ff04880); messageId=0x00020000
[DSP] @4,206,554tk: [+0 T:0x9fc3531c] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x9fc34ea0, id=6, dynParams=0x9ff048b4 (size=0x20), status=0x9ff048d4 (size=0xa0)
[DSP] @4,206,652tk: [+5 T:0x9fc3531c] CV - VISA_enter(visa=0x9fc34ea0): algHandle = 0x9fc34ed8
[DSP] @4,206,703tk: [+0 T:0x9fc3531c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x9fc34ed8)
[DSP] @4,206,765tk: [+0 T:0x9fc3531c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @4,206,817tk: [+5 T:0x9fc3531c] CV - VISA_exit(visa=0x9fc34ea0): algHandle = 0x9fc34ed8
[DSP] @4,206,867tk: [+0 T:0x9fc3531c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x9fc34ed8)
[DSP] @4,206,925tk: [+0 T:0x9fc3531c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @4,206,968tk: [+0 T:0x9fc3531c] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x9fc34ea0, retVal=0xffffffff)
[DSP] @4,207,033tk: [+5 T:0x9fc3531c] CN - NODE> returned from call(algHandle=0x9fc34ea0, msg=0x9ff04880); messageId=0x00020000
@4,268,708us: [+0 T:0x40020100] CE - Engine_fwriteTrace> returning count [1151]
@4,268,739us: [+0 T:0x40020100] CV - VISA_call Completed: messageId=0x00020000, command=0x1, return(status=-1)
@4,268,769us: [+5 T:0x40020100] CV - VISA_freeMsg(0x49990, 0x414e3880): Freeing message with messageId=0x00020000
@4,268,800us: [+0 T:0x40020100] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x49990, retVal=0xffffffff)
status = -1
@4,268,800us: [+0 T:0x40020100] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> Enter (handle=0x49990)
@4,268,830us: [+0 T:0x40020100] CV - VISA_delete(0x49990)
@4,268,861us: [+5 T:0x40020100] CV - VISA_delete> deleting codec (localQueue=0x10001, remoteQueue=0x2)
@4,268,861us: [+0 T:0x40020100] CE - Engine_ctrlNode(0x499d8, 0x499c8, 0x0)
@4,268,891us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x2, msg=0x414e3880)
@4,268,922us: [+0 T:0x40020100] OC - Comm_put> return (0)
@4,268,983us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10001, msg=0x499c8, timeout=-1)
@4,269,013us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@4,269,044us: [+0 T:0x40020100] CE - Engine_ctrlNode> Returning 0x0
@4,269,044us: [+0 T:0x40020100] CE - Engine_deleteNode(0x499d8)
@4,269,074us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
@4,269,105us: [+0 T:0x40020100] OC - Comm_put> return (0)
@4,269,105us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10000, msg=0xbe88db34, timeout=-1)
@4,269,685us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@4,269,746us: [+5 T:0x40020100] CE - Engine_deleteNode(0x499d8): algName = jpegenc, algHandle = 0x9fc34ea0, stack size = 17192, stack used = 887(6%)
@4,269,776us: [+0 T:0x40020100] OC - Comm_delete> Enter (comm=0x49a00)
@4,269,898us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49a00, 0x4)
@4,269,929us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,269,959us: [+0 T:0x40020100] OC - Comm_delete> return
@4,269,959us: [+0 T:0x40020100] OM - Memory_free> Enter(0x499d8, 0x20)
@4,269,990us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,270,020us: [+0 T:0x40020100] OC - Comm_free> Enter (msg=0x414e3880)
@4,270,051us: [+0 T:0x40020100] OC - Comm_free> return (0)
@4,270,051us: [+0 T:0x40020100] OM - Memory_free> Enter(0x499c8, 0x4)
@4,270,081us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,270,081us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49990, 0x34)
@4,270,112us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,270,142us: [+0 T:0x40020100] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> return
@4,270,142us: [+0 T:0x40020100] CE - Engine_close(0x49518)
@4,270,173us: [+3 T:0x40020100] CE - Engine_fwriteTrace(0x49518, '[DSP] ', 0x404b35e8)
@4,270,203us: [+3 T:0x40020100] CE - Engine_fwriteTrace(): requesting DSP trace @0x41287b ...
@4,270,203us: [+0 T:0x40020100] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
@4,270,234us: [+0 T:0x40020100] OC - Comm_put> return (0)
@4,270,264us: [+0 T:0x40020100] OC - Comm_get> Enter(queue=0x10000, msg=0xbe88db3c, timeout=-1)
@4,270,325us: [+0 T:0x40020100] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@4,270,356us: [+3 T:0x40020100] CE - Engine_fwriteTrace> got 1643 chars @0x41287b (0 still avail, max: 32744, lost: 0)
[DSP] @5,253,691tk: [+0 T:0x9fc3531c] CN - NODE_EXECFXN(0x9fc34dd8): jpegenc#0 exiting per request ...
[DSP] @5,254,711tk: [+0 T:0x9fc302d4] CN - NODE_delete(0x9fc34dd8): jpegenc#0
[DSP] @5,254,783tk: [+0 T:0x9fc302d4] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> Enter (handle=0x9fc34ea0)
[DSP] @5,254,838tk: [+0 T:0x9fc302d4] CV - VISA_delete(0x9fc34ea0)
[DSP] @5,254,876tk: [+5 T:0x9fc302d4] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
[DSP] @5,254,928tk: [+5 T:0x9fc302d4] CV - VISA_delete> deleting codec 0x9fc34ed8
[DSP] @5,254,972tk: [+0 T:0x9fc302d4] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x9fc34ed8)
[DSP] @5,255,068tk: [+0 T:0x9fc302d4] OM - Memory_free> Enter(addr=0x9fc34ed8, size=16)
[DSP] @5,255,115tk: [+0 T:0x9fc302d4] OM - Memory_free> return (0x1)
[DSP] @5,255,149tk: [+0 T:0x9fc302d4] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit
[DSP] @5,255,189tk: [+0 T:0x9fc302d4] OM - Memory_free> Enter(addr=0x9fc34ea0, size=52)
[DSP] @5,255,234tk: [+0 T:0x9fc302d4] OM - Memory_free> return (0x1)
[DSP] @5,255,268tk: [+0 T:0x9fc302d4] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> return
[DSP] @5,255,312tk: [+0 T:0x9fc302d4] OM - Memory_free> Enter(addr=0x9fc34df8, size=36)
[DSP] @5,255,356tk: [+0 T:0x9fc302d4] OM - Memory_free> return (0x1)
[DSP] @5,255,390tk: [+0 T:0x9fc302d4] OM - Memory_free> Enter(addr=0x9fc34dd8, size=32)
[DSP] @5,255,434tk: [+0 T:0x9fc302d4] OM - Memory_free> return (0x1)
[DSP] @5,255,471tk: [+0 T:0x9fc302d4] OM - Memory_free> Enter(addr=0x9fc34dc8, size=10)
[DSP] @5,255,516tk: [+0 T:0x9fc302d4] OM - Memory_free> return (0x1)
[DSP] @5,255,549tk: [+0 T:0x9fc302d4] OM - Memory_free> Enter(addr=0x9fc34db0, size=24)
[DSP] @5,255,594tk: [+0 T:0x9fc302d4] OM - Memory_free> return (0x1)
@4,604,951us: [+0 T:0x40020100] CE - Engine_fwriteTrace> returning count [1769]
@4,604,981us: [+0 T:0x40020100] CS - Server_disconnectTrace('0x49518', 0x0)
@4,605,012us: [+0 T:0x40020100] CS - Server_disconnectTrace> return(0)
@4,605,042us: [+0 T:0x40020100] OC - Comm_free> Enter (msg=0x414e2880)
@4,605,073us: [+0 T:0x40020100] OC - Comm_free> return (0)
@4,605,073us: [+0 T:0x40020100] OC - Comm_delete> Enter (comm=0x49930)
@4,605,164us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49930, 0x4)
@4,605,195us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,605,225us: [+0 T:0x40020100] OC - Comm_delete> return
@4,605,225us: [+0 T:0x40020100] OC - Comm_release> Enter(queue=0x0)
@4,605,256us: [+0 T:0x40020100] OC - Comm_release> return (0)
@4,605,286us: [+0 T:0x40020100] CE - rserverClose(0x486b0), count = 1
@4,605,286us: [+0 T:0x40020100] OP - Processor_delete> Enter(proc=0x49550)
@4,605,317us: [+0 T:0x40020100] OP - doCmd> Enter (cmdId=2, proc=0x49550)
@4,605,347us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x491c0]
@4,605,378us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x491c0] status[0]
@4,605,408us: [+0 T:0x40cd2490] OP - getCmd_d> Exit (result=2)
@4,605,439us: [+0 T:0x40cd2490] OP - Processor_delete_d> Enter (proc=0x49550)
@4,605,439us: [+0 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_disconnect> Enter (handle=0x49578)
@4,605,470us: [+2 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_disconnect> Calling LPM_disconnect to disconnect from the DSP power handler...
@4,605,500us: [+0 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_disconnect> return (0)
@4,605,531us: [+2 T:0x40cd2490] OP - Processor_delete_d> Closing remote transport...
@4,605,683us: [+2 T:0x40cd2490] OP - Processor_delete_d> Stopping DSP...
@4,605,744us: [+2 T:0x40cd2490] OP - Processor_delete_d> Closing pool...
@4,605,805us: [+2 T:0x40cd2490] OP - Processor_delete_d> Detaching from DSP...
@4,607,484us: [+2 T:0x40cd2490] OP - Processor_delete_d> Destroying DSP... (object, that is)
@4,607,728us: [+0 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_off> Enter (handle=0x49578)
@4,607,758us: [+2 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_off> Turning off DSP power...
@4,607,850us: [+2 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_off> Closing Local Power Manager object...
@4,607,880us: [+0 T:0x40cd2490] ti.sdo.ce.ipc.Power - Power_off> return (0)
@4,607,911us: [+0 T:0x40cd2490] OM - Memory_free> Enter(0x495b0, 0x0)
@4,607,941us: [+0 T:0x40cd2490] OM - Memory_free> return (0x1)
@4,942,506us: [+0 T:0x40cd2490] OP - Processor_delete_d> return
@4,942,536us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x491d8]
@4,942,536us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x491d8]
@4,942,567us: [+0 T:0x40cd2490] OP - getCmd_d> Enter (proc=0x40cd1dd8)
@4,942,597us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x491c0] timeout[0xffffffff]
@4,942,628us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x491c0]
@4,942,658us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x491d8] timeout[0xffffffff]
@4,942,658us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x491d8] status[0]
@4,942,689us: [+0 T:0x40020100] OP - doCmd> Exit (result=1)
@4,942,719us: [+1 T:0x40020100] OP - Processor_delete(0x49550) freeing object ...
@4,942,719us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49550, 0x24)
@4,942,750us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,942,750us: [+0 T:0x40020100] OP - Processor_delete> return.
@4,942,780us: [+0 T:0x40020100] CE - rserverClose(0x486b0) done.
@4,942,811us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49518, 0x34)
@4,942,811us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,942,841us: [+0 T:0x40020100] CE - Engine_close exit
@4,942,872us: [+0 T:0x40020100] OG - Global_exit> enter
@4,942,872us: [+2 T:0x40020100] OG - Global_exit> calling function *0xca2c()...
@4,942,902us: [+2 T:0x40020100] OG - Global_exit> calling function *0xe134()...
@4,942,933us: [+2 T:0x40020100] OG - Global_exit> calling function *0x108c4()...
@4,942,963us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49458, 0x18)
@4,942,994us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,943,024us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49478, 0x18)
@4,943,024us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,943,055us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49498, 0x18)
@4,943,055us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,943,085us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1cf8c()...
@4,943,116us: [+2 T:0x40020100] OG - Global_exit> calling function *0x143cc()...
@4,943,116us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1a638()...
@4,943,147us: [+2 T:0x40020100] OG - Global_exit> calling function *0x17d48()...
@4,943,177us: [+0 T:0x40020100] OP - doCmd> Enter (cmdId=3, proc=0x0)
@4,943,177us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x491c0]
@4,943,208us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x491c0] status[0]
@4,943,238us: [+0 T:0x40cd2490] OP - getCmd_d> Exit (result=3)
@4,943,269us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x491d8]
@4,943,269us: [+0 T:0x40cd2490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x491d8]
@4,943,391us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x491c0]
@4,943,421us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x491d8] timeout[0xffffffff]
@4,943,452us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x491d8] status[0]
@4,943,452us: [+0 T:0x40020100] OP - doCmd> Exit (result=1)
@4,943,482us: [+0 T:0x40020100] OT - Thread_delete> Enter (task=0x49210)
@4,943,513us: [+4 T:0x40020100] OT - Thread_delete> pthread_cancel (0x3)
@4,943,543us: [+4 T:0x40020100] OT - Thread_delete> pthread_join (0x0)
@4,943,543us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49210, 0x64)
@4,943,574us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@4,943,574us: [+0 T:0x40020100] OT - Thread_delete> Exit (task=0x49210)
@4,943,604us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x491c0]
@4,943,635us: [+0 T:0x40020100] OM - Memory_free> Enter(0x491c0, 0x14)
@4,943,665us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@5,278,046us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@5,278,107us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x491d8]
@5,278,107us: [+0 T:0x40020100] OM - Memory_free> Enter(0x491d8, 0x14)
@5,278,138us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@5,278,168us: [+0 T:0x40020100] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@5,278,168us: [+0 T:0x40020100] OM - Memory_free> Enter(0x491f0, 0x18)
@5,278,199us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@5,278,230us: [+2 T:0x40020100] OG - Global_exit> calling function *0x197f0()...
@5,278,230us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1ca9c()...
@5,278,260us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1a0ec()...
@5,278,291us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49140, 0x18)
@5,278,321us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@5,278,321us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1b2c0()...
@5,278,352us: [+0 T:0x40020100] OM - Memory_free> Enter(0x49110, 0x18)
@5,278,382us: [+0 T:0x40020100] OM - Memory_free> return (0x1)
@5,278,413us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1d438()...
@5,278,413us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1dfec()...
@5,278,443us: [+2 T:0x40020100] OG - Global_exit> calling function *0x1d398()...

请问,我出现该问题的原因是什么呢?

  • Eric,

    如果把control里面的命令换成XDM_GETSTATUS,结果如何?

    CE_DEBUG=2看不到有用的错误信息,请打印CE_DEBUG=3,看看。

  • CE_DEBUG=3 ./encode
    ----------------------- demo -4- start ------------------------
    @0,234,897us: [+4 T:0x40020100 S:0xbe95ab1c] OG - Global_init> This program was built with the following packages:
    @0,235,049us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package gnu.targets.arm.rtsv5T (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/gnu/targets/arm/rtsv5T/) [1, 0, 0, 0]
    @0,235,080us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.codecs.jpegenc (/opt/dvsdk_4_00_00_22/codecs-omap3530_4_00_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
    @0,235,110us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package codecs.jpegenc (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/) [1, 0, 0]
    @0,235,141us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.global (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
    @0,235,171us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.xdais.dm (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/dm/) [1, 0, 5]
    @0,235,202us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.utils.trace (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
    @0,235,232us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.utils.xdm (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
    @0,235,263us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package dsplink.gpp (/opt/dvsdk_4_00_00_22/dsplink_1_65_00_02/dsplink/gpp/) [5, 0, 0]
    @0,235,263us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.linuxutils.cmem (/opt/dvsdk_4_00_00_22/linuxutils_2_25_05_11/packages/ti/sdo/linuxutils/cmem/) [2, 2, 0]
    @0,235,293us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.bios.power (/opt/dvsdk_4_00_00_22/local-power-manager_1_24_02_09/packages/ti/bios/power/) [1, 1, 1]
    @0,235,324us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.xdais (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/) [1, 2.0, 1]
    @0,235,354us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.node (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
    @0,235,354us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.fc.global (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
    @0,235,385us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.fc.memutils (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
    @0,235,416us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.fc.utils (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/utils/) [1, 0, 2]
    @0,235,446us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.fc.dman3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
    @0,235,446us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.fc.acpy3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
    @0,235,477us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package gnu.targets (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/gnu/targets/) [1, 0, 1]
    @0,235,507us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package gnu.targets.arm (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/gnu/targets/arm/) [1, 0, 0, 0]
    @0,235,538us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.catalog.arm (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
    @0,235,568us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.catalog (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
    @0,235,568us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.catalog.c6000 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
    @0,235,599us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.platforms.evm3530 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
    @0,235,629us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.osal (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
    @0,235,660us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.ipc (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
    @0,569,949us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.osal.linux (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
    @0,569,980us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.ipc.dsplink (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
    @0,570,010us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.alg (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
    @0,570,041us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
    @0,570,071us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.image1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
    @0,570,102us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package codecs.jpegenc.ce (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/ce/) [1, 0, 0]
    @0,570,102us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.speech (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/speech/) [1, 0, 2]
    @0,570,132us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.speech1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/speech1/) [1, 0, 1]
    @0,570,163us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.audio (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/audio/) [1, 0, 2]
    @0,570,193us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.audio1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/audio1/) [1, 0, 1]
    @0,570,193us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.video (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/video/) [1, 0, 3]
    @0,570,224us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.video1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/video1/) [1, 0, 2]
    @0,570,254us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.video2 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/video2/) [1, 0, 2]
    @0,570,285us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.image (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/image/) [1, 0, 3]
    @0,570,285us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.dmai (/opt/dvsdk_4_00_00_22/dmai_2_20_00_10/packages/ti/sdo/dmai/) [1, 0, 0]
    @0,570,315us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.bioslog (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
    @0,570,346us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package ti.sdo.ce.utils.trace (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/trace/) [1, 0, 1]
    @0,570,376us: [+4 T:0x40020100 S:0xbe95ab1c] OG - package encode_config (/home/eric/workplace/chenzh/jpegenc_test/test_x64P/omap3530/encode/encode_config/) []
    @0,570,407us: [+0 T:0x40020100 S:0xbe95ab24] OG - Global_atexit> enter (fxn=0x1e01c)
    @0,570,468us: [+0 T:0x40020100 S:0xbe95ab24] OG - Global_atexit> enter (fxn=0x1d468)
    @0,570,499us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> Enter(0x18)
    @0,570,560us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> return (0x420f0)
    @0,570,682us: [+0 T:0x40020100 S:0xbe95ab14] OG - Global_atexit> enter (fxn=0x1b2f0)
    @0,570,712us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_alloc> Enter(0x18)
    @0,570,743us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_alloc> return (0x42140)
    @0,570,773us: [+0 T:0x40020100 S:0xbe95ab0c] OG - Global_atexit> enter (fxn=0x1a11c)
    @0,570,804us: [+0 T:0x40020100 S:0xbe95ab14] OG - Global_atexit> enter (fxn=0x1cacc)
    @0,905,490us: [+0 T:0x40020100 S:0xbe95ab0c] ti.sdo.ce.osal.Sem - Sem_create> count: 0
    @0,905,521us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> Enter(0x14)
    @0,905,551us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> return (0x421c0)
    @0,905,582us: [+0 T:0x40020100 S:0xbe95ab0c] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x421c0]
    @0,905,582us: [+0 T:0x40020100 S:0xbe95ab0c] ti.sdo.ce.osal.Sem - Sem_create> count: 0
    @0,905,612us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> Enter(0x14)
    @0,905,643us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> return (0x421d8)
    @0,905,673us: [+0 T:0x40020100 S:0xbe95ab0c] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x421d8]
    @0,905,673us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> Enter(0x18)
    @0,905,704us: [+0 T:0x40020100 S:0xbe95aaf4] OM - Memory_alloc> return (0x421f0)
    @0,905,734us: [+0 T:0x40020100 S:0xbe95aaec] OT - Thread_create> Enter (fxn=0x18360, attrs=0x0)
    @0,905,765us: [+0 T:0x40020100 S:0xbe95aad4] OM - Memory_alloc> Enter(0x64)
    @0,905,765us: [+0 T:0x40020100 S:0xbe95aad4] OM - Memory_alloc> return (0x42210)
    @0,906,009us: [+0 T:0x40020100 S:0xbe95aaec] OT - Thread_create> Exit (task=0x42210)
    @0,906,070us: [+0 T:0x40020100 S:0xbe95ab14] OG - Global_atexit> enter (fxn=0x19820)
    @0,906,100us: [+0 T:0x40020100 S:0xbe95ab24] OG - Global_atexit> enter (fxn=0x17d78)
    @0,906,131us: [+0 T:0x40020100 S:0xbe95ab24] OG - Global_atexit> enter (fxn=0x1a668)
    @0,906,161us: [+0 T:0x40020100 S:0xbe95ab0c] ti.sdo.ce.alg - ALG_init> Enter
    @0,906,192us: [+0 T:0x40020100 S:0xbe95ab2c] ti.sdo.ce.alg - ALG_init> Exit
    @0,906,222us: [+0 T:0x40020100 S:0xbe95ab24] OG - Global_atexit> enter (fxn=0x143fc)
    @0,906,253us: [+0 T:0x40020100 S:0xbe95aafc] OM - Memory_alloc> Enter(0x18)
    @0,906,283us: [+0 T:0x40020100 S:0xbe95aafc] OM - Memory_alloc> return (0x42418)
    @0,906,283us: [+0 T:0x40020100 S:0xbe95ab24] OG - Global_atexit> enter (fxn=0x1cfbc)
    @0,906,344us: [+6 T:0x40020100 S:0xbe95ab14] CE - Engine_init> CE debugging on (CE_DEBUG=3; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
    @0,906,375us: [+0 T:0x40020100 S:0xbe95ab04] OG - Global_atexit> enter (fxn=0x108f4)
    @0,906,375us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_alloc> Enter(0x18)
    @0,906,406us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_alloc> return (0x42458)
    @0,906,436us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_alloc> Enter(0x18)
    @0,906,467us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_alloc> return (0x42478)
    @0,906,467us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_alloc> Enter(0x18)
    @0,906,497us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_alloc> return (0x42498)
    @0,906,528us: [+0 T:0x40020100 S:0xbe95ab24] CS - Server_init()
    @0,906,558us: [+0 T:0x40020100 S:0xbe95ab24] CS - Server_init> Global_useLinkArbiter = 0
    @0,906,589us: [+0 T:0x40020100 S:0xbe95ab24] OG - Global_atexit> enter (fxn=0xe164)
    @0,906,650us: [+0 T:0x40020100 S:0xbe95ab34] OG - Global_atexit> enter (fxn=0xca5c)
    TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil)
    @0,906,680us: [+0 T:0x40020100 S:0xbe95aae4] CE - Engine_open> Enter('hv_dsplib', 0x0, 0xbe95ab54)
    @0,906,711us: [+0 T:0x40020100 S:0xbe95aacc] OM - Memory_alloc> Enter(0x34)
    @0,906,741us: [+0 T:0x40020100 S:0xbe95aacc] OM - Memory_alloc> return (0x42518)
    @0,906,772us: [+0 T:0x40020100 S:0xbe95aae4] CE - rserverOpen('hv_dsplib.x64P'), count = 0
    @0,906,802us: [+0 T:0x40020100 S:0xbe95aaac] OP - Processor_create> Enter(imageName='hv_dsplib.x64P', linkCfg='(null)', attrs=0xbe95ab38)
    @0,906,894us: [+0 T:0x40020100 S:0xbe95aa94] OM - Memory_alloc> Enter(0x24)
    @0,906,924us: [+0 T:0x40020100 S:0xbe95aa94] OM - Memory_alloc> return (0x42550)
    @0,906,955us: [+0 T:0x40020100 S:0xbe95aa8c] OP - doCmd> Enter (cmdId=1, proc=0x42550)
    @0,906,955us: [+0 T:0x40020100 S:0xbe95aa7c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x421c0]
    @1,241,031us: [+0 T:0x40020100 S:0xbe95aa8c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x421c0]
    @1,241,061us: [+0 T:0x40020100 S:0xbe95aa6c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x421d8] timeout[0xffffffff]
    @1,241,122us: [+1 T:0x40cd2490 S:0x40cd1d64] OP - daemon> thread created.
    @1,241,153us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - getCmd_d> Enter (proc=0x40cd1dd8)
    @1,241,153us: [+0 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x421c0] timeout[0xffffffff]
    @1,241,183us: [+0 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x421c0] status[0]
    @1,241,214us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - getCmd_d> Exit (result=1)
    @1,241,244us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Enter(proc=0x42550)
    @1,241,275us: [+0 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.ipc.Power - Power_on> Enter(handle=0x4256c)
    @1,241,275us: [+2 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.ipc.Power - Power_on> Opening Local Power Manager for the DSP on /dev/lpm0...
    @1,241,336us: [+2 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.ipc.Power - Power_on> Turning on DSP power...
    @1,241,489us: [+2 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.ipc.Power - Power_on> return (0)
    @1,241,489us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Initializing DSP PROC...
    @1,241,519us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'hv_dsplib.x64P']
    @1,241,550us: [+0 T:0x40cd2490 S:0x40cd1d4c] OM - Memory_alloc> Enter(0x1f8)
    @1,241,580us: [+0 T:0x40cd2490 S:0x40cd1d4c] OM - Memory_alloc> return (0x425b0)
    @1,241,641us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x9fc00000, sizeInBytes=0x300000, shared=1, syncd=0
    @1,241,672us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x9ff00000, sizeInBytes=0xff000, shared=1, syncd=0
    @1,241,702us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x9ffff000, sizeInBytes=0x1000, shared=1, syncd=0
    @1,241,733us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='L4PER', startAddress=0x49000000, sizeInBytes=0x100000, shared=0, syncd=0
    @1,241,763us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #4 to Link configuration: name='IRAM', startAddress=0x5c7f8000, sizeInBytes=0x8000, shared=1, syncd=0
    @1,241,794us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #5 to Link configuration: name='L1DSRAM', startAddress=0x5cf04000, sizeInBytes=0x10000, shared=1, syncd=0
    @1,241,824us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #6 to Link configuration: name='DDRALGHEAP', startAddress=0x94000000, sizeInBytes=0xbc00000, shared=0, syncd=0
    @1,241,855us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #7 to Link configuration: name='L4CORE', startAddress=0x48000000, sizeInBytes=0x1000000, shared=0, syncd=0
    @1,241,885us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Found 'CMEM' entry, adjusting base and size according to CMEM_getBlock()
    @1,241,916us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Setting CMEM base to 0x90000000, size to 0x4000000
    @1,241,916us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Adding DSP segment #8 to Link configuration: name='CMEM', startAddress=0x90000000, sizeInBytes=0x4000000, shared=0, syncd=0
    @1,241,946us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> DODSPCTRL was=0; now=0
    @1,242,007us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - LINKCFG_Object generated for PROC_setup(0x40a44) ...
    @1,576,572us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->gppObject->
    @1,576,602us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "ARM9"
    @1,576,633us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maxMsgqs = 0x82
    @1,576,663us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maxChnlQueue = 0x10
    @1,576,663us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - poolTableId = 0xffffffff
    @1,576,694us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - numPools = 0x0
    @1,576,724us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @1,576,724us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->dspObject->
    @1,576,755us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "OMAP3530"
    @1,576,785us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspArch = 0x2
    @1,576,816us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - loaderName = "COFF"
    @1,576,816us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - autoStart = FALSE
    @1,576,846us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - execName = "DEFAULT.OUT"
    @1,576,877us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - doDspCtrl = DSP_BootMode_Boot_NoPwr
    @1,576,877us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - resumeAddr = 0x9ffff020
    @1,576,907us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - resetVector = 0x9ffff000
    @1,576,938us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - resetCodeSize = 0x1000
    @1,576,968us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maduSize = 0x1
    @1,576,968us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - cpuFreq = 0x6ddd0
    @1,576,999us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - endian = 0x3
    @1,577,029us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - wordSwap = 0x0
    @1,577,029us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memTableId = 0x0
    @1,577,060us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntries = 0x9
    @1,577,090us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkDrvId = 0x0
    @1,577,121us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg1 = 0xffffffff
    @1,577,121us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg2 = 0xffffffff
    @1,577,151us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg3 = 0x0
    @1,577,182us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg4 = 0x0
    @1,577,182us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg5 = 0xffffffff
    @1,577,212us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @1,577,243us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->linkDrvObjects->
    @1,577,243us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "SHMDRV"
    @1,577,273us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - hshkPollCount = 0x989680
    @1,577,304us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntry = 0x1
    @1,577,334us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsTableId = 0x0
    @1,577,334us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - numIpsEntries = 0x1
    @1,577,365us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - poolTableId = 0x0
    @1,577,396us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - numPools = 0x1
    @1,577,396us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dataTableId = 0x0
    @1,577,426us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - numDataDrivers = 0x1
    @1,577,457us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - mqtId = 0x0
    @1,577,457us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ringIoTableId = 0x0
    @1,577,487us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - mplistTableId = 0x0
    @1,577,518us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - mpcsTableId = 0x0
    @1,577,548us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @1,577,548us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->memTables[0][i].
    @1,577,579us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #0:
    @1,577,609us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x0
    @1,577,609us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "DDR2"
    @1,577,640us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x9fc00000
    @1,577,670us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x9fc00000
    @1,577,701us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @1,577,701us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0x300000
    @1,912,265us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = TRUE
    @1,912,295us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @1,912,326us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #1:
    @1,912,326us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x1
    @1,912,356us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "DSPLINKMEM"
    @1,912,387us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x9ff00000
    @1,912,417us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x9ff00000
    @1,912,417us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @1,912,448us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0xff000
    @1,912,479us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = TRUE
    @1,912,479us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @1,912,509us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #2:
    @1,912,540us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x2
    @1,912,540us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "RESET_VECTOR"
    @1,912,570us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x9ffff000
    @1,912,601us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x9ffff000
    @1,912,631us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @1,912,631us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0x1000
    @1,912,662us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = TRUE
    @1,912,692us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @1,912,692us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #3:
    @1,912,723us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x3
    @1,912,753us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "L4PER"
    @1,912,753us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x49000000
    @1,912,784us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x49000000
    @1,912,814us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @1,912,845us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0x100000
    @1,912,845us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = FALSE
    @1,912,875us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @1,912,906us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #4:
    @1,912,906us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x4
    @1,912,936us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "IRAM"
    @1,912,967us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x5c7f8000
    @1,912,967us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x107f8000
    @1,912,997us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @1,913,028us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0x8000
    @1,913,058us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = TRUE
    @1,913,058us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @1,913,089us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #5:
    @1,913,119us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x5
    @1,913,119us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "L1DSRAM"
    @1,913,150us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x5cf04000
    @1,913,180us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x10f04000
    @1,913,211us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @1,913,211us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0x10000
    @1,913,241us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = TRUE
    @1,913,272us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @1,913,272us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #6:
    @1,913,302us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x6
    @1,913,333us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "DDRALGHEAP"
    @1,913,364us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x94000000
    @1,913,364us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x94000000
    @1,913,394us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @1,913,425us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0xbc00000
    @1,913,425us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = FALSE
    @2,247,897us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @2,247,958us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #7:
    @2,247,958us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x7
    @2,247,989us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "L4CORE"
    @2,248,019us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x48000000
    @2,248,050us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x48000000
    @2,248,050us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @2,248,080us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0x1000000
    @2,248,111us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = FALSE
    @2,248,111us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @2,248,141us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #8:
    @2,248,172us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry = 0x8
    @2,248,202us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "CMEM"
    @2,248,202us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - physAddr = 0x90000000
    @2,248,233us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspVirtAddr = 0x90000000
    @2,248,263us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppVirtAddr = 0xffffffff
    @2,248,263us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - size = 0x4000000
    @2,248,294us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - shared = FALSE
    @2,248,324us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - syncd = FALSE
    @2,248,324us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @2,248,355us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->ipsTables[0][i].
    @2,248,385us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #0:
    @2,248,416us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "IPS"
    @2,248,416us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - numIpsEvents = 0x20
    @2,248,447us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntry = 0x1
    @2,248,477us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - gppIntId = 0x1a
    @2,248,477us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspIntId = 0x37
    @2,248,508us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - dspIntVectorId = 0x5
    @2,248,538us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg1 = 0x2faf080
    @2,248,538us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg2 = 0x0
    @2,248,569us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @2,248,599us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->poolTables[0][i].
    @2,248,630us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @2,248,630us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->dataTables[0][i].
    @2,248,660us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - entry #0:
    @2,248,691us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "ZCPYDATA"
    @2,248,691us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - baseChnlId = 0x0
    @2,248,721us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - numChannels = 0x10
    @2,248,752us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maxBufSize = 0x4000
    @2,248,782us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntry = 0x1
    @2,248,782us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - poolId = 0x0
    @2,248,813us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - queuePerChnl = 0x1
    @2,248,843us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsId = 0x0
    @2,248,843us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsEventNo = 0x1
    @2,248,874us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg1 = 0x0
    @2,248,904us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg2 = 0x0
    @2,248,904us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @2,248,935us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->mqtObjects->
    @2,248,965us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "ZCPYMQT"
    @2,248,996us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntry = 0x1
    @2,248,996us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maxMsgSize = 0xffffffff
    @2,249,026us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsId = 0x0
    @2,249,057us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsEventNo = 0x0
    @2,249,057us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg1 = 0x0
    @2,249,087us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - arg2 = 0x0
    @2,249,118us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @2,583,407us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->ringIoObjects->
    @2,583,438us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "RINGIOTABLE"
    @2,583,469us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntry = 0x1
    @2,583,499us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maxEntries = 0x40
    @2,583,530us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsId = 0x0
    @2,583,530us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsEventNo = 0x2
    @2,583,560us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @2,583,591us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->mplistObjects->
    @2,583,591us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "MPLISTTABLE"
    @2,583,621us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntry = 0x1
    @2,583,652us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maxEntries = 0x40
    @2,583,652us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsId = 0xffffffff
    @2,583,682us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsEventNo = 0xffffffff
    @2,583,713us: [+3 T:0x40cd2490 S:0x40cd1d04] OP -
    @2,583,743us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - linkCfg->dspConfigs[0]->mpcsObjects->
    @2,583,743us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - name = "MPCS"
    @2,583,774us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - memEntry = 0x1
    @2,583,804us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - maxEntries = 0x100
    @2,583,804us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsId = 0xffffffff
    @2,583,835us: [+3 T:0x40cd2490 S:0x40cd1d04] OP - ipsEventNo = 0xffffffff
    @2,584,811us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Attaching to DSP PROC...
    @2,588,107us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Opening MSGQ pool...
    @2,588,382us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Loading hv_dsplib.x64P on DSP (1 args)...
    @2,596,835us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Starting DSP PROC...
    @2,603,091us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> Opening remote transport...
    @2,603,641us: [+0 T:0x40cd2490 S:0x40cd1d4c] ti.sdo.ce.ipc.Power - Power_connect> Enter (handle=0x42578)
    @2,603,702us: [+2 T:0x40cd2490 S:0x40cd1d4c] ti.sdo.ce.ipc.Power - Power_connect> Calling LPM_connect to connect to the DSP power handler...
    @2,603,793us: [+0 T:0x40cd2490 S:0x40cd1d4c] ti.sdo.ce.ipc.Power - Power_connect> return (0)
    @2,603,824us: [+2 T:0x40cd2490 S:0x40cd1d64] OP - Processor_create_d> return (1)
    @2,603,854us: [+0 T:0x40cd2490 S:0x40cd1d54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x421d8]
    @2,603,915us: [+0 T:0x40020100 S:0xbe95aa6c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x421d8] status[0]
    @2,603,946us: [+0 T:0x40020100 S:0xbe95aa8c] OP - doCmd> Exit (result=1)
    @2,603,976us: [+0 T:0x40020100 S:0xbe95aaac] OP - Processor_create> return (0x42550)
    @2,604,007us: [+0 T:0x40020100 S:0xbe95aae4] CE - rserverOpen('hv_dsplib.x64P'): 0x412a8 done.
    @2,604,037us: [+0 T:0x40020100 S:0xbe95aacc] OM - Memory_alloc> Enter(0x27)
    @2,604,068us: [+0 T:0x40020100 S:0xbe95aacc] OM - Memory_alloc> return (0x42900)
    @2,604,190us: [+0 T:0x40020100 S:0xbe95aabc] OC - Comm_create> Enter(queueName='hv_dsplib_2387_0', queue=0x42528, attrs=0x0)
    @2,604,220us: [+0 T:0x40020100 S:0xbe95aaa4] OM - Memory_alloc> Enter(0x4)
    @2,604,251us: [+0 T:0x40020100 S:0xbe95aaa4] OM - Memory_alloc> return (0x42930)
    @2,604,526us: [+0 T:0x40020100 S:0xbe95aabc] OC - Comm_create> return (0x42930)
    @2,604,556us: [+0 T:0x40020100 S:0xbe95aac4] OM - Memory_free> Enter(0x42900, 0x27)
    @2,604,617us: [+0 T:0x40020100 S:0xbe95aac4] OM - Memory_free> return (0x1)
    @2,604,648us: [+0 T:0x40020100 S:0xbe95aac4] OC - Comm_alloc> Enter(poolId=0x0, msg=0x42534, size=1592)
    @2,604,709us: [+0 T:0x40020100 S:0xbe95aac4] OC - Comm_alloc> msg=0x414e2880, returning (0)
    @2,604,739us: [+0 T:0x40020100 S:0xbe95aaac] OC - Comm_locate> Enter(queueName='rmsq', queue=0x42524)
    @2,604,831us: [+0 T:0x40cd2490 S:0x40cd1d64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x421d8]
    @2,604,922us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - getCmd_d> Enter (proc=0x40cd1dd8)
    @2,604,922us: [+0 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x421c0] timeout[0xffffffff]
    @2,938,571us: [+0 T:0x40020100 S:0xbe95aaac] OC - Comm_locate> return (0)
    @2,938,632us: [+0 T:0x40020100 S:0xbe95aae4] CE - checkServer(0x42518)
    @2,938,663us: [+0 T:0x40020100 S:0xbe95aab4] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @2,938,724us: [+0 T:0x40020100 S:0xbe95aab4] OC - Comm_put> return (0)
    @2,938,754us: [+0 T:0x40020100 S:0xbe95aaac] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95ab50, timeout=-1)
    @2,938,846us: [+0 T:0x40020100 S:0xbe95aaac] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @2,938,876us: [+0 T:0x40020100 S:0xbe95aae4] CE - rmsInit> RMS initialized(0x42518); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3
    @2,938,907us: [+0 T:0x40020100 S:0xbe95aabc] CE - Engine_setTrace> Enter(engine=0x42518, mask='*+01234567,GT_prefix=12345,GT_time=3')
    @2,938,998us: [+1 T:0x40020100 S:0xbe95aabc] CE - Engine_setTrace> Requesting DSP set trace ...
    @2,939,029us: [+0 T:0x40020100 S:0xbe95aa8c] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @2,939,059us: [+0 T:0x40020100 S:0xbe95aa8c] OC - Comm_put> return (0)
    @2,939,059us: [+0 T:0x40020100 S:0xbe95aa84] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95ab04, timeout=-1)
    @2,940,097us: [+0 T:0x40020100 S:0xbe95aa84] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @2,940,127us: [+0 T:0x40020100 S:0xbe95aabc] CE - Engine_setTrace> return(0)
    @2,940,158us: [+4 T:0x40020100 S:0xbe95aae4] CE - Engine_open> engine->server = 0x412a8
    @2,940,188us: [+0 T:0x40020100 S:0xbe95aa4c] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @2,940,219us: [+0 T:0x40020100 S:0xbe95aa4c] OC - Comm_put> return (0)
    @2,940,250us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95aae4, timeout=-1)
    @2,940,341us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    [DSP] @0x000002bb:[T:0x00000000] servers.imgalg - main> Welcome to DSP server's main().
    [DSP] @1,050,134tk: [+0 T:0x9fc31794 S:0x9fc3570c] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3')
    [DSP] @1,050,217tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - Global_setSpecialTrace> This program was built with the following packages:
    [DSP] @1,050,279tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.targets.rts6000 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/targets/rts6000/) [1, 0, 0, 0]
    [DSP] @1,050,356tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.codecs.jpegenc (/opt/dvsdk_4_00_00_22/codecs-omap3530_4_00_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
    [DSP] @1,050,436tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package codecs.jpegenc (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/) [1, 0, 0]
    [DSP] @1,050,508tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.fc.global (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
    [DSP] @1,050,586tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.utils.trace (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
    [DSP] @1,050,666tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.xdais (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/) [1, 2.0, 1]
    [DSP] @1,050,734tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.rtdx (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/rtdx/) [2, 0, 0, 5]
    [DSP] @1,050,801tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.psl (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/psl/) [5, 0, 0, 0]
    [DSP] @1,050,869tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.pmi (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/pmi/) [1, 0, 0, 0]
    [DSP] @1,050,937tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.pscl (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/pscl/) [1, 0, 0, 0]
    [DSP] @1,051,004tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.bios (/opt/dvsdk_4_00_00_22/dspbios_5_41_03_17/packages/ti/bios/) [5, 2, 5, 28]
    [DSP] @1,051,072tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.fc.dskt2 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
    [DSP] @1,051,150tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.fc.dman3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
    [DSP] @1,051,227tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.global (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
    [DSP] @1,051,302tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.xdais.dm (/opt/dvsdk_4_00_00_22/xdais_6_26_01_03/packages/ti/xdais/dm/) [1, 0, 5]
    [DSP] @1,051,372tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.node (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
    [DSP] @1,051,446tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.ipc.dsplink.dsp (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2, 0, 1]
    [DSP] @1,051,528tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.utils.xdm (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
    [DSP] @1,051,606tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.fc.memutils (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
    [DSP] @1,051,685tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.fc.acpy3 (/opt/dvsdk_4_00_00_22/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
    [DSP] @1,051,763tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package dsplink.dsp (/opt/dvsdk_4_00_00_22/dsplink_1_65_00_02/dsplink/dsp/) [1, 4, 0]
    [DSP] @1,051,829tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.bios.utils (/opt/dvsdk_4_00_00_22/biosutils_1_02_02/packages/ti/bios/utils/) [2, 0, 2, 02]
    [DSP] @1,051,902tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.catalog.c6000 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
    [DSP] @1,051,977tk: [+4 T:0x9fc@3,278,201us: [+0 T:0x40020100 S:0xbe95aa4c] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @3,278,232us: [+0 T:0x40020100 S:0xbe95aa4c] OC - Comm_put> return (0)
    @3,278,262us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95aae4, timeout=-1)
    @3,278,506us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    31794 S:0x9fc3570c] OG - package ti.catalog (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
    [DSP] @1,052,046tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.catalog.arm (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
    [DSP] @1,052,120tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.platforms.evm3530 (/opt/dvsdk_4_00_00_22/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
    [DSP] @1,052,196tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.osal (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
    [DSP] @1,052,270tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.osal.bios (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
    [DSP] @1,052,348tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.ipc (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
    [DSP] @1,052,421tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.ipc.bios (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
    [DSP] @1,052,498tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.alg (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
    [DSP] @1,052,571tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
    [DSP] @1,052,641tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.bioslog (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
    [DSP] @1,052,718tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package ti.sdo.ce.image1 (/opt/dvsdk_4_00_00_22/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
    [DSP] @1,052,793tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package codecs.jpegenc.ce (/home/eric/workplace/chenzh/jpegenc_test/package/codecs/jpegenc/ce/) [1, 0, 0]
    [DSP] @1,052,867tk: [+4 T:0x9fc31794 S:0x9fc3570c] OG - package servers.hv_dsplib (/home/eric/workplace/chenzh/jpegenc_test/package/servers/hv_dsplib/) [1, 0, 0]
    [DSP] @1,052,940tk: [+0 T:0x9fc31794 S:0x9fc3570c] OG - Global_setSpecialTrace> return
    [DSP] @1,053,753tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 5
    [DSP] @1,053,816tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - remote time = 0x0, trace buffer size = 4032
    [DSP] @2,110,085tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 5
    [DSP] @2,110,150tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - remote time = 0x0, trace buffer size = 4032
    @3,613,254us: [+0 T:0x40020100 S:0xbe95aa7c] CE - Engine_fwriteTrace> returning count [6811]
    @3,613,315us: [+0 T:0x40020100 S:0xbe95aa9c] CE - Engine_initFromServer(0x42518)
    @3,613,345us: [+0 T:0x40020100 S:0xbe95aa74] CE - Engine_getNumServerAlgs(0x42518 0xbe95aaf0)
    @3,613,345us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @3,613,406us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_put> return (0)
    @3,613,406us: [+0 T:0x40020100 S:0xbe95aa3c] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95aabc, timeout=-1)
    @3,613,498us: [+0 T:0x40020100 S:0xbe95aa3c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @3,613,498us: [+0 T:0x40020100 S:0xbe95aa74] CE - Engine_getNumServerAlgs number of server algs = 1
    @3,613,528us: [+0 T:0x40020100 S:0xbe95aa74] CE - Engine_getNumServerAlgs exit 0
    @3,613,559us: [+2 T:0x40020100 S:0xbe95aa9c] CE - Engine_initFromServer> Number of remote algs statically configured in engine: 1
    @3,613,589us: [+2 T:0x40020100 S:0xbe95aa9c] CE - Engine_initFromServer> Number of statically configured remote algs = number of server algs: 1
    @3,613,620us: [+0 T:0x40020100 S:0xbe95aa9c] CE - Engine_initFromServer> Returning 0
    @3,613,620us: [+0 T:0x40020100 S:0xbe95aae4] CE - Engine_open> return(271640)
    Success to open engine hv_dsplib
    @3,613,711us: [+0 T:0x40020100 S:0xbe95ab1c] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x42518, name='jpegenc', params=0xbe95ac4c)
    @3,613,742us: [+0 T:0x40020100 S:0xbe95aaec] CV - VISA_create(0x42518, 'jpegenc', 0xbe95ac4c, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
    @3,613,772us: [+0 T:0x40020100 S:0xbe95a9e4] CV - VISA_create2(0x42518, 'jpegenc', 0xbe95ac4c, 0x18, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
    @3,613,833us: [+0 T:0x40020100 S:0xbe95a9cc] OM - Memory_alloc> Enter(0x34)
    @3,613,864us: [+0 T:0x40020100 S:0xbe95a9cc] OM - Memory_alloc> return (0x42990)
    @3,613,864us: [+0 T:0x40020100 S:0xbe95a9cc] OM - Memory_alloc> Enter(0x4)
    @3,613,895us: [+0 T:0x40020100 S:0xbe95a9cc] OM - Memory_alloc> return (0x429c8)
    @3,613,925us: [+0 T:0x40020100 S:0xbe95a9c4] OC - Comm_alloc> Enter(poolId=0x0, msg=0x429c8, size=460)
    @3,613,956us: [+0 T:0x40020100 S:0xbe95a9c4] OC - Comm_alloc> msg=0x414e3880, returning (0)
    @3,613,986us: [+0 T:0x40020100 S:0xbe95a96c] CE - Engine_createNode(0x42518, 'jpegenc', 460, 0xbe95ac4c, 0x18, 0xbe95aae0)
    @3,614,017us: [+0 T:0x40020100 S:0xbe95a96c] CE - Engine> allocNode Enter(engine=0x42518, impId='jpegenc')
    @3,948,001us: [+0 T:0x40020100 S:0xbe95a954] OM - Memory_alloc> Enter(0x20)
    @3,948,001us: [+0 T:0x40020100 S:0xbe95a954] OM - Memory_alloc> return (0x429d8)
    @3,948,062us: [+0 T:0x40020100 S:0xbe95a96c] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_2387_1, 0x429e0, NULL)
    @3,948,062us: [+0 T:0x40020100 S:0xbe95a944] OC - Comm_create> Enter(queueName='gppfromnode_2387_1', queue=0x429e0, attrs=0x0)
    @3,948,123us: [+0 T:0x40020100 S:0xbe95a92c] OM - Memory_alloc> Enter(0x4)
    @3,948,154us: [+0 T:0x40020100 S:0xbe95a92c] OM - Memory_alloc> return (0x42a00)
    @3,948,398us: [+0 T:0x40020100 S:0xbe95a944] OC - Comm_create> return (0x42a00)
    @3,948,428us: [+0 T:0x40020100 S:0xbe95a94c] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @3,948,459us: [+0 T:0x40020100 S:0xbe95a94c] OC - Comm_put> return (0)
    @3,948,489us: [+0 T:0x40020100 S:0xbe95a944] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95a9f4, timeout=-1)
    @3,949,344us: [+0 T:0x40020100 S:0xbe95a944] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @3,949,374us: [+0 T:0x40020100 S:0xbe95a94c] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @3,949,435us: [+0 T:0x40020100 S:0xbe95a94c] OC - Comm_put> return (0)
    @3,949,435us: [+0 T:0x40020100 S:0xbe95a944] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95a9f4, timeout=-1)
    @3,949,679us: [+0 T:0x40020100 S:0xbe95a944] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @3,949,710us: [+4 T:0x40020100 S:0xbe95a96c] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x42a00, algName='jpegenc', rmsNode=0x9fc36230, algHandle=0x9fc36320)
    @3,949,740us: [+3 T:0x40020100 S:0xbe95a904] CE - Engine_fwriteTrace(0x42518, '[DSP] ', 0x404b35e8)
    @3,949,771us: [+3 T:0x40020100 S:0xbe95a904] CE - Engine_fwriteTrace(): requesting DSP trace @0x3c44cb ...
    @3,949,771us: [+0 T:0x40020100 S:0xbe95a8d4] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @3,949,832us: [+0 T:0x40020100 S:0xbe95a8d4] OC - Comm_put> return (0)
    @3,949,832us: [+0 T:0x40020100 S:0xbe95a8cc] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95a96c, timeout=-1)
    @3,950,076us: [+0 T:0x40020100 S:0xbe95a8cc] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @3,950,107us: [+3 T:0x40020100 S:0xbe95a904] CE - Engine_fwriteTrace> got 2931 chars @0x3c44cb (0 still avail, max: 32744, lost: 0)
    [DSP] @3,157,439tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 17
    [DSP] @4,204,551tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 0
    [DSP] @4,204,622tk: [+0 T:0x9fc31794 S:0x9fc35634] OM - Memory_alloc> Enter(size=0x18)
    [DSP] @4,204,674tk: [+0 T:0x9fc31794 S:0x9fc35634] OM - Memory_alloc> return (0x9fc36230)
    [DSP] @4,204,727tk: [+0 T:0x9fc31794 S:0x9fc35634] OM - Memory_alloc> Enter(size=0xa)
    [DSP] @4,204,773tk: [+0 T:0x9fc31794 S:0x9fc35634] OM - Memory_alloc> return (0x9fc36248)
    [DSP] @4,204,831tk: [+0 T:0x9fc31794 S:0x9fc355f4] OM - Memory_alloc> Enter(size=0x20)
    [DSP] @4,204,879tk: [+0 T:0x9fc31794 S:0x9fc355f4] OM - Memory_alloc> return (0x9fc36258)
    [DSP] @4,204,933tk: [+0 T:0x9fc31794 S:0x9fc355c4] OM - Memory_alloc> Enter(size=0x24)
    [DSP] @4,204,982tk: [+0 T:0x9fc31794 S:0x9fc355c4] OM - Memory_alloc> return (0x9fc36278)
    [DSP] @4,205,070tk: [+0 T:0x9fc31794 S:0x9fc355dc] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x0, name='jpegenc', params=0x9ff038c0)
    [DSP] @4,205,154tk: [+0 T:0x9fc31794 S:0x9fc355a4] CV - VISA_create(0x0, 'jpegenc', 0x9ff038c0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
    [DSP] @4,205,229tk: [+0 T:0x9fc31794 S:0x9fc35484] CV - VISA_create2(0x0, 'jpegenc', 0x9ff038c0, 0x18, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
    [DSP] @4,205,319tk: [+0 T:0x9fc31794 S:0x9fc3541c] CE - Engine_open> Enter('local', 0x9fc3546c, 0x9ff038c0)
    [DSP] @4,205,380tk: [+0 T:0x9fc31794 S:0x9fc353fc] OM - Memory_alloc> Enter(size=0x34)
    [DSP] @4,205,427tk: [+0 T:0x9fc31794 S:0x9fc353fc] OM - Memory_alloc> return (0x9fc362e8)
    [DSP] @4,205,489tk: [+4 T:0x9fc31794 S:0x9fc3541c] CE - Engine_open> engine->server = 0x0
    [DSP] @4,205,539tk: [+0 T:0x9fc31794 S:0x9fc3541c] CE - Engine_open> return(-1614585112)
    [DSP] @4,205,612tk: [+0 T:0x9fc31794 S:0x9fc35464] OM - Memory_alloc> Enter(size=0x34)
    [DSP] @4,205,677tk: [+0 T:0x9fc31794 S:0x9fc35464] OM - Memory_alloc> return (0x9fc36320)
    [DSP] @4,205,735tk: [+0 T:0x9fc31794 S:0x9fc3543c] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x9fc5a234, idma3Fxns=0x9fc5a390, iresFxns=0x0, params=0x9ff038c0, attrs=0x9fc35588)
    [DSP] @4,205,832tk: [+0 T:0x9fc31794 S:0x9fc3541c] OM - Memory_alloc> Enter(size=0x10)
    [DSP] @4,205,880tk: [+0 T:0x9fc31794 S:0x9fc3541c] OM - Memory_alloc> return (0x9fc36358)
    [DSP] @4,206,335tk: [+0 T:0x9fc31794 S:0x9fc3543c] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x9fc36358)
    [DSP] @4,206,398tk: [+5 T:0x9fc31794 S:0x9fc35484] CV - VISA_create> local codec created (name='jpegenc', handle=0x9fc36358)
    [DSP] @4,206,465tk: [+0 T:0x9fc31794 S:0x9fc355dc] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x9fc36320)
    [DSP] @4,206,531tk: [+4 T:0x9fc31794 S:0x9fc3559c] OT - Thread_create > name: "jpegenc#0", pri: -1, stack size: 17192, stack seg: 0
    [DSP] @4,207,563tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 1
    [DSP] @4,208,758tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 5
    [DSP] @4,208,817tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - remote time = 0x0, trace buffer size = 4032
    @4,287,326us: [+0 T:0x40020100 S:0xbe95a904] CE - Engine_fwriteTrace> returning count [3111]
    @4,287,387us: [+2 T:0x40020100 S:0xbe95a96c] CE - Engine_createNode> Returning 0x429d8
    @4,287,417us: [+5 T:0x40020100 S:0xbe95a9e4] CV - VISA_create> remote codec created (name='jpegenc', localQueueID=0x10001, remoteQueueID=0x0002)
    @4,287,448us: [+0 T:0x40020100 S:0xbe95ab1c] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x42990)
    Success to create codec jpegenc
    @4,287,479us: [+0 T:0x40020100 S:0xbe95aad4] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x42990, id=6, dynParams=0xbe95ac2c (size=0x20), status=0xbe95ab8c (size=0xa0)
    @4,287,509us: [+4 T:0x40020100 S:0xbe95aa94] CV - VISA_getMaxMsgSize(0x42990): returning 0x1000
    @4,287,540us: [+5 T:0x40020100 S:0xbe95aa9c] CV - VISA_allocMsg> Allocating message for messageId=0x00020001
    @4,287,570us: [+0 T:0x40020100 S:0xbe95aa7c] CV - VISA_call(visa=0x42990, msg=0x414e3880): messageId=0x00020001, command=0x1
    @4,287,601us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_put> Enter(queue=0x2, msg=0x414e3880)
    @4,287,662us: [+0 T:0x40020100 S:0xbe95aa44] OC - Comm_put> return (0)
    @4,287,692us: [+0 T:0x40020100 S:0xbe95aa3c] OC - Comm_get> Enter(queue=0x10001, msg=0xbe95aaec, timeout=-1)
    @4,288,058us: [+0 T:0x40020100 S:0xbe95aa3c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @4,288,089us: [+3 T:0x40020100 S:0xbe95a9fc] CE - Engine_fwriteTrace(0x42518, '[DSP] ', 0x404b35e8)
    @4,288,119us: [+3 T:0x40020100 S:0xbe95a9fc] CE - Engine_fwriteTrace(): requesting DSP trace @0x416e77 ...
    @4,288,119us: [+0 T:0x40020100 S:0xbe95a9cc] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @4,288,180us: [+0 T:0x40020100 S:0xbe95a9cc] OC - Comm_put> return (0)
    @4,288,180us: [+0 T:0x40020100 S:0xbe95a9c4] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95aa64, timeout=-1)
    @4,288,425us: [+0 T:0x40020100 S:0xbe95a9c4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @4,288,455us: [+3 T:0x40020100 S:0xbe95a9fc] CE - Engine_fwriteTrace> got 1406 chars @0x416e77 (0 still avail, max: 32744, lost: 0)
    [DSP] @5,264,507tk: [+5 T:0x9fc3679c S:0x9fc3aa8c] CN - NODE> 0x9fc36258(jpegenc#0) call(algHandle=0x9fc36320, msg=0x9ff04880); messageId=0x00020001
    [DSP] @5,264,606tk: [+0 T:0x9fc3679c S:0x9fc3a85c] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x9fc36320, id=6, dynParams=0x9ff048b4 (size=0x20), status=0x9ff048d4 (size=0xa0)
    [DSP] @5,264,717tk: [+5 T:0x9fc3679c S:0x9fc3a83c] CV - VISA_enter(visa=0x9fc36320): algHandle = 0x9fc36358
    [DSP] @5,264,784tk: [+0 T:0x9fc3679c S:0x9fc3a81c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x9fc36358)
    [DSP] @5,264,854tk: [+0 T:0x9fc3679c S:0x9fc3a81c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
    [DSP] @5,264,919tk: [+5 T:0x9fc3679c S:0x9fc3a83c] CV - VISA_exit(visa=0x9fc36320): algHandle = 0x9fc36358
    [DSP] @5,264,981tk: [+0 T:0x9fc3679c S:0x9fc3a81c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x9fc36358)
    [DSP] @5,265,049tk: [+0 T:0x9fc3679c S:0x9fc3a81c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
    [DSP] @5,265,104tk: [+0 T:0x9fc3679c S:0x9fc3a85c] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x9fc36320, retVal=0xffffffff)
    [DSP] @5,265,180tk: [+5 T:0x9fc3679c S:0x9fc3aa8c] CN - NODE> returned from call(algHandle=0x9fc36320, msg=0x9ff04880); messageId=0x00020001
    [DSP] @5,266,117tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 5
    [DSP] @5,266,179tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - remote time = 0x0, trace buffer size = 4032
    @4,622,653us: [+0 T:0x40020100 S:0xbe95a9fc] CE - Engine_fwriteTrace> returning count [1478]
    @4,622,684us: [+0 T:0x40020100 S:0xbe95aa7c] CV - VISA_call Completed: messageId=0x00020001, command=0x1, return(status=-1)
    @4,622,714us: [+5 T:0x40020100 S:0xbe95aa84] CV - VISA_freeMsg(0x42990, 0x414e3880): Freeing message with messageId=0x00020001
    @4,622,745us: [+0 T:0x40020100 S:0xbe95aad4] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x42990, retVal=0xffffffff)
    status = -1
    @4,622,775us: [+0 T:0x40020100 S:0xbe95ab34] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> Enter (handle=0x42990)
    @4,622,806us: [+0 T:0x40020100 S:0xbe95ab0c] CV - VISA_delete(0x42990)
    @4,622,836us: [+5 T:0x40020100 S:0xbe95ab0c] CV - VISA_delete> deleting codec (localQueue=0x10001, remoteQueue=0x2)
    @4,622,867us: [+0 T:0x40020100 S:0xbe95aae4] CE - Engine_ctrlNode(0x429d8, 0x429c8, 0x0)
    @4,622,867us: [+0 T:0x40020100 S:0xbe95aac4] OC - Comm_put> Enter(queue=0x2, msg=0x414e3880)
    @4,622,928us: [+0 T:0x40020100 S:0xbe95aac4] OC - Comm_put> return (0)
    @4,622,989us: [+0 T:0x40020100 S:0xbe95aabc] OC - Comm_get> Enter(queue=0x10001, msg=0x429c8, timeout=-1)
    @4,623,019us: [+0 T:0x40020100 S:0xbe95aabc] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @4,623,050us: [+0 T:0x40020100 S:0xbe95aae4] CE - Engine_ctrlNode> Returning 0x0
    @4,623,050us: [+0 T:0x40020100 S:0xbe95aac4] CE - Engine_deleteNode(0x429d8)
    @4,623,080us: [+0 T:0x40020100 S:0xbe95aaa4] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @4,623,111us: [+0 T:0x40020100 S:0xbe95aaa4] OC - Comm_put> return (0)
    @4,623,141us: [+0 T:0x40020100 S:0xbe95aa9c] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95ab1c, timeout=-1)
    @4,623,782us: [+0 T:0x40020100 S:0xbe95aa9c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @4,623,874us: [+5 T:0x40020100 S:0xbe95aac4] CE - Engine_deleteNode(0x429d8): algName = jpegenc, algHandle = 0x9fc36320, stack size = 17192, stack used = 887(6%)
    @4,623,904us: [+0 T:0x40020100 S:0xbe95aa9c] OC - Comm_delete> Enter (comm=0x42a00)
    @4,624,087us: [+0 T:0x40020100 S:0xbe95aa7c] OM - Memory_free> Enter(0x42a00, 0x4)
    @4,624,118us: [+0 T:0x40020100 S:0xbe95aa7c] OM - Memory_free> return (0x1)
    @4,624,148us: [+0 T:0x40020100 S:0xbe95aabc] OC - Comm_delete> return
    @4,624,179us: [+0 T:0x40020100 S:0xbe95aaa4] OM - Memory_free> Enter(0x429d8, 0x20)
    @4,624,179us: [+0 T:0x40020100 S:0xbe95aaa4] OM - Memory_free> return (0x1)
    @4,624,209us: [+0 T:0x40020100 S:0xbe95aafc] OC - Comm_free> Enter (msg=0x414e3880)
    @4,957,400us: [+0 T:0x40020100 S:0xbe95aafc] OC - Comm_free> return (0)
    @4,957,431us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_free> Enter(0x429c8, 0x4)
    @4,957,461us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_free> return (0x1)
    @4,957,461us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_free> Enter(0x42990, 0x34)
    @4,957,492us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_free> return (0x1)
    @4,957,522us: [+0 T:0x40020100 S:0xbe95ab44] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> return
    @4,957,553us: [+0 T:0x40020100 S:0xbe95ab24] CE - Engine_close(0x42518)
    @4,957,553us: [+3 T:0x40020100 S:0xbe95aabc] CE - Engine_fwriteTrace(0x42518, '[DSP] ', 0x404b35e8)
    @4,957,583us: [+3 T:0x40020100 S:0xbe95aabc] CE - Engine_fwriteTrace(): requesting DSP trace @0x4ba58f ...
    @4,957,614us: [+0 T:0x40020100 S:0xbe95aa8c] OC - Comm_put> Enter(queue=0x0, msg=0x414e2880)
    @4,957,645us: [+0 T:0x40020100 S:0xbe95aa8c] OC - Comm_put> return (0)
    @4,957,675us: [+0 T:0x40020100 S:0xbe95aa84] OC - Comm_get> Enter(queue=0x10000, msg=0xbe95ab24, timeout=-1)
    @4,957,919us: [+0 T:0x40020100 S:0xbe95aa84] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
    @4,957,950us: [+3 T:0x40020100 S:0xbe95aabc] CE - Engine_fwriteTrace> got 2192 chars @0x4ba58f (0 still avail, max: 32744, lost: 0)
    [DSP] @6,312,218tk: [+0 T:0x9fc3679c S:0x9fc3aa8c] CN - NODE_EXECFXN(0x9fc36258): jpegenc#0 exiting per request ...
    [DSP] @6,312,826tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 2
    [DSP] @6,313,396tk: [+0 T:0x9fc31794 S:0x9fc3570c] CN - NODE_delete(0x9fc36258): jpegenc#0
    [DSP] @6,313,470tk: [+0 T:0x9fc31794 S:0x9fc356ec] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> Enter (handle=0x9fc36320)
    [DSP] @6,313,532tk: [+0 T:0x9fc31794 S:0x9fc356bc] CV - VISA_delete(0x9fc36320)
    [DSP] @6,313,583tk: [+5 T:0x9fc31794 S:0x9fc356bc] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
    [DSP] @6,313,645tk: [+5 T:0x9fc31794 S:0x9fc356bc] CV - VISA_delete> deleting codec 0x9fc36358
    [DSP] @6,313,697tk: [+0 T:0x9fc31794 S:0x9fc3569c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x9fc36358)
    [DSP] @6,313,867tk: [+0 T:0x9fc31794 S:0x9fc3566c] OM - Memory_free> Enter(addr=0x9fc36358, size=16)
    [DSP] @6,313,925tk: [+0 T:0x9fc31794 S:0x9fc3566c] OM - Memory_free> return (0x1)
    [DSP] @6,313,970tk: [+0 T:0x9fc31794 S:0x9fc3569c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit
    [DSP] @6,314,023tk: [+0 T:0x9fc31794 S:0x9fc3568c] OM - Memory_free> Enter(addr=0x9fc36320, size=52)
    [DSP] @6,314,077tk: [+0 T:0x9fc31794 S:0x9fc3568c] OM - Memory_free> return (0x1)
    [DSP] @6,314,123tk: [+0 T:0x9fc31794 S:0x9fc356ec] ti.sdo.ce.image1.IMGENC1 - IMGENC1_delete> return
    [DSP] @6,314,183tk: [+0 T:0x9fc31794 S:0x9fc356d4] OM - Memory_free> Enter(addr=0x9fc36278, size=36)
    [DSP] @6,314,238tk: [+0 T:0x9fc31794 S:0x9fc356d4] OM - Memory_free> return (0x1)
    [DSP] @6,314,281tk: [+0 T:0x9fc31794 S:0x9fc356dc] OM - Memory_free> Enter(addr=0x9fc36258, size=32)
    [DSP] @6,314,336tk: [+0 T:0x9fc31794 S:0x9fc356dc] OM - Memory_free> return (0x1)
    [DSP] @6,314,382tk: [+0 T:0x9fc31794 S:0x9fc356fc] OM - Memory_free> Enter(addr=0x9fc36248, size=10)
    [DSP] @6,314,437tk: [+0 T:0x9fc31794 S:0x9fc356fc] OM - Memory_free> return (0x1)
    [DSP] @6,314,480tk: [+0 T:0x9fc31794 S:0x9fc356fc] OM - Memory_free> Enter(addr=0x9fc36230, size=24)
    [DSP] @6,314,534tk: [+0 T:0x9fc31794 S:0x9fc356fc] OM - Memory_free> return (0x1)
    [DSP] @7,358,284tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - processRmsCmd(0x9ff038a8, 4056): cmd = 5
    [DSP] @7,358,350tk: [+0 T:0x9fc31794 S:0x9fc35754] CR - remote time = 0x0, trace buffer size = 4032
    @4,959,384us: [+0 T:0x40020100 S:0xbe95aabc] CE - Engine_fwriteTrace> returning count [2336]
    @4,959,415us: [+0 T:0x40020100 S:0xbe95ab04] CS - Server_disconnectTrace('0x42518', 0x0)
    @5,292,880us: [+0 T:0x40020100 S:0xbe95ab04] CS - Server_disconnectTrace> return(0)
    @5,292,911us: [+0 T:0x40020100 S:0xbe95ab14] OC - Comm_free> Enter (msg=0x414e2880)
    @5,292,972us: [+0 T:0x40020100 S:0xbe95ab14] OC - Comm_free> return (0)
    @5,292,972us: [+0 T:0x40020100 S:0xbe95ab04] OC - Comm_delete> Enter (comm=0x42930)
    @5,293,094us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_free> Enter(0x42930, 0x4)
    @5,293,124us: [+0 T:0x40020100 S:0xbe95aae4] OM - Memory_free> return (0x1)
    @5,293,155us: [+0 T:0x40020100 S:0xbe95ab24] OC - Comm_delete> return
    @5,293,185us: [+0 T:0x40020100 S:0xbe95ab14] OC - Comm_release> Enter(queue=0x0)
    @5,293,216us: [+0 T:0x40020100 S:0xbe95ab14] OC - Comm_release> return (0)
    @5,293,216us: [+0 T:0x40020100 S:0xbe95ab24] CE - rserverClose(0x412a8), count = 1
    @5,293,246us: [+0 T:0x40020100 S:0xbe95ab0c] OP - Processor_delete> Enter(proc=0x42550)
    @5,293,277us: [+0 T:0x40020100 S:0xbe95aaec] OP - doCmd> Enter (cmdId=2, proc=0x42550)
    @5,293,307us: [+0 T:0x40020100 S:0xbe95aadc] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x421c0]
    @5,293,338us: [+0 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x421c0] status[0]
    @5,293,368us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - getCmd_d> Exit (result=2)
    @5,293,399us: [+0 T:0x40cd2490 S:0x40cd1d4c] OP - Processor_delete_d> Enter (proc=0x42550)
    @5,293,429us: [+0 T:0x40cd2490 S:0x40cd1d34] ti.sdo.ce.ipc.Power - Power_disconnect> Enter (handle=0x42578)
    @5,293,460us: [+2 T:0x40cd2490 S:0x40cd1d34] ti.sdo.ce.ipc.Power - Power_disconnect> Calling LPM_disconnect to disconnect from the DSP power handler...
    @5,293,490us: [+0 T:0x40cd2490 S:0x40cd1d34] ti.sdo.ce.ipc.Power - Power_disconnect> return (0)
    @5,293,521us: [+2 T:0x40cd2490 S:0x40cd1d4c] OP - Processor_delete_d> Closing remote transport...
    @5,293,674us: [+2 T:0x40cd2490 S:0x40cd1d4c] OP - Processor_delete_d> Stopping DSP...
    @5,293,735us: [+2 T:0x40cd2490 S:0x40cd1d4c] OP - Processor_delete_d> Closing pool...
    @5,293,826us: [+2 T:0x40cd2490 S:0x40cd1d4c] OP - Processor_delete_d> Detaching from DSP...
    @5,295,474us: [+2 T:0x40cd2490 S:0x40cd1d4c] OP - Processor_delete_d> Destroying DSP... (object, that is)
    @5,295,749us: [+0 T:0x40cd2490 S:0x40cd1d34] ti.sdo.ce.ipc.Power - Power_off> Enter (handle=0x42578)
    @5,295,810us: [+2 T:0x40cd2490 S:0x40cd1d34] ti.sdo.ce.ipc.Power - Power_off> Turning off DSP power...
    @5,295,901us: [+2 T:0x40cd2490 S:0x40cd1d34] ti.sdo.ce.ipc.Power - Power_off> Closing Local Power Manager object...
    @5,295,932us: [+0 T:0x40cd2490 S:0x40cd1d34] ti.sdo.ce.ipc.Power - Power_off> return (0)
    @5,295,962us: [+0 T:0x40cd2490 S:0x40cd1d2c] OM - Memory_free> Enter(0x425b0, 0x0)
    @5,295,993us: [+0 T:0x40cd2490 S:0x40cd1d2c] OM - Memory_free> return (0x1)
    @5,296,023us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - Processor_delete_d> return
    @5,296,054us: [+0 T:0x40cd2490 S:0x40cd1d54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x421d8]
    @5,296,084us: [+0 T:0x40cd2490 S:0x40cd1d64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x421d8]
    @5,296,084us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - getCmd_d> Enter (proc=0x40cd1dd8)
    @5,296,115us: [+0 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x421c0] timeout[0xffffffff]
    @5,296,176us: [+0 T:0x40020100 S:0xbe95aaec] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x421c0]
    @5,296,207us: [+0 T:0x40020100 S:0xbe95aacc] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x421d8] timeout[0xffffffff]
    @5,296,207us: [+0 T:0x40020100 S:0xbe95aacc] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x421d8] status[0]
    @5,296,237us: [+0 T:0x40020100 S:0xbe95aaec] OP - doCmd> Exit (result=1)
    @5,296,268us: [+1 T:0x40020100 S:0xbe95ab0c] OP - Processor_delete(0x42550) freeing object ...
    @5,296,298us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_free> Enter(0x42550, 0x24)
    @5,296,298us: [+0 T:0x40020100 S:0xbe95aaec] OM - Memory_free> return (0x1)
    @5,631,412us: [+0 T:0x40020100 S:0xbe95ab24] OP - Processor_delete> return.
    @5,631,442us: [+0 T:0x40020100 S:0xbe95ab24] CE - rserverClose(0x412a8) done.
    @5,631,442us: [+0 T:0x40020100 S:0xbe95ab04] OM - Memory_free> Enter(0x42518, 0x34)
    @5,631,473us: [+0 T:0x40020100 S:0xbe95ab04] OM - Memory_free> return (0x1)
    @5,631,503us: [+0 T:0x40020100 S:0xbe95ab44] CE - Engine_close exit
    @5,631,534us: [+0 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> enter
    @5,631,564us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0xca5c()...
    @5,631,595us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0xe164()...
    @5,631,625us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x108f4()...
    @5,631,656us: [+0 T:0x40020100 S:0xbe95abf4] OM - Memory_free> Enter(0x42458, 0x18)
    @5,631,686us: [+0 T:0x40020100 S:0xbe95abf4] OM - Memory_free> return (0x1)
    @5,631,717us: [+0 T:0x40020100 S:0xbe95abf4] OM - Memory_free> Enter(0x42478, 0x18)
    @5,631,747us: [+0 T:0x40020100 S:0xbe95abf4] OM - Memory_free> return (0x1)
    @5,631,747us: [+0 T:0x40020100 S:0xbe95abf4] OM - Memory_free> Enter(0x42498, 0x18)
    @5,631,778us: [+0 T:0x40020100 S:0xbe95abf4] OM - Memory_free> return (0x1)
    @5,631,808us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1cfbc()...
    @5,631,839us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x143fc()...
    @5,631,839us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1a668()...
    @5,631,869us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x17d78()...
    @5,631,900us: [+0 T:0x40020100 S:0xbe95abfc] OP - doCmd> Enter (cmdId=3, proc=0x0)
    @5,631,930us: [+0 T:0x40020100 S:0xbe95abec] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x421c0]
    @5,631,961us: [+0 T:0x40cd2490 S:0x40cd1d44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x421c0] status[0]
    @5,631,991us: [+0 T:0x40cd2490 S:0x40cd1d64] OP - getCmd_d> Exit (result=3)
    @5,632,022us: [+0 T:0x40cd2490 S:0x40cd1d54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x421d8]
    @5,632,052us: [+0 T:0x40cd2490 S:0x40cd1d64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x421d8]
    @5,632,144us: [+0 T:0x40020100 S:0xbe95abfc] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x421c0]
    @5,632,175us: [+0 T:0x40020100 S:0xbe95abdc] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x421d8] timeout[0xffffffff]
    @5,632,205us: [+0 T:0x40020100 S:0xbe95abdc] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x421d8] status[0]
    @5,632,236us: [+0 T:0x40020100 S:0xbe95abfc] OP - doCmd> Exit (result=1)
    @5,632,266us: [+0 T:0x40020100 S:0xbe95ac04] OT - Thread_delete> Enter (task=0x42210)
    @5,632,297us: [+4 T:0x40020100 S:0xbe95ac04] OT - Thread_delete> pthread_cancel (0x3)
    @5,632,327us: [+4 T:0x40020100 S:0xbe95ac04] OT - Thread_delete> pthread_join (0x0)
    @5,632,358us: [+0 T:0x40020100 S:0xbe95abe4] OM - Memory_free> Enter(0x42210, 0x64)
    @5,632,388us: [+0 T:0x40020100 S:0xbe95abe4] OM - Memory_free> return (0x1)
    @5,632,388us: [+0 T:0x40020100 S:0xbe95ac1c] OT - Thread_delete> Exit (task=0x42210)
    @5,632,419us: [+0 T:0x40020100 S:0xbe95ac0c] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x421c0]
    @5,632,449us: [+0 T:0x40020100 S:0xbe95abec] OM - Memory_free> Enter(0x421c0, 0x14)
    @5,632,480us: [+0 T:0x40020100 S:0xbe95abec] OM - Memory_free> return (0x1)
    @5,632,510us: [+0 T:0x40020100 S:0xbe95ac1c] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
    @5,632,510us: [+0 T:0x40020100 S:0xbe95ac0c] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x421d8]
    @5,632,541us: [+0 T:0x40020100 S:0xbe95abec] OM - Memory_free> Enter(0x421d8, 0x14)
    @5,632,571us: [+0 T:0x40020100 S:0xbe95abec] OM - Memory_free> return (0x1)
    @5,632,571us: [+0 T:0x40020100 S:0xbe95ac1c] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
    @5,632,602us: [+0 T:0x40020100 S:0xbe95abfc] OM - Memory_free> Enter(0x421f0, 0x18)
    @5,967,074us: [+0 T:0x40020100 S:0xbe95abfc] OM - Memory_free> return (0x1)
    @5,967,105us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x19820()...
    @5,967,135us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1cacc()...
    @5,967,166us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1a11c()...
    @5,967,197us: [+0 T:0x40020100 S:0xbe95ac0c] OM - Memory_free> Enter(0x42140, 0x18)
    @5,967,227us: [+0 T:0x40020100 S:0xbe95ac0c] OM - Memory_free> return (0x1)
    @5,967,227us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1b2f0()...
    @5,967,288us: [+0 T:0x40020100 S:0xbe95abfc] OM - Memory_free> Enter(0x420f0, 0x18)
    @5,967,288us: [+0 T:0x40020100 S:0xbe95abfc] OM - Memory_free> return (0x1)
    @5,967,319us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1d468()...
    @5,967,349us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1e01c()...
    @5,967,380us: [+2 T:0x40020100 S:0xbe95ac2c] OG - Global_exit> calling function *0x1d3c8()...

  • 你好,

    你使用的jpegenc是否有extended error可以打印出来分析一下问题原因?

    还有你的代码里面没有对动态参数进行配置,你能否把所有的动态参数都配置一下,然后再运行control命令?

  • 你好,

         感谢回复,动态配置的参数我之前也有全部按照默认的参数填过一遍,还是出现配置不成功的问题,下面我将动态参数配置成以下形式,就配置成功了:

    IMGENC1_DynamicParams       encDynParams;
    	IMGENC1_Status              encStatus;
    
    	encDynParams.size   = sizeof(IMGENC1_DynamicParams);
    	encDynParams.numAU	= XDM_DEFAULT;
    	encDynParams.inputChromaFormat = XDM_YUV_422ILE;
    	encDynParams.inputHeight	= params.maxHeight; //480
    	encDynParams.inputWidth		= params.maxWidth;  //640
    	encDynParams.captureWidth	= params.maxWidth;  //640
    	encDynParams.generateHeader	= XDM_ENCODE_AU;
    	encDynParams.qValue			= 86;
    
    	encStatus.data.buf = NULL;
    	encStatus.size = sizeof(IMGENC1_Status);
    
    	int status = IMGENC1_control(hImg, XDM_GETVERSION, &encDynParams, &encStatus);
    
    	printf("status = %d\n", status);
    
    
    在上文中,我有以下配置:
    MGENC1_Params          params;
    	params.size				= sizeof(IMGENC1_Params);	/**< @sizeField */
        params.maxHeight		= 640;			/**< Maximum height. */
        params.maxWidth			= 480;			/**< Maximum width. */
        params.maxScans			= XDM_DEFAULT;	/**< Maximum number of scans. */
        params.dataEndianness	= XDM_BYTE;		/**< Endianness of output data.
                                     *
                                     *   @sa    XDM_DataFormat
                                     */
        params.forceChromaFormat=XDM_YUV_422P;	/**< Force encoding in given Chroma format.
                                     *
                                     *   @sa XDM_ChromaFormat
                                     */

    关键在这一句:

    	encDynParams.inputHeight	= params.maxHeight; //480
    	encDynParams.inputWidth		= params.maxWidth;  //640
    	encDynParams.captureWidth	= params.maxWidth;  //640
    
    
    如果我将这里配置成使用具体数值,就会出现配置不成功的情况,
    为什么会出现这种情况的呢?

    encDynParams.inputHeight = 480;
    encDynParams.inputWidth = 640;
    encDynParams.captureWidth = 640;

    对应的返回信息如下:

    status = -1 error = 0 //printf("status = %d error = %d\n", status, encStatus.extendedError);

  • Eric,

    这个太奇怪了。你在配置inputHeight/width/cpaturewidth前把params.maxHeight/maxWidth打印出来看看,是否是你配置的那几个值?