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.

JPEG encoding problem on DM3730

Other Parts Discussed in Thread: OMAP3530, DM3730

I have written a program to encode a jpeg image from raw image. But there is a strange behaviour within the program: 

	status = IMGENC1_control(enc, XDM_SETPARAMS, &encDynParams, &encStatus);
	if (status != IMGENC1_EOK)
	{
		printf("Error (%d), Extended Error (%d) in image Encoder Control:setparams\n", status, encStatus.extendedError);
		return -1;
	}
	else
	{
		printf("Encoder params set are OK\n");
	}

	//Check whether jpegenc encoder can handle out buffer size
	status = IMGENC1_control(enc, XDM_GETBUFINFO, &encDynParams, &encStatus);
	if (status != IMGENC1_EOK)
	{
		printf("Error (%d), Extended Error (%d) in image Encoder Control:check\n", status, encStatus.extendedError);
		return -1;
	}
	else
	{
		unsigned char i;
		printf("--------Printing buffer requirements of the codec:--------\n");
		printf("Input buffers needed: %d\n",(int)encStatus.bufInfo.minNumInBufs);
		for(i=0; i<encStatus.bufInfo.minNumInBufs; i++)
			printf("Input buffer %u size: %d\n", i, (int)encStatus.bufInfo.minInBufSize[i]);

		printf("Output buffers needed: %d\n",(int)encStatus.bufInfo.minNumOutBufs);
		for(i=0;i<encStatus.bufInfo.minNumOutBufs;i++)
			printf("Output buffer %u size: %d\n", i, (int)encStatus.bufInfo.minOutBufSize[i]);
		printf("----------------------------------------------------------\n");
	}
/*
	//Encode image section
	status = IMGENC1_process(enc, &inBufDesc, &outBufDesc, &encInArgs, &encOutArgs);
	if(status != IMGENC1_EOK)
	{
		printf("Error while encoding the image\n");
		return -1;
	}
	else
	{
		printf("JPEG encoded: %d bytes\n", encOutArgs.bytesGenerated);
	}
	return encOutArgs.bytesGenerated;
*/

Program with this code section with encode image section is commented works normally, however whenever comments of encode image section is removed, errors start to occur.

Program output related with errors are as follows:

[12610.685852] CMEMK Error: get_phys: Unable to find phys addr for 0x00001000
[12610.692810] CMEMK Error: get_phys: get_user_pages() failed: -14
[12610.698791] CMEMK Error: GETPHYS: Failed to convert virtual 0x1000 to physical.
CMEM Error: getPhys: Failed to get physical address of 0x1000
Error (-1), Extended Error (0) in image Encoder Control:setparams


As you can see, program hangs by the execution of line:

status = IMGENC1_control(enc, XDM_SETPARAMS, &encDynParams, &encStatus);

which works normally before. 

I have inspected on Debug outputs of the two programs (one with comments wrapping encode image section and one without any comments) with CE_DEBUG=2.

The outputs are attached to this post:

@0,782,656us: [+4 T:0x4001e320] OG - Global_init> This program was built with the following packages:
@0,782,870us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegdec (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
@0,782,900us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegenc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
@0,782,931us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
@0,782,931us: [+4 T:0x4001e320] OG -     package ti.xdais.dm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/dm/) [1, 0, 5]
@0,782,961us: [+4 T:0x4001e320] OG -     package ti.xdais (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/) [1, 2.0, 1]
@0,782,961us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.node (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
@0,782,992us: [+4 T:0x4001e320] OG -     package ti.sdo.utils.trace (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
@0,782,992us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.utils.xdm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
@0,783,022us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
@0,783,053us: [+4 T:0x4001e320] OG -     package ti.sdo.linuxutils.cmem (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/linuxutils_2_25_05_11/packages/ti/sdo/linuxutils/cmem/) [2, 2, 0]
@0,783,053us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.memutils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
@0,783,083us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.utils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/utils/) [1, 0, 2]
@0,783,083us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.dman3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
@0,783,114us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.acpy3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
@0,783,114us: [+4 T:0x4001e320] OG -     package gnu.targets (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/gnu/targets/) [1, 0, 1]
@0,783,144us: [+4 T:0x4001e320] OG -     package gnu.targets.arm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/gnu/targets/arm/) [1, 0, 0, 0]
@0,783,144us: [+4 T:0x4001e320] OG -     package dsplink.gpp (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dsplink_1_65_00_02/dsplink/gpp/) [5, 0, 0]
@0,783,175us: [+4 T:0x4001e320] OG -     package ti.bios.power (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/local-power-manager_1_24_02_09/packages/ti/bios/power/) [1, 1, 1]
@0,783,175us: [+4 T:0x4001e320] OG -     package ti.catalog.arm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
@0,783,175us: [+4 T:0x4001e320] OG -     package ti.catalog (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
@0,783,206us: [+4 T:0x4001e320] OG -     package ti.catalog.c6000 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
@0,783,206us: [+4 T:0x4001e320] OG -     package ti.platforms.evm3530 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
@0,783,236us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.osal (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
@0,783,236us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.ipc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
@0,783,267us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.osal.linux (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
@0,783,267us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.ipc.dsplink (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
@0,783,267us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.alg (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
@0,783,297us: [+4 T:0x4001e320] OG -     package ti.sdo.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
@0,783,297us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.image1 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
@0,783,328us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegdec.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
@0,783,328us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegenc.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
@0,783,358us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.examples.apps.image1_copy (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/examples/ti/sdo/ce/examples/apps/image1_copy/) [1, 0, 0]
@0,783,541us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,783,572us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x481c0]
@0,783,602us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,783,602us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x481d8]
@0,783,633us: [+0 T:0x4001e320] OT - Thread_create> Enter (fxn=0x16fac, attrs=0x0)
@0,783,846us: [+0 T:0x4001e320] OT - Thread_create> Exit (task=0x48210)
@0,783,907us: [+0 T:0x4001e320] ti.sdo.ce.alg - ALG_init> Enter
@0,783,938us: [+0 T:0x4001e320] ti.sdo.ce.alg - ALG_init> Exit
@0,783,969us: [+6 T:0x4001e320] CE - Engine_init> CE debugging on (CE_DEBUG=2; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@0,784,030us: [+0 T:0x4001e320] CS - Server_init()
@0,784,030us: [+0 T:0x4001e320] CS - Server_init> Global_useLinkArbiter = 0
@0,784,060us: [+2 T:0x4001e320] ti.sdo.ce.examples.apps.image1_copy - main> ti.sdo.ce.examples.apps.image1_copy
@0,784,091us: [+0 T:0x4001e320] CE - Engine_open> Enter('image1_copy', 0x0, 0xbeba5c44)
@0,784,121us: [+0 T:0x4001e320] CE - rserverOpen('cs.x64P'), count = 0
@0,784,152us: [+0 T:0x4001e320] OP - Processor_create> Enter(imageName='cs.x64P', linkCfg='(null)', attrs=0xbeba5c28)
@0,785,891us: [+0 T:0x4001e320] OP - doCmd> Enter (cmdId=1, proc=0x48558)
@0,785,952us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481c0]
@0,785,983us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481c0]
@0,786,013us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481d8] timeout[0xffffffff]
@0,786,929us: [+1 T:0x40983490] OP - daemon> thread created.
@0,787,020us: [+0 T:0x40983490] OP - getCmd_d> Enter (proc=0x40982dd8)
@0,787,051us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481c0] timeout[0xffffffff]
@0,787,081us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481c0] status[0]
@0,787,081us: [+0 T:0x40983490] OP - getCmd_d> Exit (result=1)
@0,787,081us: [+0 T:0x40983490] OP - Processor_create_d> Enter(proc=0x48558)
@0,787,112us: [+0 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> Enter(handle=0x48574)
@0,787,112us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> Opening Local Power Manager for the DSP on /dev/lpm0...
@0,787,204us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> Turning on DSP power...
@0,787,356us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> return (0)
@0,787,356us: [+2 T:0x40983490] OP - Processor_create_d> Initializing DSP PROC...
@0,787,387us: [+2 T:0x40983490] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'cs.x64P']
@0,787,417us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x87800000, sizeInBytes=0x600000, shared=1, syncd=0
@0,787,448us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x87e00000, sizeInBytes=0x100000, shared=1, syncd=0
@0,787,631us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x87f00000, sizeInBytes=0x1000, shared=1, syncd=0
@0,787,661us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='L4PER', startAddress=0x49000000, sizeInBytes=0x100000, shared=0, syncd=0
@0,787,661us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #4 to Link configuration: name='IRAM', startAddress=0x5c7f8000, sizeInBytes=0x8000, shared=1, syncd=0
@0,787,692us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #5 to Link configuration: name='L1DSRAM', startAddress=0x5cf04000, sizeInBytes=0x10000, shared=1, syncd=0
@0,787,692us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #6 to Link configuration: name='L1PSRAM', startAddress=0x5ce00000, sizeInBytes=0x4000, shared=1, syncd=0
@0,787,722us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #7 to Link configuration: name='DDRALGHEAP', startAddress=0x86000000, sizeInBytes=0x1000000, shared=0, syncd=0
@0,787,753us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #8 to Link configuration: name='L4CORE', startAddress=0x48000000, sizeInBytes=0x1000000, shared=0, syncd=0
@0,787,753us: [+2 T:0x40983490] OP - Processor_create_d> Found 'CMEM' entry, adjusting base and size according to CMEM_getBlock()
@0,787,783us: [+0 T:0x40983490] OP - Processor_create_d> Setting CMEM base to 0x83700000, size to 0x2900000
@0,787,783us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #9 to Link configuration: name='CMEM', startAddress=0x83700000, sizeInBytes=0x2900000, shared=0, syncd=0
@0,787,814us: [+2 T:0x40983490] OP - Processor_create_d> DODSPCTRL was=0; now=0
@0,787,844us: [+3 T:0x40983490] OP - LINKCFG_Object generated for PROC_setup(0x46a50) ...
@0,787,875us: [+3 T:0x40983490] OP - linkCfg->gppObject->
@0,787,875us: [+3 T:0x40983490] OP -   name = "ARM9"
@0,787,905us: [+3 T:0x40983490] OP -   maxMsgqs = 0x82
@0,787,905us: [+3 T:0x40983490] OP -   maxChnlQueue = 0x10
@0,787,936us: [+3 T:0x40983490] OP -   poolTableId = 0xffffffff
@0,787,936us: [+3 T:0x40983490] OP -   numPools = 0x0
@0,787,967us: [+3 T:0x40983490] OP - 
@0,787,967us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->dspObject->
@0,787,967us: [+3 T:0x40983490] OP -   name = "OMAP3530"
@0,787,997us: [+3 T:0x40983490] OP -   dspArch = 0x2
@0,787,997us: [+3 T:0x40983490] OP -   loaderName = "COFF"
@0,788,028us: [+3 T:0x40983490] OP -   autoStart = FALSE
@0,788,028us: [+3 T:0x40983490] OP -   execName = "DEFAULT.OUT"
@0,788,058us: [+3 T:0x40983490] OP -   doDspCtrl = DSP_BootMode_Boot_NoPwr
@0,788,058us: [+3 T:0x40983490] OP -   resumeAddr = 0x87f00020
@0,788,089us: [+3 T:0x40983490] OP -   resetVector = 0x87f00000
@0,788,089us: [+3 T:0x40983490] OP -   resetCodeSize = 0x1000
@0,788,089us: [+3 T:0x40983490] OP -   maduSize = 0x1
@0,788,119us: [+3 T:0x40983490] OP -   cpuFreq = 0x6ddd0
@0,788,119us: [+3 T:0x40983490] OP -   endian = 0x3
@0,788,150us: [+3 T:0x40983490] OP -   wordSwap = 0x0
@0,788,150us: [+3 T:0x40983490] OP -   memTableId = 0x0
@0,788,180us: [+3 T:0x40983490] OP -   memEntries = 0xa
@0,788,180us: [+3 T:0x40983490] OP -   linkDrvId = 0x0
@0,788,180us: [+3 T:0x40983490] OP -   arg1 = 0xffffffff
@0,788,211us: [+3 T:0x40983490] OP -   arg2 = 0xffffffff
@0,788,211us: [+3 T:0x40983490] OP -   arg3 = 0x0
@0,788,241us: [+3 T:0x40983490] OP -   arg4 = 0x0
@0,788,241us: [+3 T:0x40983490] OP -   arg5 = 0xffffffff
@0,788,272us: [+3 T:0x40983490] OP - 
@0,788,272us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->linkDrvObjects->
@0,788,302us: [+3 T:0x40983490] OP -   name = "SHMDRV"
@0,788,302us: [+3 T:0x40983490] OP -   hshkPollCount = 0x989680
@0,788,333us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,788,333us: [+3 T:0x40983490] OP -   ipsTableId = 0x0
@0,788,333us: [+3 T:0x40983490] OP -   numIpsEntries = 0x1
@0,788,363us: [+3 T:0x40983490] OP -   poolTableId = 0x0
@0,788,363us: [+3 T:0x40983490] OP -   numPools = 0x1
@0,788,394us: [+3 T:0x40983490] OP -   dataTableId = 0x0
@0,788,394us: [+3 T:0x40983490] OP -   numDataDrivers = 0x1
@0,788,424us: [+3 T:0x40983490] OP -   mqtId = 0x0
@0,788,424us: [+3 T:0x40983490] OP -   ringIoTableId = 0x0
@0,788,424us: [+3 T:0x40983490] OP -   mplistTableId = 0x0
@0,788,455us: [+3 T:0x40983490] OP -   mpcsTableId = 0x0
@0,788,455us: [+3 T:0x40983490] OP - 
@0,788,485us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->memTables[0][i].
@0,788,485us: [+3 T:0x40983490] OP - entry #0:
@0,788,516us: [+3 T:0x40983490] OP -   entry = 0x0
@0,788,516us: [+3 T:0x40983490] OP -   name = "DDR2"
@0,788,516us: [+3 T:0x40983490] OP -   physAddr = 0x87800000
@0,788,546us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x87800000
@0,788,546us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,788,577us: [+3 T:0x40983490] OP -   size = 0x600000
@0,788,577us: [+3 T:0x40983490] OP -   shared = TRUE
@0,788,607us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,788,607us: [+3 T:0x40983490] OP - entry #1:
@0,788,607us: [+3 T:0x40983490] OP -   entry = 0x1
@0,788,638us: [+3 T:0x40983490] OP -   name = "DSPLINKMEM"
@0,788,638us: [+3 T:0x40983490] OP -   physAddr = 0x87e00000
@0,788,668us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x87e00000
@0,788,668us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,788,699us: [+3 T:0x40983490] OP -   size = 0x100000
@0,788,699us: [+3 T:0x40983490] OP -   shared = TRUE
@0,788,699us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,788,729us: [+3 T:0x40983490] OP - entry #2:
@0,788,729us: [+3 T:0x40983490] OP -   entry = 0x2
@0,788,760us: [+3 T:0x40983490] OP -   name = "RESET_VECTOR"
@0,788,760us: [+3 T:0x40983490] OP -   physAddr = 0x87f00000
@0,788,791us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x87f00000
@0,788,791us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,788,791us: [+3 T:0x40983490] OP -   size = 0x1000
@0,788,821us: [+3 T:0x40983490] OP -   shared = TRUE
@0,788,821us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,788,852us: [+3 T:0x40983490] OP - entry #3:
@0,788,852us: [+3 T:0x40983490] OP -   entry = 0x3
@0,788,882us: [+3 T:0x40983490] OP -   name = "L4PER"
@0,788,882us: [+3 T:0x40983490] OP -   physAddr = 0x49000000
@0,788,882us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x49000000
@0,788,913us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,788,913us: [+3 T:0x40983490] OP -   size = 0x100000
@0,788,943us: [+3 T:0x40983490] OP -   shared = FALSE
@0,788,943us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,788,974us: [+3 T:0x40983490] OP - entry #4:
@0,788,974us: [+3 T:0x40983490] OP -   entry = 0x4
@0,788,974us: [+3 T:0x40983490] OP -   name = "IRAM"
@0,789,004us: [+3 T:0x40983490] OP -   physAddr = 0x5c7f8000
@0,789,004us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x107f8000
@0,789,035us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,789,035us: [+3 T:0x40983490] OP -   size = 0x8000
@0,789,065us: [+3 T:0x40983490] OP -   shared = TRUE
@0,789,065us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,789,065us: [+3 T:0x40983490] OP - entry #5:
@0,789,096us: [+3 T:0x40983490] OP -   entry = 0x5
@0,789,096us: [+3 T:0x40983490] OP -   name = "L1DSRAM"
@0,789,126us: [+3 T:0x40983490] OP -   physAddr = 0x5cf04000
@0,789,126us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x10f04000
@0,789,157us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,789,157us: [+3 T:0x40983490] OP -   size = 0x10000
@0,789,157us: [+3 T:0x40983490] OP -   shared = TRUE
@0,789,187us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,789,187us: [+3 T:0x40983490] OP - entry #6:
@0,789,218us: [+3 T:0x40983490] OP -   entry = 0x6
@0,789,218us: [+3 T:0x40983490] OP -   name = "L1PSRAM"
@0,789,248us: [+3 T:0x40983490] OP -   physAddr = 0x5ce00000
@0,789,248us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x10e00000
@0,789,248us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,789,279us: [+3 T:0x40983490] OP -   size = 0x4000
@0,789,279us: [+3 T:0x40983490] OP -   shared = TRUE
@0,789,309us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,789,309us: [+3 T:0x40983490] OP - entry #7:
@0,789,340us: [+3 T:0x40983490] OP -   entry = 0x7
@0,789,340us: [+3 T:0x40983490] OP -   name = "DDRALGHEAP"
@0,789,340us: [+3 T:0x40983490] OP -   physAddr = 0x86000000
@0,789,370us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x86000000
@0,789,370us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,789,401us: [+3 T:0x40983490] OP -   size = 0x1000000
@0,789,401us: [+3 T:0x40983490] OP -   shared = FALSE
@0,789,431us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,789,431us: [+3 T:0x40983490] OP - entry #8:
@0,789,431us: [+3 T:0x40983490] OP -   entry = 0x8
@0,789,462us: [+3 T:0x40983490] OP -   name = "L4CORE"
@0,789,462us: [+3 T:0x40983490] OP -   physAddr = 0x48000000
@0,789,492us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x48000000
@0,789,492us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,789,523us: [+3 T:0x40983490] OP -   size = 0x1000000
@0,789,523us: [+3 T:0x40983490] OP -   shared = FALSE
@0,789,523us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,789,553us: [+3 T:0x40983490] OP - entry #9:
@0,789,553us: [+3 T:0x40983490] OP -   entry = 0x9
@0,789,584us: [+3 T:0x40983490] OP -   name = "CMEM"
@0,789,584us: [+3 T:0x40983490] OP -   physAddr = 0x83700000
@0,789,614us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x83700000
@0,789,614us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,789,614us: [+3 T:0x40983490] OP -   size = 0x2900000
@0,789,645us: [+3 T:0x40983490] OP -   shared = FALSE
@0,789,645us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,789,676us: [+3 T:0x40983490] OP - 
@0,789,676us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->ipsTables[0][i].
@0,789,676us: [+3 T:0x40983490] OP - entry #0:
@0,789,706us: [+3 T:0x40983490] OP -   name = "IPS"
@0,789,706us: [+3 T:0x40983490] OP -   numIpsEvents = 0x20
@0,789,737us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,789,737us: [+3 T:0x40983490] OP -   gppIntId = 0x1a
@0,789,767us: [+3 T:0x40983490] OP -   dspIntId = 0x37
@0,789,767us: [+3 T:0x40983490] OP -   dspIntVectorId = 0x5
@0,789,798us: [+3 T:0x40983490] OP -   arg1 = 0x2faf080
@0,789,798us: [+3 T:0x40983490] OP -   arg2 = 0x0
@0,789,798us: [+3 T:0x40983490] OP - 
@0,789,828us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->poolTables[0][i].
@0,789,828us: [+3 T:0x40983490] OP - 
@0,789,859us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->dataTables[0][i].
@0,789,859us: [+3 T:0x40983490] OP - entry #0:
@0,789,889us: [+3 T:0x40983490] OP -   name = "ZCPYDATA"
@0,789,889us: [+3 T:0x40983490] OP -   baseChnlId = 0x0
@0,789,889us: [+3 T:0x40983490] OP -   numChannels = 0x10
@0,789,920us: [+3 T:0x40983490] OP -   maxBufSize = 0x4000
@0,789,920us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,789,950us: [+3 T:0x40983490] OP -   poolId = 0x0
@0,789,950us: [+3 T:0x40983490] OP -   queuePerChnl = 0x1
@0,789,981us: [+3 T:0x40983490] OP -   ipsId = 0x0
@0,789,981us: [+3 T:0x40983490] OP -   ipsEventNo = 0x1
@0,789,981us: [+3 T:0x40983490] OP -   arg1 = 0x0
@0,790,011us: [+3 T:0x40983490] OP -   arg2 = 0x0
@0,790,011us: [+3 T:0x40983490] OP - 
@0,790,042us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->mqtObjects->
@0,790,042us: [+3 T:0x40983490] OP -   name = "ZCPYMQT"
@0,790,072us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,790,072us: [+3 T:0x40983490] OP -   maxMsgSize = 0xffffffff
@0,790,072us: [+3 T:0x40983490] OP -   ipsId = 0x0
@0,790,103us: [+3 T:0x40983490] OP -   ipsEventNo = 0x0
@0,790,103us: [+3 T:0x40983490] OP -   arg1 = 0x0
@0,790,133us: [+3 T:0x40983490] OP -   arg2 = 0x0
@0,790,133us: [+3 T:0x40983490] OP - 
@0,790,164us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->ringIoObjects->
@0,790,164us: [+3 T:0x40983490] OP -   name = "RINGIOTABLE"
@0,790,164us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,790,194us: [+3 T:0x40983490] OP -   maxEntries = 0x40
@0,790,194us: [+3 T:0x40983490] OP -   ipsId = 0x0
@0,790,225us: [+3 T:0x40983490] OP -   ipsEventNo = 0x2
@0,790,225us: [+3 T:0x40983490] OP - 
@0,790,255us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->mplistObjects->
@0,790,255us: [+3 T:0x40983490] OP -   name = "MPLISTTABLE"
@0,790,286us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,790,286us: [+3 T:0x40983490] OP -   maxEntries = 0x40
@0,790,286us: [+3 T:0x40983490] OP -   ipsId = 0xffffffff
@0,790,316us: [+3 T:0x40983490] OP -   ipsEventNo = 0xffffffff
@0,790,316us: [+3 T:0x40983490] OP - 
@0,790,347us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->mpcsObjects->
@0,790,347us: [+3 T:0x40983490] OP -   name = "MPCS"
@0,790,377us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,790,377us: [+3 T:0x40983490] OP -   maxEntries = 0x100
@0,790,377us: [+3 T:0x40983490] OP -   ipsId = 0xffffffff
@0,790,408us: [+3 T:0x40983490] OP -   ipsEventNo = 0xffffffff
@0,791,385us: [+2 T:0x40983490] OP - Processor_create_d> Attaching to DSP PROC...
@0,796,298us: [+2 T:0x40983490] OP - Processor_create_d> Opening MSGQ pool...
@0,796,542us: [+2 T:0x40983490] OP - Processor_create_d> Loading cs.x64P on DSP (1 args)...
@0,812,167us: [+2 T:0x40983490] OP - Processor_create_d> Starting DSP PROC...
@0,821,383us: [+2 T:0x40983490] OP - Processor_create_d> Opening remote transport...
@0,821,963us: [+0 T:0x40983490] ti.sdo.ce.ipc.Power - Power_connect> Enter (handle=0x48580)
@0,821,993us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_connect> Calling LPM_connect to connect to the DSP power handler...
@0,822,085us: [+0 T:0x40983490] ti.sdo.ce.ipc.Power - Power_connect> return (0)
@0,822,115us: [+2 T:0x40983490] OP - Processor_create_d> return (1)
@0,822,146us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481d8]
@0,822,176us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481d8]
@0,822,207us: [+0 T:0x40983490] OP - getCmd_d> Enter (proc=0x40982dd8)
@0,822,207us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481c0] timeout[0xffffffff]
@0,822,237us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481d8] status[0]
@0,822,268us: [+0 T:0x4001e320] OP - doCmd> Exit (result=1)
@0,822,298us: [+0 T:0x4001e320] OP - Processor_create> return (0x48558)
@0,822,298us: [+0 T:0x4001e320] CE - rserverOpen('cs.x64P'): 0x47260 done.
@0,822,817us: [+0 T:0x4001e320] CE - checkServer(0x48520)
@0,823,000us: [+0 T:0x4001e320] CE - rmsInit> RMS initialized(0x48520); CE_DEBUG on, setting DSP trace mask to *+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3
@0,823,031us: [+0 T:0x4001e320] CE - Engine_setTrace> Enter(engine=0x48520, mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
@0,823,122us: [+1 T:0x4001e320] CE - Engine_setTrace> Requesting DSP set trace ...
@0,824,160us: [+0 T:0x4001e320] CE - Engine_setTrace> return(0)
@0,824,190us: [+4 T:0x4001e320] CE - Engine_open> engine->server = 0x47260
[DSP] @0x00000302:[T:0x00000000] server - main> Welcome to DSP server's main().
[DSP] @0,005,982tk: [+0 T:0x87856c14] OG - Global_setSpecialTrace> enter(mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
[DSP] @0,006,080tk: [+4 T:0x87856c14] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,006,133tk: [+4 T:0x87856c14] OG -     package ti.targets.rts6000 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/targets/rts6000/) [1, 0, 0, 0]
[DSP] @0,006,212tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegdec (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
[DSP] @0,006,291tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegenc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
[DSP] @0,006,371tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
[DSP] @0,006,449tk: [+4 T:0x87856c14] OG -     package ti.sdo.utils.trace (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
[DSP] @0,006,528tk: [+4 T:0x87856c14] OG -     package ti.xdais (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/) [1, 2.0, 1]
[DSP] @0,006,595tk: [+4 T:0x87856c14] OG -     package ti.rtdx (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/rtdx/) [2, 0, 0, 5]
[DSP] @0,006,663tk: [+4 T:0x87856c14] OG -     package ti.psl (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/psl/) [5, 0, 0, 0]
[DSP] @0,006,729tk: [+4 T:0x87856c14] OG -     package ti.pmi (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/pmi/) [1, 0, 0, 0]
[DSP] @0,006,796tk: [+4 T:0x87856c14] OG -     package ti.pscl (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/pscl/) [1, 0, 0, 0]
[DSP] @0,006,863tk: [+4 T:0x87856c14] OG -     package ti.bios (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/bios/) [5, 2, 5, 28]
[DSP] @0,006,931tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.dskt2 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
[DSP] @0,007,007tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.dman3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
[DSP] @0,007,084tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
[DSP] @0,007,158tk: [+4 T:0x87856c14] OG -     package ti.xdais.dm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/dm/) [1, 0, 5]
[DSP] @0,007,227tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.node (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
[DSP] @0,007,300tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2, 0, 1]
[DSP] @0,007,381tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.utils.xdm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
[DSP] @0,007,457tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.memutils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
[DSP] @0,007,537tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.acpy3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
[DSP] @0,007,614tk: [+4 T:0x87856c14] OG -     package dsplink.dsp (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dsplink_1_65_00_02/dsplink/dsp/) [1, 4, 0]
[DSP] @0,007,680tk: [+4 T:0x87856c14] OG -     package ti.bios.utils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/biosutils_1_02_02/packages/ti/bios/utils/) [2, 0, 2, 02]
[DSP] @0,007,752tk: [+4 T:0x87856c14] OG -     package ti.catalog.c6000 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
[DSP] @0,007,826tk: [+4 T:0x87856c14] OG -     package ti.catalog (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
[DSP] @0,007,895tk: [+4 T:0x87856c14] OG -     package ti.catalog.arm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
[DSP] @0,007,969tk: [+4 T:0x87856c14] OG -     package ti.platforms.evm3530 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
[DSP] @0,008,045tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.osal (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
[DSP] @0,008,118tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.osal.bios (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
[DSP] @0,008,195tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.ipc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
[DSP] @0,008,267tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.ipc.bios (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
[DSP] @0,008,343tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.alg (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
[DSP] @0,008,416tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
[DSP] @0,008,486tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.bioslog (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
[DSP] @0,008,562tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.image1 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
[DSP] @0,008,636tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegdec.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
[DSP] @0,008,718tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegenc.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
[DSP] @0,008,800tk: [+4 T:0x87856c14] OG -     package ti.sdo.server.cs (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/server/cs/) [1, 0, 0]
[DSP] @0,008,875tk: [+0 T:0x87856c14] OG - Global_setSpecialTrace> return
@0,828,951us: [+0 T:0x4001e320] CE - Engine_fwriteTrace> returning count [6949]
@0,829,012us: [+0 T:0x4001e320] CE - Engine_initFromServer(0x48520)
@0,829,043us: [+0 T:0x4001e320] CE - Engine_getNumServerAlgs(0x48520 0xbeba5be0)
@0,829,317us: [+0 T:0x4001e320] CE - Engine_getNumServerAlgs number of server algs = 2
@0,829,317us: [+0 T:0x4001e320] CE - Engine_getNumServerAlgs exit 0
@0,829,348us: [+2 T:0x4001e320] CE - Engine_initFromServer> Number of remote algs statically configured in engine: 2
@0,829,348us: [+2 T:0x4001e320] CE - Engine_initFromServer> Number of statically configured remote algs = number of server algs: 2
@0,829,378us: [+0 T:0x4001e320] CE - Engine_initFromServer> Returning 0
@0,829,378us: [+0 T:0x4001e320] CE - Engine_open> return(296224)
@0,829,440us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x48520, name='jpegenc', params=0x0)
@0,829,440us: [+0 T:0x4001e320] CV - VISA_create(0x48520, 'jpegenc', 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
@0,829,470us: [+0 T:0x4001e320] CV - VISA_create2(0x48520, 'jpegenc', 0x0, 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
@0,829,501us: [+0 T:0x4001e320] CE - Engine_createNode(0x48520, 'jpegenc', 460, 0x0, 0x0, 0xbeba5bd0)
@0,829,531us: [+0 T:0x4001e320] CE - Engine> allocNode Enter(engine=0x48520, impId='jpegenc')
@0,829,562us: [+0 T:0x4001e320] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_1419_1, 0x48a20, NULL)
@0,830,874us: [+4 T:0x4001e320] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x48a40, algName='jpegenc', rmsNode=0x8785b6e8, algHandle=0x8785b7d8)
[DSP] @0,026,865tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,026,918tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b6e8)
[DSP] @0,026,962tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0xa)
[DSP] @0,027,000tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b700)
[DSP] @0,027,049tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,027,089tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b710)
[DSP] @0,027,132tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,027,170tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b730)
[DSP] @0,027,258tk: [+0 T:0x87856c14] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x0, name='jpegenc', params=0x0)
[DSP] @0,027,330tk: [+0 T:0x87856c14] CV - VISA_create(0x0, 'jpegenc', 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
[DSP] @0,027,393tk: [+0 T:0x87856c14] CV - VISA_create2(0x0, 'jpegenc', 0x0, 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
[DSP] @0,027,468tk: [+0 T:0x87856c14] CE - Engine_open> Enter('local', 0x8785a8ec, 0x0)
[DSP] @0,027,520tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x34)
[DSP] @0,027,558tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b7a0)
[DSP] @0,027,612tk: [+4 T:0x87856c14] CE - Engine_open> engine->server = 0x0
[DSP] @0,027,654tk: [+0 T:0x87856c14] CE - Engine_open> return(-2021279840)
[DSP] @0,027,721tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x34)
[DSP] @0,027,760tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b7d8)
[DSP] @0,027,808tk: [+0 T:0x87856c14] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x878a8ecc, idma3Fxns=0x878a9028, iresFxns=0x0, params=0x0, attrs=0x8785aa08)
[DSP] @0,027,894tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,027,932tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b810)
[DSP] @0,028,395tk: [+0 T:0x87856c14] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8785b810)
[DSP] @0,028,449tk: [+5 T:0x87856c14] CV - VISA_create> local codec created (name='jpegenc', handle=0x8785b810)
[DSP] @0,028,511tk: [+0 T:0x87856c14] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x8785b7d8)
[DSP] @0,028,569tk: [+4 T:0x87856c14] OT - Thread_create > name: "jpegenc#0", pri:  -1, stack size:  16384, stack seg: 0
@0,832,461us: [+0 T:0x4001e320] CE - Engine_fwriteTrace> returning count [2261]
@0,832,491us: [+2 T:0x4001e320] CE - Engine_createNode> Returning 0x48a18
@0,832,552us: [+5 T:0x4001e320] CV - VISA_create> remote codec created (name='jpegenc', localQueueID=0x10001, remoteQueueID=0x0002)
@0,832,583us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x489d0)
@0,832,644us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(14400) = 0x41201000.
@0,832,674us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41201000) = 0x85ffc000.
@0,832,705us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(7200) = 0x41205000.
@0,832,735us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41205000) = 0x85ff6000.
@0,832,766us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(7200) = 0x41207000.
@0,832,796us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41207000) = 0x85ff4000.
@0,832,827us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(14400) = 0x41209000.
@0,832,858us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41209000) = 0x85ff8000.
Reading file
Encoding image...
encoder address: 489d0
encDynParams address: beba5c14
encStatus address: beba5b74
@5,834,994us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x489d0, id=1, dynParams=0xbeba5c14 (size=0x20), status=0xbeba5b74 (size=0xa0)
@5,835,085us: [+4 T:0x4001e320] CV - VISA_getMaxMsgSize(0x489d0): returning 0x1000
@5,835,116us: [+5 T:0x4001e320] CV - VISA_allocMsg> Allocating message for messageId=0x00021815
@5,856,295us: [+5 T:0x4001e320] CV - VISA_freeMsg(0x489d0, 0x41191880): Freeing message with messageId=0x00021815
@5,856,417us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x489d0, retVal=0xffffffff)
Error (-1), Extended Error (0) in image Encoder Control:setparams
Encoding error
@5,860,690us: [+0 T:0x4001e320] OP - doCmd> Enter (cmdId=3, proc=0x0)
@5,860,903us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481c0]
@5,861,025us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481c0] status[0]
@5,861,056us: [+0 T:0x40983490] OP - getCmd_d> Exit (result=3)
@5,861,086us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481d8]
@5,861,086us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481d8]
@5,861,331us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481c0]
@5,861,392us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481d8] timeout[0xffffffff]
@5,861,483us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481d8] status[0]
@5,861,575us: [+0 T:0x4001e320] OP - doCmd> Exit (result=1)
@5,861,666us: [+0 T:0x4001e320] OT - Thread_delete> Enter (task=0x48210)
@5,861,758us: [+4 T:0x4001e320] OT - Thread_delete> pthread_cancel (0x3)
@5,861,849us: [+4 T:0x4001e320] OT - Thread_delete> pthread_join (0x0)
@5,861,910us: [+0 T:0x4001e320] OT - Thread_delete> Exit (task=0x48210)
@5,862,002us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x481c0]
@5,862,063us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@5,862,124us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x481d8]
@5,862,185us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_delete>

@0,803,988us: [+4 T:0x4001e320] OG - Global_init> This program was built with the following packages:
@0,804,446us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegdec (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
@0,804,568us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegenc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
@0,804,659us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
@0,804,720us: [+4 T:0x4001e320] OG -     package ti.xdais.dm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/dm/) [1, 0, 5]
@0,804,781us: [+4 T:0x4001e320] OG -     package ti.xdais (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/) [1, 2.0, 1]
@0,804,873us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.node (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
@0,804,934us: [+4 T:0x4001e320] OG -     package ti.sdo.utils.trace (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
@0,804,995us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.utils.xdm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
@0,805,056us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
@0,805,148us: [+4 T:0x4001e320] OG -     package ti.sdo.linuxutils.cmem (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/linuxutils_2_25_05_11/packages/ti/sdo/linuxutils/cmem/) [2, 2, 0]
@0,805,209us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.memutils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
@0,805,300us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.utils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/utils/) [1, 0, 2]
@0,805,361us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.dman3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
@0,805,422us: [+4 T:0x4001e320] OG -     package ti.sdo.fc.acpy3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
@0,805,483us: [+4 T:0x4001e320] OG -     package gnu.targets (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/gnu/targets/) [1, 0, 1]
@0,805,544us: [+4 T:0x4001e320] OG -     package gnu.targets.arm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/gnu/targets/arm/) [1, 0, 0, 0]
@0,805,605us: [+4 T:0x4001e320] OG -     package dsplink.gpp (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dsplink_1_65_00_02/dsplink/gpp/) [5, 0, 0]
@0,805,666us: [+4 T:0x4001e320] OG -     package ti.bios.power (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/local-power-manager_1_24_02_09/packages/ti/bios/power/) [1, 1, 1]
@0,805,758us: [+4 T:0x4001e320] OG -     package ti.catalog.arm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
@0,805,819us: [+4 T:0x4001e320] OG -     package ti.catalog (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
@0,805,880us: [+4 T:0x4001e320] OG -     package ti.catalog.c6000 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
@0,805,941us: [+4 T:0x4001e320] OG -     package ti.platforms.evm3530 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
@0,806,002us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.osal (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
@0,806,063us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.ipc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
@0,806,124us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.osal.linux (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
@0,806,124us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.ipc.dsplink (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
@0,806,155us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.alg (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
@0,806,155us: [+4 T:0x4001e320] OG -     package ti.sdo.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
@0,806,185us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.image1 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
@0,806,185us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegdec.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
@0,806,216us: [+4 T:0x4001e320] OG -     package ti.sdo.codecs.jpegenc.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
@0,806,216us: [+4 T:0x4001e320] OG -     package ti.sdo.ce.examples.apps.image1_copy (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/examples/ti/sdo/ce/examples/apps/image1_copy/) [1, 0, 0]
@0,806,429us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,806,460us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x481c0]
@0,806,490us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,806,490us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x481d8]
@0,806,521us: [+0 T:0x4001e320] OT - Thread_create> Enter (fxn=0x16ebc, attrs=0x0)
@0,806,735us: [+0 T:0x4001e320] OT - Thread_create> Exit (task=0x48210)
@0,806,796us: [+0 T:0x4001e320] ti.sdo.ce.alg - ALG_init> Enter
@0,806,826us: [+0 T:0x4001e320] ti.sdo.ce.alg - ALG_init> Exit
@0,806,857us: [+6 T:0x4001e320] CE - Engine_init> CE debugging on (CE_DEBUG=2; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@0,806,918us: [+0 T:0x4001e320] CS - Server_init()
@0,806,918us: [+0 T:0x4001e320] CS - Server_init> Global_useLinkArbiter = 0
@0,806,948us: [+2 T:0x4001e320] ti.sdo.ce.examples.apps.image1_copy - main> ti.sdo.ce.examples.apps.image1_copy
@0,806,979us: [+0 T:0x4001e320] CE - Engine_open> Enter('image1_copy', 0x0, 0xbea08c44)
@0,807,009us: [+0 T:0x4001e320] CE - rserverOpen('cs.x64P'), count = 0
@0,807,040us: [+0 T:0x4001e320] OP - Processor_create> Enter(imageName='cs.x64P', linkCfg='(null)', attrs=0xbea08c28)
@0,807,131us: [+0 T:0x4001e320] OP - doCmd> Enter (cmdId=1, proc=0x48558)
@0,807,162us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481c0]
@0,807,192us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481c0]
@0,807,223us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481d8] timeout[0xffffffff]
@0,807,314us: [+1 T:0x40983490] OP - daemon> thread created.
@0,807,314us: [+0 T:0x40983490] OP - getCmd_d> Enter (proc=0x40982dd8)
@0,807,345us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481c0] timeout[0xffffffff]
@0,807,345us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481c0] status[0]
@0,807,375us: [+0 T:0x40983490] OP - getCmd_d> Exit (result=1)
@0,807,375us: [+0 T:0x40983490] OP - Processor_create_d> Enter(proc=0x48558)
@0,807,406us: [+0 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> Enter(handle=0x48574)
@0,807,406us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> Opening Local Power Manager for the DSP on /dev/lpm0...
@0,807,498us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> Turning on DSP power...
@0,807,620us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_on> return (0)
@0,807,650us: [+2 T:0x40983490] OP - Processor_create_d> Initializing DSP PROC...
@0,807,650us: [+2 T:0x40983490] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'cs.x64P']
@0,807,681us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x87800000, sizeInBytes=0x600000, shared=1, syncd=0
@0,807,711us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x87e00000, sizeInBytes=0x100000, shared=1, syncd=0
@0,807,742us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x87f00000, sizeInBytes=0x1000, shared=1, syncd=0
@0,807,742us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='L4PER', startAddress=0x49000000, sizeInBytes=0x100000, shared=0, syncd=0
@0,807,772us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #4 to Link configuration: name='IRAM', startAddress=0x5c7f8000, sizeInBytes=0x8000, shared=1, syncd=0
@0,807,772us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #5 to Link configuration: name='L1DSRAM', startAddress=0x5cf04000, sizeInBytes=0x10000, shared=1, syncd=0
@0,807,803us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #6 to Link configuration: name='L1PSRAM', startAddress=0x5ce00000, sizeInBytes=0x4000, shared=1, syncd=0
@0,807,833us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #7 to Link configuration: name='DDRALGHEAP', startAddress=0x86000000, sizeInBytes=0x1000000, shared=0, syncd=0
@0,807,833us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #8 to Link configuration: name='L4CORE', startAddress=0x48000000, sizeInBytes=0x1000000, shared=0, syncd=0
@0,807,864us: [+2 T:0x40983490] OP - Processor_create_d> Found 'CMEM' entry, adjusting base and size according to CMEM_getBlock()
@0,807,864us: [+0 T:0x40983490] OP - Processor_create_d> Setting CMEM base to 0x83700000, size to 0x2900000
@0,807,894us: [+2 T:0x40983490] OP - Processor_create_d> Adding DSP segment #9 to Link configuration: name='CMEM', startAddress=0x83700000, sizeInBytes=0x2900000, shared=0, syncd=0
@0,807,925us: [+2 T:0x40983490] OP - Processor_create_d> DODSPCTRL was=0; now=0
@0,807,925us: [+3 T:0x40983490] OP - LINKCFG_Object generated for PROC_setup(0x46a50) ...
@0,807,955us: [+3 T:0x40983490] OP - linkCfg->gppObject->
@0,807,986us: [+3 T:0x40983490] OP -   name = "ARM9"
@0,807,986us: [+3 T:0x40983490] OP -   maxMsgqs = 0x82
@0,807,986us: [+3 T:0x40983490] OP -   maxChnlQueue = 0x10
@0,808,047us: [+3 T:0x40983490] OP -   poolTableId = 0xffffffff
@0,808,047us: [+3 T:0x40983490] OP -   numPools = 0x0
@0,808,077us: [+3 T:0x40983490] OP - 
@0,808,077us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->dspObject->
@0,808,077us: [+3 T:0x40983490] OP -   name = "OMAP3530"
@0,808,108us: [+3 T:0x40983490] OP -   dspArch = 0x2
@0,808,108us: [+3 T:0x40983490] OP -   loaderName = "COFF"
@0,808,138us: [+3 T:0x40983490] OP -   autoStart = FALSE
@0,808,138us: [+3 T:0x40983490] OP -   execName = "DEFAULT.OUT"
@0,808,169us: [+3 T:0x40983490] OP -   doDspCtrl = DSP_BootMode_Boot_NoPwr
@0,808,169us: [+3 T:0x40983490] OP -   resumeAddr = 0x87f00020
@0,808,169us: [+3 T:0x40983490] OP -   resetVector = 0x87f00000
@0,808,199us: [+3 T:0x40983490] OP -   resetCodeSize = 0x1000
@0,808,199us: [+3 T:0x40983490] OP -   maduSize = 0x1
@0,808,230us: [+3 T:0x40983490] OP -   cpuFreq = 0x6ddd0
@0,808,230us: [+3 T:0x40983490] OP -   endian = 0x3
@0,808,260us: [+3 T:0x40983490] OP -   wordSwap = 0x0
@0,808,260us: [+3 T:0x40983490] OP -   memTableId = 0x0
@0,808,291us: [+3 T:0x40983490] OP -   memEntries = 0xa
@0,808,291us: [+3 T:0x40983490] OP -   linkDrvId = 0x0
@0,808,291us: [+3 T:0x40983490] OP -   arg1 = 0xffffffff
@0,808,322us: [+3 T:0x40983490] OP -   arg2 = 0xffffffff
@0,808,322us: [+3 T:0x40983490] OP -   arg3 = 0x0
@0,808,352us: [+3 T:0x40983490] OP -   arg4 = 0x0
@0,808,352us: [+3 T:0x40983490] OP -   arg5 = 0xffffffff
@0,808,383us: [+3 T:0x40983490] OP - 
@0,808,383us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->linkDrvObjects->
@0,808,383us: [+3 T:0x40983490] OP -   name = "SHMDRV"
@0,808,413us: [+3 T:0x40983490] OP -   hshkPollCount = 0x989680
@0,808,413us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,808,444us: [+3 T:0x40983490] OP -   ipsTableId = 0x0
@0,808,444us: [+3 T:0x40983490] OP -   numIpsEntries = 0x1
@0,808,474us: [+3 T:0x40983490] OP -   poolTableId = 0x0
@0,808,474us: [+3 T:0x40983490] OP -   numPools = 0x1
@0,808,505us: [+3 T:0x40983490] OP -   dataTableId = 0x0
@0,808,505us: [+3 T:0x40983490] OP -   numDataDrivers = 0x1
@0,808,535us: [+3 T:0x40983490] OP -   mqtId = 0x0
@0,808,535us: [+3 T:0x40983490] OP -   ringIoTableId = 0x0
@0,808,535us: [+3 T:0x40983490] OP -   mplistTableId = 0x0
@0,808,566us: [+3 T:0x40983490] OP -   mpcsTableId = 0x0
@0,808,566us: [+3 T:0x40983490] OP - 
@0,808,596us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->memTables[0][i].
@0,808,596us: [+3 T:0x40983490] OP - entry #0:
@0,808,627us: [+3 T:0x40983490] OP -   entry = 0x0
@0,808,627us: [+3 T:0x40983490] OP -   name = "DDR2"
@0,808,627us: [+3 T:0x40983490] OP -   physAddr = 0x87800000
@0,808,657us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x87800000
@0,808,657us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,808,688us: [+3 T:0x40983490] OP -   size = 0x600000
@0,808,688us: [+3 T:0x40983490] OP -   shared = TRUE
@0,808,718us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,808,718us: [+3 T:0x40983490] OP - entry #1:
@0,808,718us: [+3 T:0x40983490] OP -   entry = 0x1
@0,808,749us: [+3 T:0x40983490] OP -   name = "DSPLINKMEM"
@0,808,749us: [+3 T:0x40983490] OP -   physAddr = 0x87e00000
@0,808,779us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x87e00000
@0,808,779us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,808,810us: [+3 T:0x40983490] OP -   size = 0x100000
@0,808,810us: [+3 T:0x40983490] OP -   shared = TRUE
@0,808,810us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,808,840us: [+3 T:0x40983490] OP - entry #2:
@0,808,840us: [+3 T:0x40983490] OP -   entry = 0x2
@0,808,871us: [+3 T:0x40983490] OP -   name = "RESET_VECTOR"
@0,808,871us: [+3 T:0x40983490] OP -   physAddr = 0x87f00000
@0,808,901us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x87f00000
@0,808,901us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,808,901us: [+3 T:0x40983490] OP -   size = 0x1000
@0,808,932us: [+3 T:0x40983490] OP -   shared = TRUE
@0,808,932us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,808,962us: [+3 T:0x40983490] OP - entry #3:
@0,808,993us: [+3 T:0x40983490] OP -   entry = 0x3
@0,808,993us: [+3 T:0x40983490] OP -   name = "L4PER"
@0,808,993us: [+3 T:0x40983490] OP -   physAddr = 0x49000000
@0,809,023us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x49000000
@0,809,023us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,809,054us: [+3 T:0x40983490] OP -   size = 0x100000
@0,809,054us: [+3 T:0x40983490] OP -   shared = FALSE
@0,809,084us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,809,084us: [+3 T:0x40983490] OP - entry #4:
@0,809,115us: [+3 T:0x40983490] OP -   entry = 0x4
@0,809,207us: [+3 T:0x40983490] OP -   name = "IRAM"
@0,809,207us: [+3 T:0x40983490] OP -   physAddr = 0x5c7f8000
@0,809,237us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x107f8000
@0,809,237us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,809,268us: [+3 T:0x40983490] OP -   size = 0x8000
@0,809,268us: [+3 T:0x40983490] OP -   shared = TRUE
@0,809,298us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,809,298us: [+3 T:0x40983490] OP - entry #5:
@0,809,298us: [+3 T:0x40983490] OP -   entry = 0x5
@0,809,329us: [+3 T:0x40983490] OP -   name = "L1DSRAM"
@0,809,329us: [+3 T:0x40983490] OP -   physAddr = 0x5cf04000
@0,809,359us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x10f04000
@0,809,359us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,809,390us: [+3 T:0x40983490] OP -   size = 0x10000
@0,809,390us: [+3 T:0x40983490] OP -   shared = TRUE
@0,809,390us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,809,420us: [+3 T:0x40983490] OP - entry #6:
@0,809,420us: [+3 T:0x40983490] OP -   entry = 0x6
@0,809,451us: [+3 T:0x40983490] OP -   name = "L1PSRAM"
@0,809,451us: [+3 T:0x40983490] OP -   physAddr = 0x5ce00000
@0,809,481us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x10e00000
@0,809,481us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,809,512us: [+3 T:0x40983490] OP -   size = 0x4000
@0,809,512us: [+3 T:0x40983490] OP -   shared = TRUE
@0,809,512us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,809,542us: [+3 T:0x40983490] OP - entry #7:
@0,809,542us: [+3 T:0x40983490] OP -   entry = 0x7
@0,809,573us: [+3 T:0x40983490] OP -   name = "DDRALGHEAP"
@0,809,573us: [+3 T:0x40983490] OP -   physAddr = 0x86000000
@0,809,603us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x86000000
@0,809,603us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,809,603us: [+3 T:0x40983490] OP -   size = 0x1000000
@0,809,634us: [+3 T:0x40983490] OP -   shared = FALSE
@0,809,634us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,809,664us: [+3 T:0x40983490] OP - entry #8:
@0,809,664us: [+3 T:0x40983490] OP -   entry = 0x8
@0,809,695us: [+3 T:0x40983490] OP -   name = "L4CORE"
@0,809,695us: [+3 T:0x40983490] OP -   physAddr = 0x48000000
@0,809,725us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x48000000
@0,809,725us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,809,725us: [+3 T:0x40983490] OP -   size = 0x1000000
@0,809,756us: [+3 T:0x40983490] OP -   shared = FALSE
@0,809,756us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,809,786us: [+3 T:0x40983490] OP - entry #9:
@0,809,786us: [+3 T:0x40983490] OP -   entry = 0x9
@0,809,817us: [+3 T:0x40983490] OP -   name = "CMEM"
@0,809,817us: [+3 T:0x40983490] OP -   physAddr = 0x83700000
@0,809,817us: [+3 T:0x40983490] OP -   dspVirtAddr = 0x83700000
@0,809,847us: [+3 T:0x40983490] OP -   gppVirtAddr = 0xffffffff
@0,809,847us: [+3 T:0x40983490] OP -   size = 0x2900000
@0,809,878us: [+3 T:0x40983490] OP -   shared = FALSE
@0,809,878us: [+3 T:0x40983490] OP -   syncd = FALSE
@0,809,908us: [+3 T:0x40983490] OP - 
@0,809,908us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->ipsTables[0][i].
@0,809,939us: [+3 T:0x40983490] OP - entry #0:
@0,809,969us: [+3 T:0x40983490] OP -   name = "IPS"
@0,809,969us: [+3 T:0x40983490] OP -   numIpsEvents = 0x20
@0,809,969us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,810,000us: [+3 T:0x40983490] OP -   gppIntId = 0x1a
@0,810,000us: [+3 T:0x40983490] OP -   dspIntId = 0x37
@0,810,030us: [+3 T:0x40983490] OP -   dspIntVectorId = 0x5
@0,810,030us: [+3 T:0x40983490] OP -   arg1 = 0x2faf080
@0,810,061us: [+3 T:0x40983490] OP -   arg2 = 0x0
@0,810,061us: [+3 T:0x40983490] OP - 
@0,810,092us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->poolTables[0][i].
@0,810,092us: [+3 T:0x40983490] OP - 
@0,810,092us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->dataTables[0][i].
@0,810,122us: [+3 T:0x40983490] OP - entry #0:
@0,810,122us: [+3 T:0x40983490] OP -   name = "ZCPYDATA"
@0,810,153us: [+3 T:0x40983490] OP -   baseChnlId = 0x0
@0,810,153us: [+3 T:0x40983490] OP -   numChannels = 0x10
@0,810,183us: [+3 T:0x40983490] OP -   maxBufSize = 0x4000
@0,810,183us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,810,214us: [+3 T:0x40983490] OP -   poolId = 0x0
@0,810,214us: [+3 T:0x40983490] OP -   queuePerChnl = 0x1
@0,810,214us: [+3 T:0x40983490] OP -   ipsId = 0x0
@0,810,244us: [+3 T:0x40983490] OP -   ipsEventNo = 0x1
@0,810,244us: [+3 T:0x40983490] OP -   arg1 = 0x0
@0,810,275us: [+3 T:0x40983490] OP -   arg2 = 0x0
@0,810,275us: [+3 T:0x40983490] OP - 
@0,810,305us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->mqtObjects->
@0,810,305us: [+3 T:0x40983490] OP -   name = "ZCPYMQT"
@0,810,305us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,810,336us: [+3 T:0x40983490] OP -   maxMsgSize = 0xffffffff
@0,810,336us: [+3 T:0x40983490] OP -   ipsId = 0x0
@0,810,366us: [+3 T:0x40983490] OP -   ipsEventNo = 0x0
@0,810,366us: [+3 T:0x40983490] OP -   arg1 = 0x0
@0,810,397us: [+3 T:0x40983490] OP -   arg2 = 0x0
@0,810,397us: [+3 T:0x40983490] OP - 
@0,810,397us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->ringIoObjects->
@0,810,427us: [+3 T:0x40983490] OP -   name = "RINGIOTABLE"
@0,810,427us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,810,458us: [+3 T:0x40983490] OP -   maxEntries = 0x40
@0,810,458us: [+3 T:0x40983490] OP -   ipsId = 0x0
@0,810,488us: [+3 T:0x40983490] OP -   ipsEventNo = 0x2
@0,810,488us: [+3 T:0x40983490] OP - 
@0,810,519us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->mplistObjects->
@0,810,519us: [+3 T:0x40983490] OP -   name = "MPLISTTABLE"
@0,810,519us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,810,549us: [+3 T:0x40983490] OP -   maxEntries = 0x40
@0,810,549us: [+3 T:0x40983490] OP -   ipsId = 0xffffffff
@0,810,580us: [+3 T:0x40983490] OP -   ipsEventNo = 0xffffffff
@0,810,580us: [+3 T:0x40983490] OP - 
@0,810,610us: [+3 T:0x40983490] OP - linkCfg->dspConfigs[0]->mpcsObjects->
@0,810,610us: [+3 T:0x40983490] OP -   name = "MPCS"
@0,810,610us: [+3 T:0x40983490] OP -   memEntry = 0x1
@0,810,641us: [+3 T:0x40983490] OP -   maxEntries = 0x100
@0,810,641us: [+3 T:0x40983490] OP -   ipsId = 0xffffffff
@0,810,671us: [+3 T:0x40983490] OP -   ipsEventNo = 0xffffffff
@0,811,617us: [+2 T:0x40983490] OP - Processor_create_d> Attaching to DSP PROC...
@0,815,341us: [+2 T:0x40983490] OP - Processor_create_d> Opening MSGQ pool...
@0,815,615us: [+2 T:0x40983490] OP - Processor_create_d> Loading cs.x64P on DSP (1 args)...
@0,830,203us: [+2 T:0x40983490] OP - Processor_create_d> Starting DSP PROC...
@0,839,419us: [+2 T:0x40983490] OP - Processor_create_d> Opening remote transport...
@0,840,029us: [+0 T:0x40983490] ti.sdo.ce.ipc.Power - Power_connect> Enter (handle=0x48580)
@0,840,090us: [+2 T:0x40983490] ti.sdo.ce.ipc.Power - Power_connect> Calling LPM_connect to connect to the DSP power handler...
@0,840,151us: [+0 T:0x40983490] ti.sdo.ce.ipc.Power - Power_connect> return (0)
@0,840,182us: [+2 T:0x40983490] OP - Processor_create_d> return (1)
@0,840,182us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481d8]
@0,840,273us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481d8] status[0]
@0,840,304us: [+0 T:0x4001e320] OP - doCmd> Exit (result=1)
@0,840,304us: [+0 T:0x4001e320] OP - Processor_create> return (0x48558)
@0,840,334us: [+0 T:0x4001e320] CE - rserverOpen('cs.x64P'): 0x47260 done.
@0,841,097us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481d8]
@0,841,189us: [+0 T:0x40983490] OP - getCmd_d> Enter (proc=0x40982dd8)
@0,841,219us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481c0] timeout[0xffffffff]
@0,841,311us: [+0 T:0x4001e320] CE - checkServer(0x48520)
@0,841,647us: [+0 T:0x4001e320] CE - rmsInit> RMS initialized(0x48520); CE_DEBUG on, setting DSP trace mask to *+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3
@0,841,677us: [+0 T:0x4001e320] CE - Engine_setTrace> Enter(engine=0x48520, mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
@0,841,769us: [+1 T:0x4001e320] CE - Engine_setTrace> Requesting DSP set trace ...
@0,842,898us: [+0 T:0x4001e320] CE - Engine_setTrace> return(0)
@0,842,928us: [+4 T:0x4001e320] CE - Engine_open> engine->server = 0x47260
[DSP] @0x00000304:[T:0x00000000] server - main> Welcome to DSP server's main().
[DSP] @0,007,929tk: [+0 T:0x87856c14] OG - Global_setSpecialTrace> enter(mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
[DSP] @0,008,025tk: [+4 T:0x87856c14] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,008,078tk: [+4 T:0x87856c14] OG -     package ti.targets.rts6000 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/targets/rts6000/) [1, 0, 0, 0]
[DSP] @0,008,156tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegdec (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
[DSP] @0,008,236tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegenc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
[DSP] @0,008,315tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
[DSP] @0,008,393tk: [+4 T:0x87856c14] OG -     package ti.sdo.utils.trace (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
[DSP] @0,008,472tk: [+4 T:0x87856c14] OG -     package ti.xdais (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/) [1, 2.0, 1]
[DSP] @0,008,539tk: [+4 T:0x87856c14] OG -     package ti.rtdx (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/rtdx/) [2, 0, 0, 5]
[DSP] @0,008,607tk: [+4 T:0x87856c14] OG -     package ti.psl (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/psl/) [5, 0, 0, 0]
[DSP] @0,008,673tk: [+4 T:0x87856c14] OG -     package ti.pmi (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/pmi/) [1, 0, 0, 0]
[DSP] @0,008,739tk: [+4 T:0x87856c14] OG -     package ti.pscl (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/pscl/) [1, 0, 0, 0]
[DSP] @0,008,806tk: [+4 T:0x87856c14] OG -     package ti.bios (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/bios/) [5, 2, 5, 28]
[DSP] @0,008,874tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.dskt2 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
[DSP] @0,008,950tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.dman3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
[DSP] @0,009,028tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.global (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
[DSP] @0,009,102tk: [+4 T:0x87856c14] OG -     package ti.xdais.dm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/dm/) [1, 0, 5]
[DSP] @0,009,170tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.node (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
[DSP] @0,009,243tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.ipc.dsplink.dsp (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2, 0, 1]
[DSP] @0,009,324tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.utils.xdm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
[DSP] @0,009,401tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.memutils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
[DSP] @0,009,481tk: [+4 T:0x87856c14] OG -     package ti.sdo.fc.acpy3 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
[DSP] @0,009,558tk: [+4 T:0x87856c14] OG -     package dsplink.dsp (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/dsplink_1_65_00_02/dsplink/dsp/) [1, 4, 0]
[DSP] @0,009,624tk: [+4 T:0x87856c14] OG -     package ti.bios.utils (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/biosutils_1_02_02/packages/ti/bios/utils/) [2, 0, 2, 02]
[DSP] @0,009,696tk: [+4 T:0x87856c14] OG -     package ti.catalog.c6000 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
[DSP] @0,009,770tk: [+4 T:0x87856c14] OG -     package ti.catalog (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
[DSP] @0,009,839tk: [+4 T:0x87856c14] OG -     package ti.catalog.arm (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
[DSP] @0,009,913tk: [+4 T:0x87856c14] OG -     package ti.platforms.evm3530 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
[DSP] @0,009,989tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.osal (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
[DSP] @0,010,062tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.osal.bios (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
[DSP] @0,010,159tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.ipc (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
[DSP] @0,010,231tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.ipc.bios (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
[DSP] @0,010,308tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.alg (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
[DSP] @0,010,381tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
[DSP] @0,010,451tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.bioslog (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
[DSP] @0,010,527tk: [+4 T:0x87856c14] OG -     package ti.sdo.ce.image1 (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
[DSP] @0,010,602tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegdec.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
[DSP] @0,010,684tk: [+4 T:0x87856c14] OG -     package ti.sdo.codecs.jpegenc.ce (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
[DSP] @0,010,766tk: [+4 T:0x87856c14] OG -     package ti.sdo.server.cs (/home/engin/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/server/cs/) [1, 0, 0]
[DSP] @0,010,841tk: [+0 T:0x87856c14] OG - Global_setSpecialTrace> return
@0,847,567us: [+0 T:0x4001e320] CE - Engine_fwriteTrace> returning count [6949]
@0,847,567us: [+0 T:0x4001e320] CE - Engine_initFromServer(0x48520)
@0,847,598us: [+0 T:0x4001e320] CE - Engine_getNumServerAlgs(0x48520 0xbea08be0)
@0,847,872us: [+0 T:0x4001e320] CE - Engine_getNumServerAlgs number of server algs = 2
@0,847,872us: [+0 T:0x4001e320] CE - Engine_getNumServerAlgs exit 0
@0,847,903us: [+2 T:0x4001e320] CE - Engine_initFromServer> Number of remote algs statically configured in engine: 2
@0,847,903us: [+2 T:0x4001e320] CE - Engine_initFromServer> Number of statically configured remote algs = number of server algs: 2
@0,847,933us: [+0 T:0x4001e320] CE - Engine_initFromServer> Returning 0
@0,847,933us: [+0 T:0x4001e320] CE - Engine_open> return(296224)
@0,847,964us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x48520, name='jpegenc', params=0x0)
@0,847,994us: [+0 T:0x4001e320] CV - VISA_create(0x48520, 'jpegenc', 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
@0,848,025us: [+0 T:0x4001e320] CV - VISA_create2(0x48520, 'jpegenc', 0x0, 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
@0,848,055us: [+0 T:0x4001e320] CE - Engine_createNode(0x48520, 'jpegenc', 460, 0x0, 0x0, 0xbea08bd0)
@0,848,086us: [+0 T:0x4001e320] CE - Engine> allocNode Enter(engine=0x48520, impId='jpegenc')
@0,848,147us: [+0 T:0x4001e320] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_1501_1, 0x48a20, NULL)
@0,849,246us: [+4 T:0x4001e320] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x48a40, algName='jpegenc', rmsNode=0x8785b6e8, algHandle=0x8785b7d8)
[DSP] @0,028,682tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,028,734tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b6e8)
[DSP] @0,028,778tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0xa)
[DSP] @0,028,815tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b700)
[DSP] @0,028,867tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,028,906tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b710)
[DSP] @0,028,950tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,028,988tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b730)
[DSP] @0,029,075tk: [+0 T:0x87856c14] ti.sdo.ce.image1.IMGENC1 - IMGENC1_create> Enter (engine=0x0, name='jpegenc', params=0x0)
[DSP] @0,029,146tk: [+0 T:0x87856c14] CV - VISA_create(0x0, 'jpegenc', 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
[DSP] @0,029,210tk: [+0 T:0x87856c14] CV - VISA_create2(0x0, 'jpegenc', 0x0, 0x0, 0x460, 'ti.sdo.ce.image1.IIMGENC1')
[DSP] @0,029,285tk: [+0 T:0x87856c14] CE - Engine_open> Enter('local', 0x8785a8ec, 0x0)
[DSP] @0,029,336tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x34)
[DSP] @0,029,374tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b7a0)
[DSP] @0,029,426tk: [+4 T:0x87856c14] CE - Engine_open> engine->server = 0x0
[DSP] @0,029,468tk: [+0 T:0x87856c14] CE - Engine_open> return(-2021279840)
[DSP] @0,029,534tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x34)
[DSP] @0,029,573tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b7d8)
[DSP] @0,029,619tk: [+0 T:0x87856c14] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x878a8ecc, idma3Fxns=0x878a9028, iresFxns=0x0, params=0x0, attrs=0x8785aa08)
[DSP] @0,029,705tk: [+0 T:0x87856c14] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,029,743tk: [+0 T:0x87856c14] OM - Memory_alloc> return (0x8785b810)
[DSP] @0,030,167tk: [+0 T:0x87856c14] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8785b810)
[DSP] @0,030,220tk: [+5 T:0x87856c14] CV - VISA_create> local codec created (name='jpegenc', handle=0x8785b810)
[DSP] @0,030,281tk: [+0 T:0x87856c14] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x8785b7d8)
[DSP] @0,030,337tk: [+4 T:0x87856c14] OT - Thread_create > name: "jpegenc#0", pri:  -1, stack size:  16384, stack seg: 0
@0,850,710us: [+0 T:0x4001e320] CE - Engine_fwriteTrace> returning count [2261]
@0,850,710us: [+2 T:0x4001e320] CE - Engine_createNode> Returning 0x48a18
@0,850,741us: [+5 T:0x4001e320] CV - VISA_create> remote codec created (name='jpegenc', localQueueID=0x10001, remoteQueueID=0x0002)
@0,850,771us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC_create> return (0x489d0)
@0,850,832us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(14400) = 0x41201000.
@0,850,863us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41201000) = 0x85ffc000.
@0,850,924us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(7200) = 0x41205000.
@0,850,954us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41205000) = 0x85ff6000.
@0,850,985us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(7200) = 0x41207000.
@0,850,985us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41207000) = 0x85ff4000.
@0,851,016us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_alloc(14400) = 0x41209000.
@0,851,046us: [+4 T:0x4001e320] OM - Memory_contigAlloc> CMEM_getPhys(0x41209000) = 0x85ff8000.
Reading file
Encoding image...
encoder address: 489d0
encDynParams address: bea08c38
encStatus address: bea08b98
@5,853,061us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x489d0, id=1, dynParams=0xbea08c38 (size=0x20), status=0xbea08b98 (size=0xa0)
@5,853,153us: [+4 T:0x4001e320] CV - VISA_getMaxMsgSize(0x489d0): returning 0x1000
@5,853,183us: [+5 T:0x4001e320] CV - VISA_allocMsg> Allocating message for messageId=0x00021819
@5,853,183us: [+0 T:0x4001e320] CV - VISA_call(visa=0x489d0, msg=0x41191880): messageId=0x00021819, command=0x1
[DSP] @15,669,113tk: [+5 T:0x8785bc54] CN - NODE> 0x8785b710(jpegenc#0) call(algHandle=0x8785b7d8, msg=0x87e04880); messageId=0x00021819
[DSP] @15,669,221tk: [+0 T:0x8785bc54] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x8785b7d8, id=1, dynParams=0x87e048b4 (size=0x20), status=0x87e048d4 (size=0xa0)
[DSP] @15,669,340tk: [+5 T:0x8785bc54] CV - VISA_enter(visa=0x8785b7d8): algHandle = 0x8785b810
[DSP] @15,669,397tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8785b810)
[DSP] @15,669,462tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @15,669,634tk: [+5 T:0x8785bc54] CV - VISA_exit(visa=0x8785b7d8): algHandle = 0x8785b810
[DSP] @15,669,690tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8785b810)
[DSP] @15,669,749tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @15,669,797tk: [+0 T:0x8785bc54] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x8785b7d8, retVal=0x0)
[DSP] @15,669,859tk: [+5 T:0x8785bc54] CN - NODE> returned from call(algHandle=0x8785b7d8, msg=0x87e04880); messageId=0x00021819
@5,854,679us: [+0 T:0x4001e320] CE - Engine_fwriteTrace> returning count [1154]
@5,854,709us: [+0 T:0x4001e320] CV - VISA_call Completed: messageId=0x00021819, command=0x1, return(status=0)
@5,854,740us: [+5 T:0x4001e320] CV - VISA_freeMsg(0x489d0, 0x41191880): Freeing message with messageId=0x00021819
@5,854,740us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x489d0, retVal=0x0)
Encoder params set are OK
@5,854,770us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x489d0, id=5, dynParams=0xbea08c38 (size=0x20), status=0xbea08b98 (size=0xa0)
@5,854,770us: [+4 T:0x4001e320] CV - VISA_getMaxMsgSize(0x489d0): returning 0x1000
@5,854,801us: [+5 T:0x4001e320] CV - VISA_allocMsg> Allocating message for messageId=0x0002181a
@5,854,831us: [+0 T:0x4001e320] CV - VISA_call(visa=0x489d0, msg=0x41191880): messageId=0x0002181a, command=0x1
[DSP] @15,674,062tk: [+5 T:0x8785bc54] CN - NODE> 0x8785b710(jpegenc#0) call(algHandle=0x8785b7d8, msg=0x87e04880); messageId=0x0002181a
[DSP] @15,674,154tk: [+0 T:0x8785bc54] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x8785b7d8, id=5, dynParams=0x87e048b4 (size=0x20), status=0x87e048d4 (size=0xa0)
[DSP] @15,674,245tk: [+5 T:0x8785bc54] CV - VISA_enter(visa=0x8785b7d8): algHandle = 0x8785b810
[DSP] @15,674,296tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8785b810)
[DSP] @15,674,351tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @15,674,402tk: [+5 T:0x8785bc54] CV - VISA_exit(visa=0x8785b7d8): algHandle = 0x8785b810
[DSP] @15,674,455tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8785b810)
[DSP] @15,674,511tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @15,674,556tk: [+0 T:0x8785bc54] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x8785b7d8, retVal=0x0)
[DSP] @15,674,613tk: [+5 T:0x8785bc54] CN - NODE> returned from call(algHandle=0x8785b7d8, msg=0x87e04880); messageId=0x0002181a
@5,856,113us: [+0 T:0x4001e320] CE - Engine_fwriteTrace> returning count [1154]
@5,856,113us: [+0 T:0x4001e320] CV - VISA_call Completed: messageId=0x0002181a, command=0x1, return(status=0)
@5,856,174us: [+5 T:0x4001e320] CV - VISA_freeMsg(0x489d0, 0x41191880): Freeing message with messageId=0x0002181a
@5,856,174us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x489d0, retVal=0x0)
--------Printing buffer requirements of the codec:--------
Input buffers needed: 3
Input buffer 0 size: 14400
Input buffer 1 size: 7200
Input buffer 2 size: 7200
Output buffers needed: 1
Output buffer 0 size: 11400
----------------------------------------------------------
@5,859,134us: [+0 T:0x4001e320] OP - doCmd> Enter (cmdId=3, proc=0x0)
@5,859,195us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481c0]
@5,859,256us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481c0] status[0]
@5,859,287us: [+0 T:0x40983490] OP - getCmd_d> Exit (result=3)
@5,859,287us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x481d8]
@5,859,317us: [+0 T:0x40983490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481d8]
@5,859,439us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x481c0]
@5,859,470us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x481d8] timeout[0xffffffff]
@5,859,500us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x481d8] status[0]
@5,859,500us: [+0 T:0x4001e320] OP - doCmd> Exit (result=1)
@5,859,531us: [+0 T:0x4001e320] OT - Thread_delete> Enter (task=0x48210)
@5,859,561us: [+4 T:0x4001e320] OT - Thread_delete> pthread_cancel (0x3)
@5,859,561us: [+4 T:0x4001e320] OT - Thread_delete> pthread_join (0x0)
@5,859,592us: [+0 T:0x4001e320] OT - Thread_delete> Exit (task=0x48210)
@5,859,592us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x481c0]
@5,859,622us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@5,859,653us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x481d8]
@5,859,653us: [+0 T:0x4001e320] ti.sdo.ce.osal.Sem - Leaving Sem_delete>

I have compared these two and I have realized that, within version which causes errors, it seems program tries to allocate memory for messaging but it fails. This situation can be seen lines between 394 - 400:

394: @5,834,994us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x489d0, id=1, dynParams=0xbeba5c14 (size=0x20), status=0xbeba5b74 (size=0xa0)
395: @5,835,085us: [+4 T:0x4001e320] CV - VISA_getMaxMsgSize(0x489d0): returning 0x1000
396: @5,835,116us: [+5 T:0x4001e320] CV - VISA_allocMsg> Allocating message for messageId=0x00021815
397: @5,856,295us: [+5 T:0x4001e320] CV - VISA_freeMsg(0x489d0, 0x41191880): Freeing message with messageId=0x00021815
398: @5,856,417us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x489d0, retVal=0xffffffff)
399 : Error (-1), Extended Error (0) in image Encoder Control:setparams
400: Encoding error

However in error free version, everything goes ok, and there is no memory allocation problem for a message: (lines between 394 - 412)

394: @5,853,061us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x489d0, id=1, dynParams=0xbea08c38 (size=0x20), status=0xbea08b98 (size=0xa0)
395: @5,853,153us: [+4 T:0x4001e320] CV - VISA_getMaxMsgSize(0x489d0): returning 0x1000
396: @5,853,183us: [+5 T:0x4001e320] CV - VISA_allocMsg> Allocating message for messageId=0x00021819
397: @5,853,183us: [+0 T:0x4001e320] CV - VISA_call(visa=0x489d0, msg=0x41191880): messageId=0x00021819, command=0x1
398: [DSP] @15,669,113tk: [+5 T:0x8785bc54] CN - NODE> 0x8785b710(jpegenc#0) call(algHandle=0x8785b7d8, msg=0x87e04880); messageId=0x00021819
399: [DSP] @15,669,221tk: [+0 T:0x8785bc54] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Enter (handle=0x8785b7d8, id=1, dynParams=0x87e048b4 (size=0x20), status=0x87e048d4 (size=0xa0)
400: [DSP] @15,669,340tk: [+5 T:0x8785bc54] CV - VISA_enter(visa=0x8785b7d8): algHandle = 0x8785b810
401: [DSP] @15,669,397tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8785b810)
402: [DSP] @15,669,462tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
403: [DSP] @15,669,634tk: [+5 T:0x8785bc54] CV - VISA_exit(visa=0x8785b7d8): algHandle = 0x8785b810
404: [DSP] @15,669,690tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8785b810)
405: [DSP] @15,669,749tk: [+0 T:0x8785bc54] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
406: [DSP] @15,669,797tk: [+0 T:0x8785bc54] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x8785b7d8, retVal=0x0)
407: [DSP] @15,669,859tk: [+5 T:0x8785bc54] CN - NODE> returned from call(algHandle=0x8785b7d8, msg=0x87e04880); messageId=0x00021819
408: @5,854,679us: [+0 T:0x4001e320] CE - Engine_fwriteTrace> returning count [1154]
409: @5,854,709us: [+0 T:0x4001e320] CV - VISA_call Completed: messageId=0x00021819, command=0x1, return(status=0)
410: @5,854,740us: [+5 T:0x4001e320] CV - VISA_freeMsg(0x489d0, 0x41191880): Freeing message with messageId=0x00021819
411: @5,854,740us: [+0 T:0x4001e320] ti.sdo.ce.image1.IMGENC1 - IMGENC1_control> Exit (handle=0x489d0, retVal=0x0)
412: Encoder params set are OK

Definition of my build environment and hardware:

ti-dvsdk_dm3730-evm_4_01_00_09

Beagleboard xm - C2

How can I solve this problem?

Regards.

  • Hi Engin,

    Probably you have some issue with the parameters of the IMGENC1_control function. May be some incorrect pointer or some field has no configuration. I suggest you to add debugging printfs in the IMGENC1_control function in file .../codec-engine_2_26_02_11/packages/ti/sdo/ce/image1/imgenc1.c to localize the reason for the errors.

    BR

    Tsvetolin Shulev

  • Hi Tsvetolin,

    Thank you so much for your immediate response. 

    I cannot understand difference between two versions. You said that, there may be errors related with parameters of IMGENC1_control function, but parameters are not changing between two versions, the commented and un-commented one. 

    For your convenience I am sharing my parameters fed to IMGENC1_control function and their initailization procedures:

    	//Initialize status
    	IMGENC1_Status	encStatus;
    
    	//Initialize dynamic parameter structure for encoder
    	IMGENC1_DynamicParams	encDynParams;
    	encDynParams.numAU = XDM_DEFAULT;
    	encDynParams.inputChromaFormat = XDM_YUV_422P;
    	encDynParams.inputHeight = FRAME_HEIGHT;
    	encDynParams.inputWidth = FRAME_WIDTH;
    	encDynParams.captureWidth = 0;
    	encDynParams.generateHeader = XDM_ENCODE_AU;
    	encDynParams.qValue = 75;
    
    	//Initialize sizes of structures
    	encInArgs.size    = sizeof(encInArgs);
    	encOutArgs.size   = sizeof(encOutArgs);
    	encDynParams.size = sizeof(encDynParams);
    	encStatus.size    = sizeof(encStatus);

    I really cannot understand, how commenting out the function 

    IMGENC1_process(enc, &inBufDesc, &outBufDesc, &encInArgs, &encOutArgs);

    changes the behaviour of IMGENC1_control function. Could you please explain me for a better understanding of the problem?

     

    Regards.

  • Hello,

    As you suggested, I have started to inspect on imgenc1.c file. 

    I have traced the code. I got some results, but since I cannot recompile imgenc1 interface, I cannot obtain detailed results. Since I don't need recompile interface before, I don't know how to do? Could you please assist me on recompilation? 

    Regards.

  • Hi Engin,

    Building Codec Engine is complicated in some extend because it hasn't been officially supported but it is possible and necessary for debugging your issue. The following article describes the Codec Engine building process:

    http://processors.wiki.ti.com/index.php/Rebuilding_Codec_Engine

    BR

    Tsvetolin Shulev

  • Hello,

    I found that link while researching on the internet to find a solution. I will try recompilation.

    But before that, I want you to know that the same application is working without any problems on an OMAP3530. This situation makes me to think that we should search problem some other place? What do you think about this?

    Best regards.

  • "...the same application is working without any problems on an OMAP3530."

    This seems to me little bit strange because the omap3530 and dm3730 are very similar. I would like to know are there some other differences in the software environment during both cases - when your program works correct and when not?

    BR

    Tsvetolin Shulev

  • Hello,

    Here is the development environment for two cases:

    OMAP3530:

    Yocto Project 1.4 Dylan, meta-ti Dylan layer 

    ti-codec-engine_2.26.02.11

    ti-codecs-omap3530_4.00.00.00

    DM3730:

    ti-dvsdk_dm3730-evm_4_01_00_09

    codec-engine_2_26_01_09 (version came with ti-dvsdk)

    codecs-omap3530_4_01_00_00 (version came with ti-dvsdk)

    Regards.

  • Hi Engin,

    As I can see from your post both boards use different versions of codec engine. This seems the most probable reason for the different results with both boards. I suggest you to test behaviour of the DM3730 equipped board with the same software environment which has used on the OMAP3530 board or try with the latest version DVSDK 4.03 which could be downloaded from the link:

    http://software-dl.ti.com/dsps/dsps_public_sw/sdo_sb/targetcontent/dvsdk/DVSDK_4_00/latest/index_FDS.html

    which comes with codec-engine_2_26_02_11.

    BR

    Tsvetolin Shulev

  • Hello,

    As you suggested, I have recompiled the interface. I have realized that, the problem is due to buffer descriptors by debugging with printfs. It seems that older versions cannot handle empty (non-initialized) buffer descriptors. This is why same program is running on OMAP3530 but not running on DM3730. 

    Thank you for your help.

  • Hi Engin,

    Thank you for sharing the experience about solving your issue.

    BR

    Tsvetolin Shulev