We compile the algorithm code in the CCS 3.3 and select optimize -O2 to product the static lib:face.lib
Then we link it to the dvsdk codec_engine project, the link operation is fine,
but try to execute the final file one the dm6446 development board it crashed!
but when we select the -none Opt level, it execute pretty well on the dm6446 development board!
Any helpful suggestion?
THANKS!
PS:CE_DEBUG information:
@0,284,097us: [+4 T:0x40020bc0] OG - Global_init> This program was built with the following packages:
@0,284,682us: [+4 T:0x40020bc0] OG - package gnu.targets.arm.rtsv5T (/home/xjy/dvsdk_2_00_00_22/xdctools_3_10_05_61/packages/gnu/targets/arm/rtsv5T/) [1,0,0,0,1242339117094]
@0,284,849us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.global (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464]
@0,284,984us: [+4 T:0x40020bc0] OG - package dsplink.gpp (/home/xjy/dvsdk_2_00_00_22/dsplink-1_61_03-prebuilt/packages/dsplink/gpp/) [5,0,0,1239931267000]
@0,285,113us: [+4 T:0x40020bc0] OG - package ti.sdo.linuxutils.cmem (/home/xjy/dvsdk_2_00_00_22/linuxutils_2_23_01/packages/ti/sdo/linuxutils/cmem/) [2,2,0,1240253001679]
@0,285,238us: [+4 T:0x40020bc0] OG - package gnu.targets (/home/xjy/dvsdk_2_00_00_22/xdctools_3_10_05_61/packages/gnu/targets/) [1,0,1,1242339114958]
@0,285,364us: [+4 T:0x40020bc0] OG - package gnu.targets.arm (/home/xjy/dvsdk_2_00_00_22/xdctools_3_10_05_61/packages/gnu/targets/arm/) [1,0,0,0,1242339114728]
@0,285,489us: [+4 T:0x40020bc0] OG - package ti.sdo.utils.trace (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890]
@0,285,612us: [+4 T:0x40020bc0] OG - package ti.xdais (/home/xjy/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/) [1,2,1,1236972427008]
@0,285,729us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.node (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858]
@0,285,849us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.utils.xdm (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490]
@0,285,968us: [+4 T:0x40020bc0] OG - package ti.sdo.fc.global (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/global/) [1,0,0,1240266696499]
@0,286,088us: [+4 T:0x40020bc0] OG - package ti.sdo.fc.dman3 (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662]
@0,286,212us: [+4 T:0x40020bc0] OG - package ti.sdo.fc.memutils (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007]
@0,286,337us: [+4 T:0x40020bc0] OG - package ti.sdo.fc.acpy3 (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108]
@0,286,460us: [+4 T:0x40020bc0] OG - package ti.catalog.c470 (/home/xjy/dvsdk_2_00_00_22/xdctools_3_10_05_61/packages/ti/catalog/c470/) [1,0,1,1,0]
@0,286,581us: [+4 T:0x40020bc0] OG - package ti.catalog.arm (/home/xjy/dvsdk_2_00_00_22/xdctools_3_10_05_61/packages/ti/catalog/arm/) [1,0,1,0,0]
@0,286,701us: [+4 T:0x40020bc0] OG - package ti.platforms.evmDM6446 (/home/xjy/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/platforms/evmDM6446/) [1,0,0,1,0]
@0,286,823us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.osal (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,1240276730877]
@0,286,946us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.osal.linux (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/linux/) [2,0,1,1240276736840]
@0,287,146us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.ipc (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961]
@0,287,285us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.ipc.dsplink (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/) [2,0,1,1240276714152]
@0,287,412us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.alg (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798]
@0,287,537us: [+4 T:0x40020bc0] OG - package ti.sdo.ce (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491]
@0,287,662us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.examples.extensions.scale (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/extensions/scale/) [1,0,0,1373245768000]
@0,287,788us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.examples.codecs.scale (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/codecs/scale/) [1,0,0,1373263640000]
@0,287,989us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.examples.extensions.yuyv2rgb (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/extensions/yuyv2rgb/) [1,0,0,1378982477000]
@0,288,138us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.examples.codecs.yuyv2rgb (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/codecs/yuyv2rgb/) [1,0,0,1378961755000]
@0,288,272us: [+4 T:0x40020bc0] OG - package ti.sdo.ce.examples.apps.scale (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/apps/scale/) []
@0,288,679us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,288,929us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0xb10918]
@0,289,095us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@0,289,247us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0xb10930]
@0,289,401us: [+0 T:0x40020bc0] OT - Thread_create> Enter (fxn=0x3c350, attrs=0x0)
@0,290,611us: [+0 T:0x40020bc0] OT - Thread_create> Exit (task=0xb10968)
@0,290,974us: [+0 T:0x40020bc0] ti.sdo.ce.alg - ALG_init> Enter
@0,291,155us: [+0 T:0x40020bc0] ti.sdo.ce.alg - ALG_init> Exit
@0,291,408us: [+6 T:0x40020bc0] CE - Engine_init> CE debugging on (CE_DEBUG=2; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@0,291,712us: [+0 T:0x40020bc0] CS - Server_init()
@0,291,870us: [+0 T:0x40020bc0] CS - Server_init> Global_useLinkArbiter = 0
initEngineFace started.
@0,293,214us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_alloc(14814216) = 0x4180c000.
@0,293,438us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_getPhys(0x4180c000) = 0x881de000.
@0,294,598us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_alloc(14814216) = 0x4262d000.
@0,294,818us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_getPhys(0x4262d000) = 0x873bd000.
@0,295,057us: [+0 T:0x40020bc0] CE - Engine_open> Enter('scale', 0x0, 0xbec3c9d4)
@0,295,250us: [+0 T:0x40020bc0] CE - rserverOpen('all.x64P'), count = 0
@0,295,397us: [+0 T:0x40020bc0] OP - Processor_create> Enter(imageName='all.x64P', linkCfg='(null)', attrs=0xbec3c9b8)
@0,295,917us: [+0 T:0x40020bc0] OP - doCmd> Enter (cmdId=1, proc=0xb10c78)
@0,296,111us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xb10918]
@0,296,399us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xb10918]
@0,296,573us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xb10930] timeout[0xffffffff]
@0,297,021us: [+1 T:0x4180b490] OP - daemon> thread created.
@0,297,210us: [+0 T:0x4180b490] OP - getCmd_d> Enter (proc=0x4180ade8)
@0,297,359us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xb10918] timeout[0xffffffff]
@0,297,503us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xb10918] status[0]
@0,297,637us: [+0 T:0x4180b490] OP - getCmd_d> Exit (result=1)
@0,297,765us: [+0 T:0x4180b490] OP - Processor_create_d> Enter(proc=0xb10c78)
@0,297,899us: [+2 T:0x4180b490] OP - Processor_create_d> Initializing DSP PROC...
@0,298,046us: [+2 T:0x4180b490] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'all.x64P']
@0,298,229us: [+2 T:0x4180b490] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8a000000, sizeInBytes=0x5e00000, shared=1, syncd=0
@0,298,408us: [+2 T:0x4180b490] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000, sizeInBytes=0x100000, shared=1, syncd=0
@0,298,576us: [+2 T:0x4180b490] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x8ff00000, sizeInBytes=0x80, shared=1, syncd=0
@0,298,738us: [+2 T:0x4180b490] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x89000000, sizeInBytes=0x1000000, shared=0, syncd=0
@0,298,897us: [+2 T:0x4180b490] OP - Processor_create_d> DODSPCTRL was=1; now=0
@0,302,456us: [+2 T:0x4180b490] OP - Processor_create_d> Attaching to DSP PROC...
@0,316,210us: [+2 T:0x4180b490] OP - Processor_create_d> Opening MSGQ pool...
@0,316,947us: [+2 T:0x4180b490] OP - Processor_create_d> Loading all.x64P on DSP (1 args)...
@0,355,578us: [+2 T:0x4180b490] OP - Processor_create_d> Starting DSP PROC...
@0,410,031us: [+2 T:0x4180b490] OP - Processor_create_d> Opening remote transport...
@0,411,149us: [+2 T:0x4180b490] OP - Processor_create_d> return (1)
@0,411,353us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xb10930]
@0,411,564us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xb10930] status[0]
@0,411,730us: [+0 T:0x40020bc0] OP - doCmd> Exit (result=1)
@0,411,866us: [+0 T:0x40020bc0] OP - Processor_create> return (0xb10c78)
@0,411,996us: [+0 T:0x40020bc0] CE - rserverOpen('all.x64P'): 0xaccc98 done.
@0,413,107us: [+0 T:0x40020bc0] CE - checkServer(0xb10c48)
@0,413,693us: [+0 T:0x40020bc0] CE - rmsInit> RMS initialized(0xb10c48); 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,413,901us: [+0 T:0x40020bc0] CE - Engine_setTrace> Enter(engine=0xb10c48, mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3')
@0,414,086us: [+1 T:0x40020bc0] CE - Engine_setTrace> Requesting DSP set trace ...
@0,414,347us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xb10930]
@0,414,519us: [+0 T:0x4180b490] OP - getCmd_d> Enter (proc=0x4180ade8)
@0,414,662us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xb10918] timeout[0xffffffff]
@0,415,657us: [+0 T:0x40020bc0] CE - Engine_setTrace> return(0)
[DSP] @0x000002b7:[T:0x00000000] ti.sdo.ce.examples.servers.all_codecs - main> Welcome to DSP server's main().
[DSP] @0,010,130tk: [+0 T:0x8a011474] 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,010,215tk: [+4 T:0x8a011474] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,010,267tk: [+4 T:0x8a011474] OG - package ti.targets.rts6000 (/home/xjy/dvsdk_2_00_00_22/xdctools_3_10_05_61/packages/ti/targets/rts6000/) [1,0,0,0,1242339328638]
[DSP] @0,010,341tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.ipc.dsplink.dsp (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1240276720026]
[DSP] @0,010,418tk: [+4 T:0x8a011474] OG - package ti.sdo.fc.global (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/global/) [1,0,0,1240266696499]
[DSP] @0,010,493tk: [+4 T:0x8a011474] OG - package ti.sdo.fc.dman3 (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662]
[DSP] @0,010,566tk: [+4 T:0x8a011474] OG - package ti.sdo.fc.ires.nullresource (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/ires/nullresource/) [1,0,0,1240266782634]
[DSP] @0,010,648tk: [+4 T:0x8a011474] OG - package ti.rtdx (/home/xjy/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/rtdx/) [2,0,0,4,1219531643983]
[DSP] @0,010,710tk: [+4 T:0x8a011474] OG - package ti.psl (/home/xjy/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/psl/) [5,0,0,0,0]
[DSP] @0,010,767tk: [+4 T:0x8a011474] OG - package ti.bios (/home/xjy/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/bios/) [5,2,5,6,1227035764854]
[DSP] @0,010,830tk: [+4 T:0x8a011474] OG - package ti.sdo.fc.dskt2 (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/dskt2/) [1,0,4,1240266678055]
[DSP] @0,010,903tk: [+4 T:0x8a011474] OG - package ti.sdo.fc.rman (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/rman/) [2,0,0,1240266813533]
[DSP] @0,010,976tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.global (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464]
[DSP] @0,011,047tk: [+4 T:0x8a011474] OG - package ti.xdais (/home/xjy/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/) [1,2,1,1236972427008]
[DSP] @0,011,108tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.node (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858]
[DSP] @0,011,178tk: [+4 T:0x8a011474] OG - package ti.sdo.utils.trace (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890]
[DSP] @0,011,253tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.utils.xdm (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490]
[DSP] @0,011,327tk: [+4 T:0x8a011474] OG - package ti.sdo.fc.memutils (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007]
[DSP] @0,011,402tk: [+4 T:0x8a011474] OG - package ti.sdo.fc.acpy3 (/home/xjy/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108]
[DSP] @0,011,476tk: [+4 T:0x8a011474] OG - package dsplink.dsp (/home/xjy/dvsdk_2_00_00_22/dsplink-1_61_03-prebuilt/packages/dsplink/dsp/) [1,4,0,1239931280000]
[DSP] @0,011,545tk: [+4 T:0x8a011474] OG - package ti.bios.utils (/home/xjy/dvsdk_2_00_00_22/biosutils_1_01_00/packages/ti/bios/utils/) [2,0,1,0,0]
[DSP] @0,011,608tk: [+4 T:0x8a011474] OG - package ti.catalog.c6000 (/home/xjy/dvsdk_2_00_00_22/xdctools_3_10_05_61/packages/ti/catalog/c6000/) [1,0,0,0,0]
[DSP] @0,011,676tk: [+4 T:0x8a011474] OG - package ti.platforms.evmDM6446 (/home/xjy/dvsdk_2_00_00_22/bios_5_33_03/packages/ti/platforms/evmDM6446/) [1,0,0,1,0]
[DSP] @0,011,745tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.osal (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,1240276730877]
[DSP] @0,011,815tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.osal.bios (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/bios/) [2,0,1,1240276734107]
[DSP] @0,011,888tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.ipc (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961]
[DSP] @0,011,957tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.ipc.bios (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1240276705217]
[DSP] @0,012,029tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.alg (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798]
[DSP] @0,012,098tk: [+4 T:0x8a011474] OG - package ti.sdo.ce (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491]
[DSP] @0,012,164tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.bioslog (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/bioslog/) [1,0,1,1240276303166]
[DSP] @0,012,235tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.examples.extensions.scale (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/extensions/scale/) [1,0,0,1373245768000]
[DSP] @0,012,321tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.examples.codecs.scale (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/codecs/scale/) [1,0,0,1373263640000]
[DSP] @0,012,412tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.examples.extensions.yuyv2rgb (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/extensions/yuyv2rgb/) [1,0,0,1378982477000]
[DSP] @0,012,499tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.examples.codecs.yuyv2rgb (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/codecs/yuyv2rgb/) [1,0,0,1378961755000]
[DSP] @0,012,584tk: [+4 T:0x8a011474] OG - package ti.sdo.ce.examples.servers.all_codecs_new_config (/home/xjy/dvsdk_2_00_00_22/codec_engine_2_23_01/examples/ti/sdo/ce/examples/servers/all_codecs_new_config/) [1,0,0,1373095904000]
[DSP] @0,012,678tk: [+0 T:0x8a011474] OG - Global_setSpecialTrace> return
@0,425,953us: [+0 T:0x40020bc0] CE - Engine_fwriteTrace> returning count [6255]
@0,426,120us: [+0 T:0x40020bc0] CE - Engine_open> return(11603016)
@0,426,293us: [+0 T:0x40020bc0] ti.sdo.ce.extensions.scale.SCALE - SCALE_create> Enter (engine=0xb10c48, name='scale', params=0x0)
@0,426,552us: [+0 T:0x40020bc0] CV - VISA_create(0xb10c48, 'scale', 0xac8fcc, 0x124, 'ti.sdo.ce.examples.extensions.scale.ISCALE')
@0,426,724us: [+0 T:0x40020bc0] CV - VISA_create2(0xb10c48, 'scale', 0xac8fcc, 0x8, 0x124, 'ti.sdo.ce.examples.extensions.scale.ISCALE')
@0,426,914us: [+0 T:0x40020bc0] CE - Engine_createNode(0xb10c48, 'scale', 124, 0xac8fcc, 0x8, 0xbec3c96c)
@0,427,078us: [+0 T:0x40020bc0] CE - Engine> allocNode Enter(engine=0xb10c48, impId='scale')
@0,427,268us: [+0 T:0x40020bc0] CE - Engine> allocNode(). Calling Comm_create(gppfromnode_3642_1, 0xb10f80, NULL)
@0,429,201us: [+4 T:0x40020bc0] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0xb10fa0, algName='scale', rmsNode=0x8a019f68, algHandle=0x8a01a050)
[DSP] @0,041,671tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,041,714tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a019f68)
[DSP] @0,041,756tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x8)
[DSP] @0,041,793tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a019f80)
[DSP] @0,041,839tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,041,876tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a019f88)
[DSP] @0,041,917tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,041,954tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a019fa8)
[DSP] @0,042,027tk: [+0 T:0x8a011474] ti.sdo.ce.extensions.scale.SCALE - SCALE_create> Enter (engine=0x0, name='scale', params=0x8fe05cc0)
[DSP] @0,042,097tk: [+0 T:0x8a011474] CV - VISA_create(0x0, 'scale', 0x8fe05cc0, 0x124, 'ti.sdo.ce.examples.extensions.scale.ISCALE')
[DSP] @0,042,164tk: [+0 T:0x8a011474] CV - VISA_create2(0x0, 'scale', 0x8fe05cc0, 0x8, 0x124, 'ti.sdo.ce.examples.extensions.scale.ISCALE')
[DSP] @0,042,243tk: [+0 T:0x8a011474] CE - Engine_open> Enter('local', 0x8a019174, 0x8fe05cc0)
[DSP] @0,042,297tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x2c)
[DSP] @0,042,334tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a01a020)
[DSP] @0,042,384tk: [+0 T:0x8a011474] CE - Engine_open> return(-1979604960)
[DSP] @0,042,437tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x30)
[DSP] @0,042,479tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a01a050)
[DSP] @0,042,524tk: [+0 T:0x8a011474] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8ea8e374, idma3Fxns=0x0, iresFxns=0x0, params=0x8fe05cc0, attrs=0x8a019288)
[DSP] @0,042,616tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,042,653tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a01a080)
[DSP] @0,042,775tk: [+0 T:0x8a011474] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8a01a080)
[DSP] @0,042,824tk: [+5 T:0x8a011474] CV - VISA_create> local codec created (name='scale', handle=0x8a01a080)
[DSP] @0,042,878tk: [+0 T:0x8a011474] ti.sdo.ce.extensions.scale.SCALE - SCALE_create> return (0x8a01a050)
[DSP] @0,042,934tk: [+4 T:0x8a011474] OT - Thread_create > name: "scale#0", pri: -1, stack size: 65536, stack seg: 0
@0,433,938us: [+0 T:0x40020bc0] CE - Engine_fwriteTrace> returning count [2249]
@0,434,102us: [+2 T:0x40020bc0] CE - Engine_createNode> Returning 0xb10f78
@0,434,348us: [+5 T:0x40020bc0] CV - VISA_create> remote codec created (name='scale', localQueueID=0x10001, remoteQueueID=0x0002)
@0,434,532us: [+0 T:0x40020bc0] ti.sdo.ce.extensions.scale.SCALE - SCALE_create> return (0xb10f40)
@0,434,867us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_alloc(211968) = 0x43cce000.
@0,435,084us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_getPhys(0x43cce000) = 0x8728d000.
@0,435,713us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_alloc(317952) = 0x43dfe000.
@0,435,935us: [+4 T:0x40020bc0] OM - Memory_contigAlloc> CMEM_getPhys(0x43dfe000) = 0x86d47000.
@0,436,197us: [+0 T:0x40020bc0] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_create> Enter (engine=0xb10c48, name='yuyv2rgb', params=0x0)
@0,436,379us: [+0 T:0x40020bc0] CV - VISA_create(0xb10c48, 'yuyv2rgb', 0xac8fc4, 0x92, 'ti.sdo.ce.examples.extensions.yuyv2rgb.IYUYV2RGB')
@0,436,618us: [+0 T:0x40020bc0] CV - VISA_create2(0xb10c48, 'yuyv2rgb', 0xac8fc4, 0x8, 0x92, 'ti.sdo.ce.examples.extensions.yuyv2rgb.IYUYV2RGB')
@0,436,835us: [+0 T:0x40020bc0] CE - Engine_createNode(0xb10c48, 'yuyv2rgb', 92, 0xac8fc4, 0x8, 0xbec3c96c)
@0,437,005us: [+0 T:0x40020bc0] CE - Engine> allocNode Enter(engine=0xb10c48, impId='yuyv2rgb')
@0,437,192us: [+0 T:0x40020bc0] CE - Engine> allocNode(). Calling Comm_create(gppfromnode_3642_2, 0xb11070, NULL)
@0,439,104us: [+4 T:0x40020bc0] CE - Engine_createNode> created node(stdIn=0x3, stdOut=0x10002, msgq=0xb11090, algName='yuyv2rgb', rmsNode=0x8a02a4c8, algHandle=0x8a02a570)
[DSP] @0,064,759tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x18)
[DSP] @0,064,820tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a02a4c8)
[DSP] @0,064,862tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0xb)
[DSP] @0,064,899tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a02a4e0)
[DSP] @0,064,944tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x20)
[DSP] @0,064,982tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a02a4f0)
[DSP] @0,065,024tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x24)
[DSP] @0,065,061tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a02a510)
[DSP] @0,065,144tk: [+0 T:0x8a011474] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_create> Enter (engine=0x0, name='yuyv2rgb', params=0x8fe05cc0)
[DSP] @0,065,214tk: [+0 T:0x8a011474] CV - VISA_create(0x0, 'yuyv2rgb', 0x8fe05cc0, 0x92, 'ti.sdo.ce.examples.extensions.yuyv2rgb.IYUYV2RGB')
[DSP] @0,065,285tk: [+0 T:0x8a011474] CV - VISA_create2(0x0, 'yuyv2rgb', 0x8fe05cc0, 0x8, 0x92, 'ti.sdo.ce.examples.extensions.yuyv2rgb.IYUYV2RGB')
[DSP] @0,065,384tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x30)
[DSP] @0,065,429tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a02a570)
[DSP] @0,065,474tk: [+0 T:0x8a011474] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8ea8e41c, idma3Fxns=0x0, iresFxns=0x0, params=0x8fe05cc0, attrs=0x8a019288)
[DSP] @0,065,556tk: [+0 T:0x8a011474] OM - Memory_alloc> Enter(size=0x10)
[DSP] @0,065,593tk: [+0 T:0x8a011474] OM - Memory_alloc> return (0x8a02a5a0)
[DSP] @0,065,680tk: [+0 T:0x8a011474] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8a02a5a0)
[DSP] @0,065,728tk: [+5 T:0x8a011474] CV - VISA_create> local codec created (name='yuyv2rgb', handle=0x8a02a5a0)
[DSP] @0,065,798tk: [+0 T:0x8a011474] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_create> return (0x8a02a570)
[DSP] @0,065,857tk: [+4 T:0x8a011474] OT - Thread_create > name: "yuyv2rgb#1", pri: -1, stack size: 65536, stack seg: 0
@0,442,961us: [+0 T:0x40020bc0] CE - Engine_fwriteTrace> returning count [1970]
@0,443,126us: [+2 T:0x40020bc0] CE - Engine_createNode> Returning 0xb11068
@0,443,371us: [+5 T:0x40020bc0] CV - VISA_create> remote codec created (name='yuyv2rgb', localQueueID=0x10002, remoteQueueID=0x0003)
@0,443,558us: [+0 T:0x40020bc0] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_create> return (0xb11030)
@0,686,885us: [+0 T:0x40020bc0] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0xbec3c9c0, outArgs=0xbec3c99c)
@0,687,118us: [+5 T:0x40020bc0] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad1a
@0,687,300us: [+0 T:0x40020bc0] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad1a, command=0x0
[DSP] @0,644,082tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1a
[DSP] @0,644,176tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @0,660,224tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @0,660,257tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @0,676,297tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @0,676,334tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @0,676,442tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @0,676,498tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @0,676,563tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @0,676,661tk: [+4 T:0x8a01a474] xxtrace - InitFaceRecognition!@1,120,616tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @1,120,694tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @1,120,754tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @1,120,799tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @1,120,864tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @1,136,925tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @1,136,962tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1a
@0,903,598us: [+0 T:0x40020bc0] CE - Engine_fwriteTrace> returning count [1744]
@0,903,761us: [+0 T:0x40020bc0] CV - VISA_call Completed: messageId=0x0002ad1a, command=0x0, return(status=0)
@0,903,912us: [+5 T:0x40020bc0] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad1a
@0,904,059us: [+0 T:0x40020bc0] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
scaleOutArgs.result = 0
init sucessful
VideoPort:0
ThrPri:99
VidecID:0
VidecMode:2
VidIfMode:0
VidSys:1
NumBuf:16
BufSize:211968
AllocMem:3391488 PHYS = 86000000, VIRT = 44b44000
PHYS = 86033c00, VIRT = 44b77c00
PHYS = 86067800, VIRT = 44bab800
PHYS = 8609b400, VIRT = 44bdf400
PHYS = 860cf000, VIRT = 44c13000
PHYS = 86102c00, VIRT = 44c46c00
PHYS = 86136800, VIRT = 44c7a800
PHYS = 8616a400, VIRT = 44cae400
PHYS = 8619e000, VIRT = 44ce2000
PHYS = 861d1c00, VIRT = 44d15c00
PHYS = 86205800, VIRT = 44d49800
PHYS = 86239400, VIRT = 44d7d400
PHYS = 8626d000, VIRT = 44db1000
PHYS = 862a0c00, VIRT = 44de4c00
PHYS = 862d4800, VIRT = 44e18800
PHYS = 86308400, VIRT = 44e4c400
MCVIP: Display init in progress
MCVIP: Display init done !!!
PAGE 0 PROPERTIES
------------------
Num of Channels = 4
Channel No = 0 :Width = 360 ,Height = 288
Channel No = 1 :Width = 360 ,Height = 288
Channel No = 2 :Width = 360 ,Height = 288
Channel No = 3 :Width = 360 ,Height = 288
CAPTURE task start run
MCVIP: TVP5158 init in progress for stage 0
MCVIP: Patch is already running.
MCVIP: TVP5158 init done !!!
@1,373,453us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d90, outArgs=0x47bd2d6c)
@1,373,693us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad1b
@1,374,111us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad1b, command=0x0
[DSP] @2,237,932tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1b
[DSP] @2,238,003tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,254,104tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,254,137tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,270,181tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,270,217tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,270,317tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,270,370tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,270,426tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,270,475tk: [+4 T:0x8a01a474] xxtrace - face_register!@2,281,706tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,281,831tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,281,888tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,281,932tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,281,994tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,298,046tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,298,083tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1b
@1,423,193us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [1738]
@1,423,361us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad1b, command=0x0, return(status=0)
@1,423,520us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad1b
@1,423,670us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
@1,427,631us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d98, outArgs=0x47bd2d74)
@1,427,872us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad1c
@1,428,049us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad1c, command=0x0
[DSP] @2,362,861tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1c
[DSP] @2,362,935tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,378,995tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,379,028tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,395,352tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,395,388tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,395,491tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,395,545tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,395,601tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,395,648tk: [+4 T:0x8a01a474] xxtrace - face_recognition!@2,407,647tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,407,730tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,407,789tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,407,833tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,407,896tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,424,542tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,424,578tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1c
@1,483,128us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [1741]
@1,483,298us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad1c, command=0x0, return(status=0)
@1,483,462us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad1c
@1,483,611us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
face recognition: id=0 [0, 0, 0, 0]
eye position (0, 0) (0,0)
@1,487,126us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d90, outArgs=0x47bd2d6c)
@1,487,371us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad1d
@1,487,558us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad1d, command=0x0
[DSP] @2,500,941tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1d
[DSP] @2,501,017tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,517,071tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,517,104tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,533,165tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,533,199tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,533,299tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,533,354tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,533,410tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,533,456tk: [+4 T:0x8a01a474] xxtrace - face_register!@2,545,180tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,545,275tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,545,336tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,545,381tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,545,447tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,561,554tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,561,592tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1d
@1,517,317us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [1738]
@1,517,487us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad1d, command=0x0, return(status=0)
@1,517,647us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad1d
@1,517,796us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
@1,519,282us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d98, outArgs=0x47bd2d74)
@1,519,513us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad1e
@1,519,695us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad1e, command=0x0
[DSP] @2,575,509tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1e
[DSP] @2,575,584tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,591,630tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,591,664tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,607,710tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,607,744tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,607,845tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,607,898tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,607,954tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,608,001tk: [+4 T:0x8a01a474] xxtrace - face_recognition!@2,627,186tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,628,202tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,628,370tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,628,489tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,628,664tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,644,943tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,644,981tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1e
@1,563,190us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [1741]
@1,563,365us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad1e, command=0x0, return(status=0)
@1,563,528us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad1e
@1,563,678us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
face recognition: id=0 [0, 0, 0, 0]
eye position (0, 0) (0,0)
@1,565,679us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d90, outArgs=0x47bd2d6c)
@1,565,910us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad1f
@1,566,089us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad1f, command=0x0
[DSP] @2,683,153tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1f
[DSP] @2,683,233tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,699,299tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,699,333tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,715,404tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,715,439tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,715,546tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,715,605tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,715,667tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,715,720tk: [+4 T:0x8a01a474] xxtrace - face_register!@2,731,142tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,731,258tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,731,318tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,731,363tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,731,428tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,747,557tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,747,594tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad1f
@1,597,418us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [1738]
@1,597,586us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad1f, command=0x0, return(status=0)
@1,597,749us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad1f
@1,597,901us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
@1,599,392us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d98, outArgs=0x47bd2d74)
@1,599,624us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad20
@1,599,803us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad20, command=0x0
[DSP] @2,761,381tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad20
[DSP] @2,761,456tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,777,576tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,777,610tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,793,858tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,793,942tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,794,136tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,794,234tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,794,296tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,794,348tk: [+4 T:0x8a01a474] xxtrace - face_recognition!@2,812,796tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,812,885tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,812,943tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,812,988tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,813,051tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,829,175tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,829,216tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad20
@1,632,957us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [1741]
@1,633,124us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad20, command=0x0, return(status=0)
@1,633,285us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad20
@1,633,436us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
face recognition: id=0 [0, 0, 0, 0]
eye position (0, 0) (0,0)
@1,635,457us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d90, outArgs=0x47bd2d6c)
@1,635,689us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad21
@1,635,870us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad21, command=0x0
[DSP] @2,845,073tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad21
[DSP] @2,845,147tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,861,202tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,861,239tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,877,301tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,877,335tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,877,435tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,877,489tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,877,546tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,877,592tk: [+4 T:0x8a01a474] xxtrace - face_register!@2,895,260tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,895,383tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,895,447tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,895,495tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,895,567tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,911,902tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,911,939tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad21
@1,668,292us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [1738]
@1,668,462us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad21, command=0x0, return(status=0)
@1,668,623us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad21
@1,668,846us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
@1,671,100us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d98, outArgs=0x47bd2d74)
@1,671,340us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad22
@1,671,525us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad22, command=0x0
*******************chid : 0
chid: 0
@1,698,629us: [+0 T:0x44b43490] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_process> Enter (handle=0xb11030, inBufs=0x43cce000, outBufs=0x43dfe000, inArgs=0x44b42d5c, outArgs=0x44b42d78)
@1,698,833us: [+5 T:0x44b43490] CV - VISA_allocMsg> Allocating message for messageId=0x00030e06
@1,699,011us: [+0 T:0x44b43490] CV - VISA_call(visa=0xb11030, msg=0x43c5fc80): messageId=0x00030e06, command=0x0
[DSP] @2,927,792tk: [+5 T:0x8a01a474] CN - NODE> 0x8a019f88(scale#0) call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad22
[DSP] @2,927,868tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x881de000, sizeInBytes=14814216)
[DSP] @2,943,934tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,943,968tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,960,028tk: [+0 T:0x8a01a474] OM - Memory_cacheInv> return
[DSP] @2,960,063tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0x8a01a050, inBufs=0x881de000, outBufs=0x873bd000, inArgs=0x8fe06cb8, outArgs=0x8fe06cd8)
[DSP] @2,960,175tk: [+5 T:0x8a01a474] CV - VISA_enter(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,960,231tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a01a080)
[DSP] @2,960,296tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @2,960,349tk: [+4 T:0x8a01a474] xxtrace - face_recognition!@2,975,214tk: [+5 T:0x8a01a474] CV - VISA_exit(visa=0x8a01a050): algHandle = 0x8a01a080
[DSP] @2,975,295tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a01a080)
[DSP] @2,975,356tk: [+0 T:0x8a01a474] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @2,975,401tk: [+0 T:0x8a01a474] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0x8a01a050, retVal=0x0)
[DSP] @2,975,473tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> Enter(addr=0x873bd000, sizeInBytes=14814216)
[DSP] @2,991,777tk: [+0 T:0x8a01a474] OM - Memory_cacheWbInv> return
[DSP] @2,991,815tk: [+5 T:0x8a01a474] CN - NODE> returned from call(algHandle=0x8a01a050, msg=0x8fe06c80); messageId=0x0002ad22
[DSP] @2,991,952tk: [+5 T:0x8a02a624] CN - NODE> 0x8a02a4f0(yuyv2rgb#1) call(algHandle=0x8a02a570, msg=0x8fe07c80); messageId=0x00030e06
[DSP] @2,992,027tk: [+0 T:0x8a02a624] OM - Memory_cacheInv> Enter(addr=0x8728d000, sizeInBytes=211968)
[DSP] @2,992,308tk: [+0 T:0x8a02a624] OM - Memory_cacheInv> return
[DSP] @2,992,342tk: [+0 T:0x8a02a624] OM - Memory_cacheInv> Enter(addr=0x86d47000, sizeInBytes=317952)
[DSP] @2,992,814tk: [+0 T:0x8a02a624] OM - Memory_cacheInv> return
[DSP] @2,992,850tk: [+0 T:0x8a02a624] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_process> Enter (handle=0x8a02a570, inBufs=0x8728d000, outBufs=0x86d47000, inArgs=0x8fe07cb8, outArgs=0x8fe07cd4)
[DSP] @2,992,974tk: [+5 T:0x8a02a624] CV - VISA_enter(visa=0x8a02a570): algHandle = 0x8a02a5a0
[DSP] @2,993,034tk: [+0 T:0x8a02a624] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8a02a5a0)
[DSP] @2,993,113tk: [+0 T:0x8a02a624] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @3,023,432tk: [+5 T:0x8a02a624] CV - VISA_exit(visa=0x8a02a570): algHandle = 0x8a02a5a0
[DSP] @3,023,513tk: [+0 T:0x8a02a624] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8a02a5a0)
[DSP] @3,023,574tk: [+0 T:0x8a02a624] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @3,023,620tk: [+0 T:0x8a02a624] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_process> Exit (handle=0x8a02a570, retVal=0x0)
[DSP] @3,023,688tk: [+0 T:0x8a02a624] OM - Memory_cacheWbInv> Enter(addr=0x86d47000, sizeInBytes=317952)
[DSP] @3,024,351tk: [+0 T:0x8a02a624] OM - Memory_cacheWbInv> return
[DSP] @3,024,388tk: [+5 T:0x8a02a624] CN - NODE> returned from call(algHandle=0x8a02a570, msg=0x8fe07c80); messageId=0x00030e06
@1,719,247us: [+0 T:0x47bd3490] CE - Engine_fwriteTrace> returning count [3438]
@1,719,792us: [+0 T:0x44b43490] CE - Engine_fwriteTrace> returning count [0]
@1,720,011us: [+0 T:0x44b43490] CV - VISA_call Completed: messageId=0x00030e06, command=0x0, return(status=0)
@1,720,314us: [+5 T:0x44b43490] CV - VISA_freeMsg(0xb11030, 0x43c5fc80): Freeing message with messageId=0x00030e06
@1,720,498us: [+0 T:0x44b43490] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_process> Exit (handle=0xb11030, retVal=0x0)
compress success
*******************chid : 1
chid: 1
compress success
@1,727,168us: [+0 T:0x47bd3490] CV - VISA_call Completed: messageId=0x0002ad22, command=0x0, return(status=0)
@1,727,540us: [+5 T:0x47bd3490] CV - VISA_freeMsg(0xb10f40, 0x43c5ec80): Freeing message with messageId=0x0002ad22
@1,727,856us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Exit (handle=0xb10f40, retVal=0x0)
*******************chid : 0
chid: 0
@1,732,748us: [+0 T:0x44b43490] ti.sdo.ce.extensions.yuyv2rgb.YUYV2RGB - YUYV2RGB_process> Enter (handle=0xb11030, inBufs=0x43cce000, outBufs=0x43dfe000, inArgs=0x44b42d5c, outArgs=0x44b42d78)
@1,732,970us: [+5 T:0x44b43490] CV - VISA_allocMsg> Allocating message for messageId=0x00030e07
@1,733,146us: [+0 T:0x44b43490] CV - VISA_call(visa=0xb11030, msg=0x43c5fc80): messageId=0x00030e07, command=0x0
face recognition: id=0 [0, 0, 0, 0]
eye position (0, 0) (0,0)
@1,736,082us: [+0 T:0x47bd3490] ti.sdo.ce.extensions.scale.SCALE - SCALE_process> Enter (handle=0xb10f40, inBufs=0x4180c000, outBufs=0x4262d000, inArgs=0x47bd2d90, outArgs=0x47bd2d6c)
@1,736,387us: [+5 T:0x47bd3490] CV - VISA_allocMsg> Allocating message for messageId=0x0002ad23
@1,736,607us: [+0 T:0x47bd3490] CV - VISA_call(visa=0xb10f40, msg=0x43c5ec80): messageId=0x0002ad23, command=0x0
@3,592,428us: [+0 T:0x40020bc0] OP - doCmd> Enter (cmdId=3, proc=0x0)
@3,592,800us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xb10918]
@3,592,998us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xb10918]
@3,593,153us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xb10930] timeout[0xffffffff]
@3,630,282us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xb10918] status[0]
@3,630,497us: [+0 T:0x4180b490] OP - getCmd_d> Exit (result=3)
@3,630,654us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xb10930]
@3,630,831us: [+0 T:0x4180b490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xb10930]
@3,690,273us: [+0 T:0x40020bc0] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xb10930] status[0]
@3,690,491us: [+0 T:0x40020bc0] OP - doCmd> Exit (result=1)
@3,690,639us: [+0 T:0x40020bc0] OT - Thread_delete> Enter (task=0xb10968)
@3,690,855us: [+4 T:0x40020bc0] OT - Thread_delete> pthread_cancel (0x0)
