Hi
On dvsdk3.1, I could use h264enc codec to encode D1_PAL. Then I changed encode name, from 'h264enc' to 'h264fhdvenc'.
When encoding D1_PAL, I got an error:
Error: Failed to encode video buffer
root@192.168.99.153:/opt/dvsdk/dm6467t# CE_DEBUG=3 ./encode -v bb.264
Encode demo started.
@0,605,250us: [+4 T:0x4001f960 S:0xbed47a7c] OG - Global_init> This program was built with the following packages:
@0,605,664us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package gnu.targets.arm.rtsv5T (/opt/dvsdk/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/gnu/targets/arm/rtsv5T/) [1, 0, 0, 0]
@0,605,826us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.aachedec (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/aachedec/) [1, 0, 0]
@0,605,939us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.g711dec (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711dec/) [1, 0, 0]
@0,606,044us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.g711enc (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711enc/) [1, 0, 0]
@0,606,203us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h264dec (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264dec/) [1, 0, 0]
@0,606,310us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h2641080p60vdec (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h2641080p60vdec/) [1, 0, 0]
@0,606,417us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h264enc (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264enc/) [1, 0, 0]
@0,606,559us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h264fhdvenc (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264fhdvenc/) [1, 0, 0]
@0,606,668us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.mpeg2dec (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg2dec/) [1, 0, 0]
@0,606,772us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.jpegdec (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
@0,606,874us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.jpegenc (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
@0,606,976us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.mpeg4dec (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4dec/) [1, 0, 0]
@0,607,079us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.mpeg4enc (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4enc/) [1, 0, 0]
@0,607,183us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.global (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/global/) [1, 0, 0]
@0,607,285us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.xdais.dm (/opt/dvsdk/dvsdk_3_10_00_19/xdais_6_25_02_11/packages/ti/xdais/dm/) [1, 0, 5]
@0,607,384us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.utils.trace (/opt/dvsdk/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/utils/trace/) [1, 0, 0]
@0,607,486us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.utils.xdm (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
@0,607,587us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package dsplink.gpp (/opt/dvsdk/dvsdk_3_10_00_19/dsplink_linux_1_64/dsplink/gpp/) [5, 0, 0]
@0,607,685us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.linuxutils.cmem (/opt/dvsdk/dvsdk_3_10_00_19/linuxutils_2_25_04_10/packages/ti/sdo/linuxutils/cmem/) [2, 2, 0]
@0,607,786us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.xdais (/opt/dvsdk/dvsdk_3_10_00_19/xdais_6_25_02_11/packages/ti/xdais/) [1, 2.0, 1]
@0,607,883us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.node (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/node/) [1, 0, 0]
@0,607,983us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.fc.global (/opt/dvsdk/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/global/) [1, 0, 0]
@0,608,084us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.fc.memutils (/opt/dvsdk/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/memutils/) [1, 0, 0]
@0,941,543us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.fc.utils (/opt/dvsdk/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/utils/) [1, 0, 2]
@0,941,668us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.fc.dman3 (/opt/dvsdk/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/dman3/) [1, 0, 4]
@0,941,776us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.fc.acpy3 (/opt/dvsdk/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
@0,941,878us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package gnu.targets (/opt/dvsdk/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/gnu/targets/) [1, 0, 1]
@0,941,979us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package gnu.targets.arm (/opt/dvsdk/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/gnu/targets/arm/) [1, 0, 0, 0]
@0,942,080us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.catalog.arm (/opt/dvsdk/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/catalog/arm/) [1, 0, 1, 0]
@0,942,182us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.catalog (/opt/dvsdk/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/catalog/) [1, 0, 0]
@0,942,281us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.catalog.c6000 (/opt/dvsdk/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/catalog/c6000/) [1, 0, 0, 0]
@0,942,380us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.platforms.evmDM6467 (/opt/dvsdk/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/platforms/evmDM6467/) [1, 0, 0, 0]
@0,942,483us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.osal (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/osal/) [2, 0, 2]
@0,942,582us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.ipc (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/ipc/) [2, 0, 1]
@0,942,681us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.osal.linux (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
@0,942,782us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.ipc.dsplink (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
@0,942,883us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.alg (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/alg/) [1, 0, 1]
@0,942,980us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/) [1, 0, 6]
@0,943,079us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.audio1 (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/audio1/) [1, 0, 1]
@0,943,182us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.aachedec.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/aachedec/ce/) [1, 0, 0]
@0,943,329us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.speech1 (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/speech1/) [1, 0, 1]
@0,943,437us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.g711dec.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711dec/ce/) [1, 0, 0]
@0,943,541us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.g711enc.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711enc/ce/) [1, 0, 0]
@0,943,642us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.video2 (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/video2/) [1, 0, 2]
@0,943,744us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h264dec.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264dec/ce/) [1, 0, 0]
@0,943,846us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h2641080p60vdec.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h2641080p60vdec/ce/) [1, 0, 0]
@1,277,402us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.video1 (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/video1/) [1, 0, 2]
@1,277,527us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h264enc.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264enc/ce/) [1, 0, 0]
@1,277,637us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.h264fhdvenc.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264fhdvenc/ce/) [1, 0, 0]
@1,277,744us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.mpeg2dec.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg2dec/ce/) [1, 0, 0]
@1,277,848us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.image1 (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/image1/) [1, 0, 1]
@1,277,950us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.jpegdec.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
@1,278,055us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.jpegenc.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
@1,278,159us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.mpeg4dec.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4dec/ce/) [1, 0, 0]
@1,278,262us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.codecs.mpeg4enc.ce (/opt/dvsdk/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4enc/ce/) [1, 0, 0]
@1,278,365us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.speech (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/speech/) [1, 0, 2]
@1,278,468us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.audio (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/audio/) [1, 0, 2]
@1,278,568us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.video (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/video/) [1, 0, 3]
@1,278,669us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.ce.image (/opt/dvsdk/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/image/) [1, 0, 3]
@1,278,768us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.dmai (/opt/dvsdk/dvsdk_3_10_00_19/dmai_2_10_00_12/packages/ti/sdo/dmai/) [1, 0, 0]
@1,278,867us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package ti.sdo.simplewidget (/opt/dvsdk/dvsdk_3_10_00_19/dvsdk_demos_3_10_00_16/packages/ti/sdo/simplewidget/) []
@1,278,967us: [+4 T:0x4001f960 S:0xbed47a7c] OG - package encode_config (/opt/dvsdk/dvsdk_3_10_00_19/dvsdk_demos_3_10_00_16/dm6467/encode/encode_config/) []
@1,279,115us: [+0 T:0x4001f960 S:0xbed47a84] OG - Global_atexit> enter (fxn=0x38d88)
@1,279,234us: [+0 T:0x4001f960 S:0xbed47a84] OG - Global_atexit> enter (fxn=0x381d4)
@1,279,376us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> Enter(0x18)
@1,279,490us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> return (0x6c0f0)
@1,279,790us: [+0 T:0x4001f960 S:0xbed47a74] OG - Global_atexit> enter (fxn=0x3605c)
@1,279,964us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> Enter(0x18)
@1,280,190us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> return (0x6c140)
@1,280,298us: [+0 T:0x4001f960 S:0xbed47a6c] OG - Global_atexit> enter (fxn=0x34e88)
@1,280,467us: [+0 T:0x4001f960 S:0xbed47a74] OG - Global_atexit> enter (fxn=0x37838)
@1,280,645us: [+0 T:0x4001f960 S:0xbed47a6c] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@1,280,754us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> Enter(0x14)
@1,616,021us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> return (0x6c1c0)
@1,616,161us: [+0 T:0x4001f960 S:0xbed47a6c] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x6c1c0]
@1,616,272us: [+0 T:0x4001f960 S:0xbed47a6c] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@1,616,368us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> Enter(0x14)
@1,616,468us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> return (0x6c1d8)
@1,616,566us: [+0 T:0x4001f960 S:0xbed47a6c] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x6c1d8]
@1,616,663us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> Enter(0x18)
@1,616,760us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_alloc> return (0x6c1f0)
@1,616,858us: [+0 T:0x4001f960 S:0xbed47a4c] OT - Thread_create> Enter (fxn=0x33670, attrs=0x0)
@1,616,957us: [+0 T:0x4001f960 S:0xbed47a34] OM - Memory_alloc> Enter(0x64)
@1,617,056us: [+0 T:0x4001f960 S:0xbed47a34] OM - Memory_alloc> return (0x6c210)
@1,617,630us: [+0 T:0x4001f960 S:0xbed47a4c] OT - Thread_create> Exit (task=0x6c210)
@1,617,763us: [+0 T:0x4001f960 S:0xbed47a84] OG - Global_atexit> enter (fxn=0x33088)
@1,617,883us: [+0 T:0x4001f960 S:0xbed47a84] OG - Global_atexit> enter (fxn=0x353d4)
@1,618,085us: [+0 T:0x4001f960 S:0xbed47a6c] ti.sdo.ce.alg - ALG_init> Enter
@1,618,198us: [+0 T:0x4001f960 S:0xbed47a8c] ti.sdo.ce.alg - ALG_init> Exit
@1,618,296us: [+0 T:0x4001f960 S:0xbed47a84] OG - Global_atexit> enter (fxn=0x2fa48)
@1,618,410us: [+0 T:0x4001f960 S:0xbed47a5c] OM - Memory_alloc> Enter(0x18)
@1,618,517us: [+0 T:0x4001f960 S:0xbed47a5c] OM - Memory_alloc> return (0x6c3e0)
@1,618,618us: [+0 T:0x4001f960 S:0xbed47a84] OG - Global_atexit> enter (fxn=0x37d28)
@1,618,786us: [+6 T:0x4001f960 S:0xbed47a7c] CE - Engine_init> CE debugging on (CE_DEBUG=3; allowed CE_DEBUG levels: 1=min, 2=good, 3=max)
@1,618,906us: [+0 T:0x4001f960 S:0xbed47a6c] OG - Global_atexit> enter (fxn=0x2cc08)
@1,619,013us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> Enter(0x18)
@1,619,117us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> return (0x6c420)
@1,619,216us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> Enter(0x18)
@1,619,316us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> return (0x6c440)
@1,619,416us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> Enter(0x18)
@1,619,515us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_alloc> return (0x6c460)
@1,619,659us: [+0 T:0x4001f960 S:0xbed47a94] CS - Server_init()
@1,619,760us: [+0 T:0x4001f960 S:0xbed47a94] CS - Server_init> Global_useLinkArbiter = 0
@1,619,862us: [+0 T:0x4001f960 S:0xbed47a94] OG - Global_atexit> enter (fxn=0x2ae48)
@1,620,204us: [+1 T:0x40bc8490 S:0x40bc7d74] OP - daemon> thread created.
@1,620,329us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Enter (proc=0x40bc7de8)
@1,620,434us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x6c1c0] timeout[0xffffffff]
@1,621,583us: [+2 T:0x413c8490 S:0x413c7cbc] ti.sdo.dmai - [BufTab] Allocating BufTab for 8 buffers
@1,621,728us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@1,621,842us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@1,622,227us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x413c9000.
@1,622,378us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x413c9000) = 0x8b60b000.
@1,622,491us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x413c9000, size=4147200, physAddr=0x8b60b000)
@1,622,599us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@1,622,696us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@1,622,799us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6c830)
@1,622,898us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x8b60b000, cb->size=4147200, cb->virt=0x413c9000
@1,957,510us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x413c9000)
@1,957,640us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x413c9000)
@1,957,747us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x413c9000, size=4)
@1,957,852us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x413c9000, size=4)
@1,957,953us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x413c9000, Ec=0x417bd800, Ss=0x413c9000, Es=0x413c9004, PSc=0x8b60b000)
@1,958,065us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8b60b000
@1,958,165us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x8b60b000)
@1,958,265us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x413c9000 (0x8b60b000 phys)
@1,958,381us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@1,958,486us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@1,958,822us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x41fbe000.
@1,958,972us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x41fbe000) = 0x8b216000.
@1,959,086us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x41fbe000, size=4147200, physAddr=0x8b216000)
@1,959,198us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@1,959,299us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@1,959,403us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6c9b0)
@1,959,502us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x8b216000, cb->size=4147200, cb->virt=0x41fbe000
@1,959,608us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x41fbe000)
@1,959,707us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x41fbe000)
@1,959,805us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x41fbe000, size=4)
@1,959,909us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x41fbe000, size=4)
@1,960,080us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x41fbe000, Ec=0x423b2800, Ss=0x41fbe000, Es=0x41fbe004, PSc=0x8b216000)
@1,960,236us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8b216000
@1,960,345us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x8b216000)
@1,960,449us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x41fbe000 (0x8b216000 phys)
@1,960,567us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@1,960,669us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@1,961,003us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x423b3000.
@1,961,153us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x423b3000) = 0x8ae21000.
@1,961,270us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x423b3000, size=4147200, physAddr=0x8ae21000)
@1,961,380us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@1,961,478us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@1,961,582us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6ca40)
@1,961,681us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x8ae21000, cb->size=4147200, cb->virt=0x423b3000
@1,961,789us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x423b3000)
@2,296,182us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x423b3000)
@2,296,309us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x423b3000, size=4)
@2,296,420us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x423b3000, size=4)
@2,296,524us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x423b3000, Ec=0x427a7800, Ss=0x423b3000, Es=0x423b3004, PSc=0x8ae21000)
@2,296,635us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8ae21000
@2,296,733us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x8ae21000)
@2,296,831us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x423b3000 (0x8ae21000 phys)
@2,296,946us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@2,297,050us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@2,297,384us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x427a8000.
@2,297,533us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x427a8000) = 0x8aa2c000.
@2,297,645us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x427a8000, size=4147200, physAddr=0x8aa2c000)
@2,297,757us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@2,297,856us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@2,297,960us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6cad0)
@2,298,059us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x8aa2c000, cb->size=4147200, cb->virt=0x427a8000
@2,298,169us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x427a8000)
@2,298,267us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x427a8000)
@2,298,365us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x427a8000, size=4)
@2,298,468us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x427a8000, size=4)
@2,298,568us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x427a8000, Ec=0x42b9c800, Ss=0x427a8000, Es=0x427a8004, PSc=0x8aa2c000)
@2,298,680us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8aa2c000
@2,298,778us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x8aa2c000)
@2,298,908us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x427a8000 (0x8aa2c000 phys)
@2,299,028us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@2,299,133us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@2,299,471us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x42b9d000.
@2,299,620us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x42b9d000) = 0x8a637000.
@2,299,735us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x42b9d000, size=4147200, physAddr=0x8a637000)
@2,299,847us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@2,299,944us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@2,300,129us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6cb60)
@2,300,239us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x8a637000, cb->size=4147200, cb->virt=0x42b9d000
@2,300,349us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x42b9d000)
@2,300,448us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x42b9d000)
@2,634,819us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x42b9d000, size=4)
@2,634,950us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x42b9d000, size=4)
@2,635,061us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x42b9d000, Ec=0x42f91800, Ss=0x42b9d000, Es=0x42b9d004, PSc=0x8a637000)
@2,635,176us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8a637000
@2,635,277us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x8a637000)
@2,635,375us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x42b9d000 (0x8a637000 phys)
@2,635,491us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@2,635,594us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@2,635,931us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x42f92000.
@2,636,078us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x42f92000) = 0x8a242000.
@2,636,196us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x42f92000, size=4147200, physAddr=0x8a242000)
@2,636,308us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@2,636,408us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@2,636,512us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6cbf0)
@2,636,612us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x8a242000, cb->size=4147200, cb->virt=0x42f92000
@2,636,721us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x42f92000)
@2,636,819us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x42f92000)
@2,636,919us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x42f92000, size=4)
@2,637,020us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x42f92000, size=4)
@2,637,122us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x42f92000, Ec=0x43386800, Ss=0x42f92000, Es=0x42f92004, PSc=0x8a242000)
@2,637,234us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8a242000
@2,637,334us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x8a242000)
@2,637,432us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x42f92000 (0x8a242000 phys)
@2,637,580us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@2,637,688us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@2,638,024us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x43387000.
@2,638,174us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x43387000) = 0x89e4d000.
@2,638,290us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x43387000, size=4147200, physAddr=0x89e4d000)
@2,638,403us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@2,638,501us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@2,638,607us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6cc80)
@2,638,705us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x89e4d000, cb->size=4147200, cb->virt=0x43387000
@2,638,813us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x43387000)
@2,638,908us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x43387000)
@2,639,007us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x43387000, size=4)
@2,973,500us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x43387000, size=4)
@2,973,633us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x43387000, Ec=0x4377b800, Ss=0x43387000, Es=0x43387004, PSc=0x89e4d000)
@2,973,752us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x89e4d000
@2,973,852us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x89e4d000)
@2,973,951us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x43387000 (0x89e4d000 phys)
@2,974,069us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> Enter(0x3f4800)
@2,974,172us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> Enter(size=4147200, align=-1, cached=FALSE, heap=FALSE)
@2,974,505us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_alloc(4147200) = 0x4377c000.
@2,974,652us: [+4 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> CMEM_getPhys(0x4377c000) = 0x89a58000.
@2,974,764us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> Enter(virtAddr=0x4377c000, size=4147200, physAddr=0x89a58000)
@2,974,876us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> creating new contigBuf object
@2,974,973us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> Enter(0x10)
@2,975,077us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_alloc> return (0x6cd10)
@2,975,176us: [+1 T:0x413c8490 S:0x413c7bec] OM - Memory__addContigBuf> returning: cb->phys=0x89a58000, cb->size=4147200, cb->virt=0x4377c000
@2,975,281us: [+0 T:0x413c8490 S:0x413c7c34] OM - Memory_contigAlloc> return (0x4377c000)
@2,975,378us: [+0 T:0x413c8490 S:0x413c7c7c] OM - Memory_alloc> return (0x4377c000)
@2,975,474us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x4377c000, size=4)
@2,975,575us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x4377c000, size=4)
@2,975,674us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x4377c000, Ec=0x43b70800, Ss=0x4377c000, Es=0x4377c004, PSc=0x89a58000)
@2,975,783us: [+1 T:0x413c8490 S:0x413c7c5c] OM - Memory__getPhysicalAddress> returning physAddr=0x89a58000
@2,975,880us: [+0 T:0x413c8490 S:0x413c7c5c] OM - Memory_getBufferPhysicalAddress> return (0x89a58000)
@2,975,977us: [+2 T:0x413c8490 S:0x413c7c94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 4147200 at 0x4377c000 (0x89a58000 phys)
@2,976,296us: [+0 T:0x41fbd490 S:0x41fbcc84] CE - Engine_open> Enter('encode', 0x0, 0x41fbccf4)
@2,976,470us: [+0 T:0x41fbd490 S:0x41fbcc6c] OM - Memory_alloc> Enter(0x2c)
@2,976,600us: [+0 T:0x41fbd490 S:0x41fbcc6c] OM - Memory_alloc> return (0x6cd48)
@2,976,708us: [+0 T:0x41fbd490 S:0x41fbcc84] CE - rserverOpen('cs.x64P'), count = 0
@2,976,809us: [+0 T:0x41fbd490 S:0x41fbcc4c] OP - Processor_create> Enter(imageName='cs.x64P', linkCfg='(null)', attrs=0x41fbccd8)
@2,977,799us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_alloc> Enter(0x24)
@2,977,938us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_alloc> return (0x6cd78)
@2,978,045us: [+0 T:0x41fbd490 S:0x41fbcc2c] OP - doCmd> Enter (cmdId=1, proc=0x6cd78)
@2,978,148us: [+0 T:0x41fbd490 S:0x41fbcc1c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x6c1c0]
@2,978,328us: [+0 T:0x41fbd490 S:0x41fbcc2c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x6c1c0]
@2,978,454us: [+0 T:0x41fbd490 S:0x41fbcc0c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x6c1d8] timeout[0xffffffff]
@2,978,633us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x6c1c0] status[0]
@2,978,765us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Exit (result=1)
@2,978,871us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Enter(proc=0x6cd78)
@2,978,998us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Initializing DSP PROC...
@3,314,900us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'cs.x64P']
@3,315,031us: [+0 T:0x40bc8490 S:0x40bc7d5c] OM - Memory_alloc> Enter(0xe0)
@3,315,145us: [+0 T:0x40bc8490 S:0x40bc7d5c] OM - Memory_alloc> return (0x6cda0)
@3,315,249us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fb00000, sizeInBytes=0x400000, shared=1, syncd=0
@3,315,373us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8ff00080, sizeInBytes=0xfff80, shared=1, syncd=0
@3,315,499us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x8ff00000, sizeInBytes=0x80, shared=1, syncd=0
@3,315,621us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x8ba00000, sizeInBytes=0x4100000, shared=0, syncd=0
@3,315,743us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> DODSPCTRL was=1; now=0
@3,315,882us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - LINKCFG_Object generated for PROC_setup(0x6ab84) ...
@3,315,994us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->gppObject->
@3,316,088us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "ARM9"
@3,316,182us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maxMsgqs = 0x82
@3,316,274us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maxChnlQueue = 0x10
@3,316,369us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - poolTableId = 0xffffffff
@3,316,461us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - numPools = 0x0
@3,316,553us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,316,681us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->dspObject->
@3,316,781us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "DM6467GEM"
@3,316,876us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dspArch = 0x2
@3,316,969us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - loaderName = "COFF"
@3,317,062us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - autoStart = FALSE
@3,317,155us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - execName = "DEFAULT.OUT"
@3,317,248us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - doDspCtrl = DSP_BootMode_Boot_NoPwr
@3,317,343us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - resumeAddr = 0x8ff00020
@3,317,437us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - resetVector = 0x8ff00000
@3,317,530us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - resetCodeSize = 0x80
@3,317,651us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maduSize = 0x1
@3,317,747us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - cpuFreq = 0x91050
@3,317,839us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - endian = 0x3
@3,317,933us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - wordSwap = 0x0
@3,318,025us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memTableId = 0x0
@3,318,119us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntries = 0x4
@3,318,212us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkDrvId = 0x0
@3,318,305us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg1 = 0xffffffff
@3,318,398us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg2 = 0xffffffff
@3,318,491us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg3 = 0x0
@3,318,582us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg4 = 0x0
@3,318,672us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg5 = 0xffffffff
@3,318,763us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,318,851us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->linkDrvObjects->
@3,318,944us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "SHMDRV"
@3,319,037us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - hshkPollCount = 0x5f5e100
@3,319,132us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntry = 0x1
@3,319,223us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsTableId = 0x0
@3,319,316us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - numIpsEntries = 0x1
@3,653,505us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - poolTableId = 0x0
@3,653,618us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - numPools = 0x1
@3,653,715us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dataTableId = 0x0
@3,653,810us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - numDataDrivers = 0x1
@3,653,904us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - mqtId = 0x0
@3,653,996us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ringIoTableId = 0x0
@3,654,089us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - mplistTableId = 0x0
@3,654,182us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - mpcsTableId = 0x0
@3,654,275us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,654,364us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->memTables[0][i].
@3,654,462us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry #0:
@3,654,554us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry = 0x0
@3,654,648us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "DDR2"
@3,654,740us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - physAddr = 0x8fb00000
@3,654,832us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dspVirtAddr = 0x8fb00000
@3,654,923us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - gppVirtAddr = 0xffffffff
@3,655,015us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - size = 0x400000
@3,655,108us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - shared = TRUE
@3,655,200us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - syncd = FALSE
@3,655,294us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry #1:
@3,655,385us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry = 0x1
@3,655,477us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "DSPLINKMEM"
@3,655,568us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - physAddr = 0x8ff00080
@3,655,660us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dspVirtAddr = 0x8ff00080
@3,655,753us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - gppVirtAddr = 0xffffffff
@3,655,847us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - size = 0xfff80
@3,655,940us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - shared = TRUE
@3,656,031us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - syncd = FALSE
@3,656,124us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry #2:
@3,656,242us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry = 0x2
@3,656,338us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "RESET_VECTOR"
@3,656,432us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - physAddr = 0x8ff00000
@3,656,526us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dspVirtAddr = 0x8ff00000
@3,656,618us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - gppVirtAddr = 0xffffffff
@3,656,711us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - size = 0x80
@3,656,802us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - shared = TRUE
@3,656,892us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - syncd = FALSE
@3,656,983us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry #3:
@3,657,074us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry = 0x3
@3,657,166us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "DDRALGHEAP"
@3,657,259us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - physAddr = 0x8ba00000
@3,657,352us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dspVirtAddr = 0x8ba00000
@3,657,447us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - gppVirtAddr = 0xffffffff
@3,657,540us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - size = 0x4100000
@3,657,630us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - shared = FALSE
@3,657,722us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - syncd = FALSE
@3,657,810us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,657,898us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->ipsTables[0][i].
@3,657,993us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry #0:
@3,658,085us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "IPS"
@3,658,178us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - numIpsEvents = 0x20
@3,658,272us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntry = 0x1
@3,658,362us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - gppIntId = 0x2d
@3,658,452us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dspIntId = 0x10
@3,658,542us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - dspIntVectorId = 0x4
@3,992,143us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg1 = 0x2faf080
@3,992,258us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg2 = 0x0
@3,992,357us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,992,446us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->poolTables[0][i].
@3,992,542us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,992,630us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->dataTables[0][i].
@3,992,726us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - entry #0:
@3,992,817us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "ZCPYDATA"
@3,992,909us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - baseChnlId = 0x0
@3,993,002us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - numChannels = 0x10
@3,993,096us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maxBufSize = 0x4000
@3,993,191us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntry = 0x1
@3,993,282us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - poolId = 0x0
@3,993,374us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - queuePerChnl = 0x1
@3,993,465us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsId = 0x0
@3,993,556us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsEventNo = 0x2
@3,993,648us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg1 = 0x0
@3,993,739us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg2 = 0x0
@3,993,830us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,993,917us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->mqtObjects->
@3,994,011us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "ZCPYMQT"
@3,994,103us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntry = 0x1
@3,994,195us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maxMsgSize = 0xffffffff
@3,994,288us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsId = 0x0
@3,994,379us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsEventNo = 0x1
@3,994,469us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg1 = 0x0
@3,994,562us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - arg2 = 0x0
@3,994,652us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,994,739us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->ringIoObjects->
@3,994,853us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "RINGIOTABLE"
@3,994,951us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntry = 0x1
@3,995,045us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maxEntries = 0x40
@3,995,140us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsId = 0x0
@3,995,232us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsEventNo = 0x0
@3,995,325us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,995,410us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->mplistObjects->
@3,995,504us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "MPLISTTABLE"
@3,995,597us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntry = 0x1
@3,995,689us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maxEntries = 0x40
@3,995,781us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsId = 0xffffffff
@3,995,873us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsEventNo = 0xffffffff
@3,995,965us: [+3 T:0x40bc8490 S:0x40bc7d14] OP -
@3,996,052us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - linkCfg->dspConfigs[0]->mpcsObjects->
@3,996,147us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - name = "MPCS"
@3,996,238us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - memEntry = 0x1
@3,996,330us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - maxEntries = 0x100
@3,996,422us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsId = 0xffffffff
@3,996,512us: [+3 T:0x40bc8490 S:0x40bc7d14] OP - ipsEventNo = 0xffffffff
@4,004,344us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Attaching to DSP PROC...
@4,024,478us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Opening MSGQ pool...
@4,025,439us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Loading cs.x64P on DSP (1 args)...
@4,383,717us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Starting DSP PROC...
@4,427,142us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> Opening remote transport...
@4,429,302us: [+2 T:0x40bc8490 S:0x40bc7d74] OP - Processor_create_d> return (1)
@4,429,433us: [+0 T:0x40bc8490 S:0x40bc7d64] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x6c1d8]
@4,429,618us: [+0 T:0x41fbd490 S:0x41fbcc0c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x6c1d8] status[0]
@4,429,747us: [+0 T:0x41fbd490 S:0x41fbcc2c] OP - doCmd> Exit (result=1)
@4,429,846us: [+0 T:0x41fbd490 S:0x41fbcc4c] OP - Processor_create> return (0x6cd78)
@4,429,944us: [+0 T:0x41fbd490 S:0x41fbcc84] CE - rserverOpen('cs.x64P'): 0x6b608 done.
@4,430,146us: [+0 T:0x41fbd490 S:0x41fbcc6c] OM - Memory_alloc> Enter(0x24)
@4,430,264us: [+0 T:0x41fbd490 S:0x41fbcc6c] OM - Memory_alloc> return (0x6cfd8)
@4,430,469us: [+0 T:0x41fbd490 S:0x41fbcc5c] OC - Comm_create> Enter(queueName='encode_2076_0', queue=0x6cd58, attrs=0x0)
@4,430,594us: [+0 T:0x41fbd490 S:0x41fbcc44] OM - Memory_alloc> Enter(0x4)
@4,430,741us: [+0 T:0x41fbd490 S:0x41fbcc44] OM - Memory_alloc> return (0x6d000)
@4,432,766us: [+0 T:0x41fbd490 S:0x41fbcc5c] OC - Comm_create> return (0x6d000)
@4,432,921us: [+0 T:0x41fbd490 S:0x41fbcc64] OM - Memory_free> Enter(0x6cfd8, 0x24)
@4,433,080us: [+0 T:0x41fbd490 S:0x41fbcc64] OM - Memory_free> return (0x1)
@4,433,196us: [+0 T:0x41fbd490 S:0x41fbcc64] OC - Comm_alloc> Enter(poolId=0x0, msg=0x6cd64, size=576)
@4,433,333us: [+0 T:0x41fbd490 S:0x41fbcc64] OC - Comm_alloc> msg=0x44380900, returning (0)
@4,433,442us: [+0 T:0x41fbd490 S:0x41fbcc4c] OC - Comm_locate> Enter(queueName='rmsq', queue=0x6cd54)
@4,434,125us: [+0 T:0x40bc8490 S:0x40bc7d74] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x6c1d8]
@4,434,262us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Enter (proc=0x40bc7de8)
@4,434,369us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x6c1c0] timeout[0xffffffff]
@4,434,665us: [+0 T:0x41fbd490 S:0x41fbcc4c] OC - Comm_locate> return (0)
@4,434,795us: [+0 T:0x41fbd490 S:0x41fbcc84] CE - checkServer(0x6cd48)
@4,434,915us: [+0 T:0x41fbd490 S:0x41fbcc54] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@4,435,070us: [+0 T:0x41fbd490 S:0x41fbcc54] OC - Comm_put> return (0)
@4,435,212us: [+0 T:0x41fbd490 S:0x41fbcc4c] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbccf0, timeout=-1)
@4,435,448us: [+0 T:0x41fbd490 S:0x41fbcc4c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@4,435,583us: [+0 T:0x41fbd490 S:0x41fbcc84] CE - rmsInit> RMS initialized(0x6cd48); CE_DEBUG on, setting DSP trace mask to *+01234567,GT_prefix=12345,GT_time=3
@4,435,726us: [+0 T:0x41fbd490 S:0x41fbcc5c] CE - Engine_setTrace> Enter(engine=0x6cd48, mask='*+01234567,GT_prefix=12345,GT_time=3')
@4,435,854us: [+1 T:0x41fbd490 S:0x41fbcc5c] CE - Engine_setTrace> Requesting DSP set trace ...
@4,435,951us: [+0 T:0x41fbd490 S:0x41fbcc2c] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@4,436,094us: [+0 T:0x41fbd490 S:0x41fbcc2c] OC - Comm_put> return (0)
@4,436,203us: [+0 T:0x41fbd490 S:0x41fbcc24] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcca4, timeout=-1)
@4,437,887us: [+0 T:0x41fbd490 S:0x41fbcc24] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@4,438,017us: [+0 T:0x41fbd490 S:0x41fbcc5c] CE - Engine_setTrace> return(0)
@4,438,135us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@4,438,280us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> return (0)
@4,438,418us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcc84, timeout=-1)
@4,438,679us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @0x000001a1:[T:0x00000000] codec_unitserver - main> Welcome to CS2DM6467 1.00.00.10 DSP server's main().
[DSP] @0,034,824tk: [+0 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=12345,GT_time=3')
[DSP] @0,034,903tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> This program was built with the following packages:
[DSP] @0,034,965tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.targets.rts6000 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/targets/rts6000/) [1, 0, 0, 0]
[DSP] @0,035,054tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.aachedec (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/aachedec/) [1, 0, 0]
[DSP] @0,035,144tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.g711dec (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711dec/) [1, 0, 0]
[DSP] @0,035,234tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.g711enc (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711enc/) [1, 0, 0]
[DSP] @0,035,324tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h2641080p60vdec (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h2641080p60vdec/) [1, 0, 0]
[DSP] @0,035,419tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h264dec (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264dec/) [1, 0, 0]
[DSP] @0,035,509tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h264enc (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264enc/) [1, 0, 0]
[DSP] @0,035,599tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h264fhdvenc (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264fhdvenc/) [1, 0, 0]
[DSP] @0,035,692tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.mpeg2dec (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg2dec/) [1, 0, 0]
[DSP] @0,035,782tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.jpegdec (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
[DSP] @0,035,872tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.jpegenc (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
[DSP] @0,035,961tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.mpeg4dec (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4dec/) [1, 0, 0]
[DSP] @0,036,052tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.mpeg4enc (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4enc/) [1, 0, 0]
[DSP] @0,036,142tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.hdvicp (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/hdvicp/) [1, 0, 0]
[DSP] @0,036,231tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.xdais (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/xdais_6_25_02_11/packages/ti/xdais/) [1, 2.0, 1]
[DSP] @0,036,311tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.global (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/global/) [1, 0, 0]
[DSP] @0,036,401tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.rtdx (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/bios_5_41_00_06/packages/ti/rtdx/) [2, 0, 0, 5]
[DSP] @0,036,479tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.psl (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/bios_5_41_00_06/packages/ti/psl/) [5, 0, 0, 0]
[DSP] @0,036,557tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.pmi (/sim/scratch_a0868396/arago-insta@4,777,362us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@4,777,531us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> return (0)
@4,777,673us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcc84, timeout=-1)
@4,777,920us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
ll/dvsdk_3_10_00_19/bios_5_41_00_06/packages/ti/pmi/) [1, 0, 0, 0]
[DSP] @0,036,635tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.pscl (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/bios_5_41_00_06/packages/ti/pscl/) [1, 0, 0, 0]
[DSP] @0,036,714tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.bios (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/bios_5_41_00_06/packages/ti/bios/) [5, 2, 5, 19]
[DSP] @0,036,793tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.ires (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/ires/) [1, 0, 0]
[DSP] @0,036,881tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.ires.hdvicp (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/ires/hdvicp/) [1, 0, 1]
[DSP] @0,036,975tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.hdintc (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/hdintc/) [1, 0, 4]
[DSP] @0,037,064tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.edma3.rm (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/edma3_lld_01_11_00_03/packages/ti/sdo/edma3/rm/) [01, 03, 07]
[DSP] @0,037,151tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.ires.nullresource (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/ires/nullresource/) [1, 0, 0]
[DSP] @0,037,249tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.utils.trace (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/utils/trace/) [1, 0, 0]
[DSP] @0,037,340tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.dskt2 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
[DSP] @0,037,429tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.rman (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/rman/) [2, 0, 0]
[DSP] @0,037,518tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.edma3 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/edma3/) [3, 0, 0]
[DSP] @0,037,607tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.ires.edma3chan (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/ires/edma3chan/) [1, 0, 0]
[DSP] @0,037,703tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.global (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/global/) [1, 0, 0]
[DSP] @0,037,790tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.xdais.dm (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/xdais_6_25_02_11/packages/ti/xdais/dm/) [1, 0, 5]
[DSP] @0,037,871tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.utils.xdm (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
[DSP] @0,037,960tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.node (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/node/) [1, 0, 0]
[DSP] @0,038,046tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.ipc.dsplink.dsp (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2, 0, 1]
[DSP] @0,038,139tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.dman3 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/dman3/) [1, 0, 4]
[DSP] @0,038,228tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.memutils (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/ti/sdo/fc/memutils/) [1, 0, 0]
[DSP] @0,038,320tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.fc.acpy3 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/framework_components_2_25_02_06/packages/@5,451,808us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@5,451,991us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> return (0)
@5,452,132us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcc84, timeout=-1)
@5,452,378us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
ti/sdo/fc/acpy3/) [1, 0, 4]
[DSP] @0,038,409tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package dsplink.dsp (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/dsplink_linux_1_64/dsplink/dsp/) [1, 4, 0]
[DSP] @0,038,487tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.bios.utils (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/biosutils_1_02_02/packages/ti/bios/utils/) [2, 0, 2, 02]
[DSP] @0,038,571tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.catalog.c6000 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/catalog/c6000/) [1, 0, 0, 0]
[DSP] @0,038,658tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.catalog (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/catalog/) [1, 0, 0]
[DSP] @0,038,739tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.platforms.evmDM6467 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/xdctools_3_16_01_27/packages/ti/platforms/evmDM6467/) [1, 0, 0, 0]
[DSP] @0,038,830tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.osal (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/osal/) [2, 0, 2]
[DSP] @0,038,916tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.osal.bios (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
[DSP] @0,039,006tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.ipc (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/ipc/) [2, 0, 1]
[DSP] @0,039,090tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.ipc.bios (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
[DSP] @0,039,178tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.alg (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/alg/) [1, 0, 1]
[DSP] @0,039,263tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/) [1, 0, 6]
[DSP] @0,039,345tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.bioslog (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
[DSP] @0,039,433tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.audio1 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/audio1/) [1, 0, 1]
[DSP] @0,039,520tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.aachedec.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/aachedec/ce/) [1, 0, 0]
[DSP] @0,039,612tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.speech1 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/speech1/) [1, 0, 1]
[DSP] @0,039,700tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.g711dec.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711dec/ce/) [1, 0, 0]
[DSP] @0,039,792tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.g711enc.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/g711enc/ce/) [1, 0, 0]
[DSP] @0,039,883tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.video2 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/video2/) [1, 0, 2]
[DSP] @0,039,970tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h2641080p60vdec.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h2641080p60vdec/ce/) [1, 0, 0]
[DSP] @0,040,068tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h264dec.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264dec/ce/) [1, 0, 0]
[DSP] @0,040,160tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.vid@5,791,130us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@5,791,297us: [+0 T:0x41fbd490 S:0x41fbcbec] OC - Comm_put> return (0)
@5,791,438us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcc84, timeout=-1)
@5,791,682us: [+0 T:0x41fbd490 S:0x41fbcbe4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
eo1 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/video1/) [1, 0, 2]
[DSP] @0,040,247tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h264enc.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264enc/ce/) [1, 0, 0]
[DSP] @0,040,338tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.h264fhdvenc.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/h264fhdvenc/ce/) [1, 0, 0]
[DSP] @0,040,433tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.mpeg2dec.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg2dec/ce/) [1, 0, 0]
[DSP] @0,040,526tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.ce.image1 (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/codec_engine_2_25_05_16/packages/ti/sdo/ce/image1/) [1, 0, 1]
[DSP] @0,040,613tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.jpegdec.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
[DSP] @0,040,704tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.jpegenc.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
[DSP] @0,040,796tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.mpeg4dec.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4dec/ce/) [1, 0, 0]
[DSP] @0,040,889tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.codecs.mpeg4enc.ce (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/codecs/mpeg4enc/ce/) [1, 0, 0]
[DSP] @0,040,981tk: [+4 T:0x8ba0006c S:0x8ba03fe4] OG - package ti.sdo.server.cs (/sim/scratch_a0868396/arago-install/dvsdk_3_10_00_19/cs2dm6467_1_00_00_10/packages/ti/sdo/server/cs/) [1, 0, 0]
[DSP] @0,041,067tk: [+0 T:0x8ba0006c S:0x8ba03fe4] OG - Global_setSpecialTrace> return
[DSP] @0,043,254tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @0,043,310tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @1,355,197tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @1,355,252tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @3,963,462tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @3,963,517tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @5,275,623tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @5,275,677tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@6,129,436us: [+0 T:0x41fbd490 S:0x41fbcc1c] CE - Engine_fwriteTrace> returning count [15380]
@6,129,548us: [+0 T:0x41fbd490 S:0x41fbcc84] CE - Engine_open> return(445768)
ENCODE_NAME=h264fhdvenc
@6,129,854us: [+2 T:0x41fbd490 S:0x41fbcc0c] ti.sdo.dmai - [Venc1] Creating encoder h264fhdvenc for max 720x576 bitrate 8000000 ratectrl 4
@6,130,128us: [+0 T:0x41fbd490 S:0x41fbcbe4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x6cd48, name='h264fhdvenc', params=0x41fbcdd0)
@6,130,274us: [+0 T:0x41fbd490 S:0x41fbcbb4] CV - VISA_create(0x6cd48, 'h264fhdvenc', 0x41fbcdd0, 0x520, 'ti.sdo.ce.video1.IVIDENC1')
@6,130,393us: [+0 T:0x41fbd490 S:0x41fbcaac] CV - VISA_create2(0x6cd48, 'h264fhdvenc', 0x41fbcdd0, 0x30, 0x520, 'ti.sdo.ce.video1.IVIDENC1')
@6,130,520us: [+0 T:0x41fbd490 S:0x41fbca94] OM - Memory_alloc> Enter(0x34)
@6,130,627us: [+0 T:0x41fbd490 S:0x41fbca94] OM - Memory_alloc> return (0x6d180)
@6,130,722us: [+0 T:0x41fbd490 S:0x41fbca94] OM - Memory_alloc> Enter(0x4)
@6,130,820us: [+0 T:0x41fbd490 S:0x41fbca94] OM - Memory_alloc> return (0x6d1b8)
@6,130,916us: [+0 T:0x41fbd490 S:0x41fbca8c] OC - Comm_alloc> Enter(poolId=0x0, msg=0x6d1b8, size=520)
@6,131,046us: [+0 T:0x41fbd490 S:0x41fbca8c] OC - Comm_alloc> msg=0x44381900, returning (0)
@6,131,152us: [+0 T:0x41fbd490 S:0x41fbca34] CE - Engine_createNode(0x6cd48, 'h264fhdvenc', 520, 0x41fbcdd0, 0x30, 0x41fbcba8)
@6,131,266us: [+0 T:0x41fbd490 S:0x41fbca34] CE - Engine> allocNode Enter(engine=0x6cd48, impId='h264fhdvenc')
@6,131,367us: [+0 T:0x41fbd490 S:0x41fbca1c] OM - Memory_alloc> Enter(0x20)
@6,131,464us: [+0 T:0x41fbd490 S:0x41fbca1c] OM - Memory_alloc> return (0x6cfd8)
@6,131,577us: [+0 T:0x41fbd490 S:0x41fbca34] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_2076_1, 0x6cfe0, NULL)
@6,131,708us: [+0 T:0x41fbd490 S:0x41fbca0c] OC - Comm_create> Enter(queueName='gppfromnode_2076_1', queue=0x6cfe0, attrs=0x0)
@6,131,815us: [+0 T:0x41fbd490 S:0x41fbc9f4] OM - Memory_alloc> Enter(0x4)
@6,131,914us: [+0 T:0x41fbd490 S:0x41fbc9f4] OM - Memory_alloc> return (0x6d1c8)
@6,133,933us: [+0 T:0x41fbd490 S:0x41fbca0c] OC - Comm_create> return (0x6d1c8)
@6,134,072us: [+0 T:0x41fbd490 S:0x41fbca14] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@6,134,229us: [+0 T:0x41fbd490 S:0x41fbca14] OC - Comm_put> return (0)
@6,134,337us: [+0 T:0x41fbd490 S:0x41fbca0c] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcabc, timeout=-1)
@6,141,741us: [+0 T:0x41fbd490 S:0x41fbca0c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@6,141,872us: [+0 T:0x41fbd490 S:0x41fbca14] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@6,142,025us: [+0 T:0x41fbd490 S:0x41fbca14] OC - Comm_put> return (0)
@6,142,167us: [+0 T:0x41fbd490 S:0x41fbca0c] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcabc, timeout=-1)
@6,142,399us: [+0 T:0x41fbd490 S:0x41fbca0c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@6,142,523us: [+4 T:0x41fbd490 S:0x41fbca34] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x6d1c8, algName='h264fhdvenc', rmsNode=0x8fc66cc0, algHandle=0x8fc66da8)
@6,142,654us: [+0 T:0x41fbd490 S:0x41fbc99c] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@6,142,798us: [+0 T:0x41fbd490 S:0x41fbc99c] OC - Comm_put> return (0)
@6,142,954us: [+0 T:0x41fbd490 S:0x41fbc994] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbca34, timeout=-1)
@6,143,190us: [+0 T:0x41fbd490 S:0x41fbc994] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @6,601,806tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 0
[DSP] @6,601,869tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0x18)
[DSP] @6,601,920tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fc66cc0)
[DSP] @6,601,973tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> Enter(size=0xe)
[DSP] @6,602,019tk: [+0 T:0x8ba0006c S:0x8ba03f14] OM - Memory_alloc> return (0x8fc66cd8)
[DSP] @6,602,076tk: [+0 T:0x8ba0006c S:0x8ba03ed4] OM - Memory_alloc> Enter(size=0x20)
[DSP] @6,602,123tk: [+0 T:0x8ba0006c S:0x8ba03ed4] OM - Memory_alloc> return (0x8fc66ce8)
[DSP] @6,602,177tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_alloc> Enter(size=0x24)
[DSP] @6,602,224tk: [+0 T:0x8ba0006c S:0x8ba03ea4] OM - Memory_alloc> return (0x8fc66d08)
[DSP] @6,602,297tk: [+0 T:0x8ba0006c S:0x8ba03ebc] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x0, name='h264fhdvenc', params=0x8ff03940)
[DSP] @6,602,378tk: [+0 T:0x8ba0006c S:0x8ba03e84] CV - VISA_create(0x0, 'h264fhdvenc', 0x8ff03940, 0x520, 'ti.sdo.ce.video1.IVIDENC1')
[DSP] @6,602,454tk: [+0 T:0x8ba0006c S:0x8ba03d64] CV - VISA_create2(0x0, 'h264fhdvenc', 0x8ff03940, 0x30, 0x520, 'ti.sdo.ce.video1.IVIDENC1')
[DSP] @6,602,539tk: [+0 T:0x8ba0006c S:0x8ba03cfc] CE - Engine_open> Enter('local', 0x8ba03d4c, 0x8ff03940)
[DSP] @6,602,600tk: [+0 T:0x8ba0006c S:0x8ba03cdc] OM - Memory_alloc> Enter(size=0x2c)
[DSP] @6,602,652tk: [+0 T:0x8ba0006c S:0x8ba03cdc] OM - Memory_alloc> return (0x8fc66d78)
[DSP] @6,602,711tk: [+0 T:0x8ba0006c S:0x8ba03cfc] CE - Engine_open> return(-1882821256)
[DSP] @6,602,778tk: [+0 T:0x8ba0006c S:0x8ba03d44] OM - Memory_alloc> Enter(size=0x34)
[DSP] @6,602,826tk: [+0 T:0x8ba0006c S:0x8ba03d44] OM - Memory_alloc> return (0x8fc66da8)
[DSP] @6,602,879tk: [+0 T:0x8ba0006c S:0x8ba03d1c] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fb86bb4, idma3Fxns=0x0, iresFxns=0x8fb86b0c, params=0x8ff03940, attrs=0x8ba03e68)
[DSP] @6,602,976tk: [+0 T:0x8ba0006c S:0x8ba03cfc] OM - Memory_alloc> Enter(size=0x10)
[DSP] @6,603,023tk: [+0 T:0x8ba0006c S:0x8ba03cfc] OM - Memory_alloc> return (0x8fc66de0)
[DSP] @6,627,603tk: [+0 T:0x8ba0006c S:0x8ba03734] ti.sdo.ce.osal.Sem - Sem_create> count 1
[DSP] @6,627,667tk: [+0 T:0x8ba0006c S:0x8ba03734] ti.sdo.ce.osal.Sem - Sem_create> sem: 0x8bbdcdb4
[DSP] @6,627,772tk: [+0 T:0x8ba0006c S:0x8ba03734] ti.sdo.ce.osal.Sem - Sem_create> count 1
[DSP] @6,627,820tk: [+0 T:0x8ba0006c S:0x8ba03734] ti.sdo.ce.osal.Sem - Sem_create> sem: 0x8bbdcde4
[DSP] @6,629,773tk: [+0 T:0x8ba0006c S:0x8ba03d1c] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8fc66de0)
[DSP] @6,629,841tk: [+5 T:0x8ba0006c S:0x8ba03d64] CV - VISA_create> local codec created (name='h264fhdvenc', handle=0x8fc66de0)
[DSP] @6,629,910tk: [+0 T:0x8ba0006c S:0x8ba03ebc] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x8fc66da8)
[DSP] @6,629,974tk: [+4 T:0x8ba0006c S:0x8ba03e7c] OT - Thread_create > name: "h264fhdvenc#0", pri: -1, stack size: 20480, stack seg: 0
[DSP] @6,631,978tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 1
[DSP] @6,634,946tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @6,635,002tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@6,482,058us: [+0 T:0x41fbd490 S:0x41fbc9cc] CE - Engine_fwriteTrace> returning count [3328]
@6,482,172us: [+2 T:0x41fbd490 S:0x41fbca34] CE - Engine_createNode> Returning 0x6cfd8
@6,482,288us: [+5 T:0x41fbd490 S:0x41fbcaac] CV - VISA_create> remote codec created (name='h264fhdvenc', localQueueID=0x10001, remoteQueueID=0x0002)
@6,482,406us: [+0 T:0x41fbd490 S:0x41fbcbe4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x6d180)
@6,482,513us: [+2 T:0x41fbd490 S:0x41fbcc0c] ti.sdo.dmai - [Venc1] Setting dynParams size 720x576 bitrate 8000000
@6,817,415us: [+0 T:0x41fbd490 S:0x41fbcb8c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x6d180, id=1, dynParams=0x6983c (size=0x30), status=0x41fbcc70 (size=0x9c)
@6,817,592us: [+4 T:0x41fbd490 S:0x41fbcb4c] CV - VISA_getMaxMsgSize(0x6d180): returning 0x1000
@6,817,710us: [+5 T:0x41fbd490 S:0x41fbcb54] CV - VISA_allocMsg> Allocating message for messageId=0x0002efc2
@6,817,818us: [+0 T:0x41fbd490 S:0x41fbcb34] CV - VISA_call(visa=0x6d180, msg=0x44381900): messageId=0x0002efc2, command=0x1
@6,817,927us: [+0 T:0x41fbd490 S:0x41fbcafc] OC - Comm_put> Enter(queue=0x2, msg=0x44381900)
@6,818,071us: [+0 T:0x41fbd490 S:0x41fbcafc] OC - Comm_put> return (0)
@6,818,181us: [+0 T:0x41fbd490 S:0x41fbcaf4] OC - Comm_get> Enter(queue=0x10001, msg=0x41fbcba4, timeout=-1)
@6,818,449us: [+0 T:0x41fbd490 S:0x41fbcaf4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@6,818,583us: [+0 T:0x41fbd490 S:0x41fbca84] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@6,818,732us: [+0 T:0x41fbd490 S:0x41fbca84] OC - Comm_put> return (0)
@6,818,871us: [+0 T:0x41fbd490 S:0x41fbca7c] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcb1c, timeout=-1)
@6,819,106us: [+0 T:0x41fbd490 S:0x41fbca7c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @9,246,356tk: [+5 T:0x8bbdca44 S:0x8bbe29dc] CN - NODE> 0x8fc66ce8(h264fhdvenc#0) call(algHandle=0x8fc66da8, msg=0x8ff04900); messageId=0x0002efc2
[DSP] @9,246,444tk: [+0 T:0x8bbdca44 S:0x8bbe283c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fc66da8, id=1, dynParams=0x8ff04934 (size=0x30), status=0x8ff04964 (size=0x9c)
[DSP] @9,246,549tk: [+5 T:0x8bbdca44 S:0x8bbe281c] CV - VISA_enter(visa=0x8fc66da8): algHandle = 0x8fc66de0
[DSP] @9,246,611tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fc66de0)
[DSP] @9,246,761tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @9,246,859tk: [+5 T:0x8bbdca44 S:0x8bbe281c] CV - VISA_exit(visa=0x8fc66da8): algHandle = 0x8fc66de0
[DSP] @9,246,919tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fc66de0)
[DSP] @9,246,982tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @9,247,038tk: [+0 T:0x8bbdca44 S:0x8bbe283c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fc66da8, retVal=0x0)
[DSP] @9,247,105tk: [+5 T:0x8bbdca44 S:0x8bbe29dc] CN - NODE> returned from call(algHandle=0x8fc66da8, msg=0x8ff04900); messageId=0x0002efc2
[DSP] @9,248,913tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @9,248,968tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@6,820,740us: [+0 T:0x41fbd490 S:0x41fbcab4] CE - Engine_fwriteTrace> returning count [1475]
@6,820,853us: [+0 T:0x41fbd490 S:0x41fbcb34] CV - VISA_call Completed: messageId=0x0002efc2, command=0x1, return(status=0)
@6,820,968us: [+5 T:0x41fbd490 S:0x41fbcb3c] CV - VISA_freeMsg(0x6d180, 0x44381900): Freeing message with messageId=0x0002efc2
@6,821,075us: [+0 T:0x41fbd490 S:0x41fbcb8c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x6d180, retVal=0x0)
@6,821,183us: [+2 T:0x41fbd490 S:0x41fbcc0c] ti.sdo.dmai - [Venc1] Made XDM_SETPARAMS control call
@6,821,279us: [+0 T:0x41fbd490 S:0x41fbcb8c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x6d180, id=5, dynParams=0x6983c (size=0x30), status=0x41fbcc70 (size=0x9c)
@6,821,397us: [+4 T:0x41fbd490 S:0x41fbcb4c] CV - VISA_getMaxMsgSize(0x6d180): returning 0x1000
@6,821,497us: [+5 T:0x41fbd490 S:0x41fbcb54] CV - VISA_allocMsg> Allocating message for messageId=0x0002efc3
@6,821,600us: [+0 T:0x41fbd490 S:0x41fbcb34] CV - VISA_call(visa=0x6d180, msg=0x44381900): messageId=0x0002efc3, command=0x1
@6,821,707us: [+0 T:0x41fbd490 S:0x41fbcafc] OC - Comm_put> Enter(queue=0x2, msg=0x44381900)
@7,156,133us: [+0 T:0x41fbd490 S:0x41fbcafc] OC - Comm_put> return (0)
@7,156,251us: [+0 T:0x41fbd490 S:0x41fbcaf4] OC - Comm_get> Enter(queue=0x10001, msg=0x41fbcba4, timeout=-1)
@7,156,523us: [+0 T:0x41fbd490 S:0x41fbcaf4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@7,156,660us: [+0 T:0x41fbd490 S:0x41fbca84] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@7,156,810us: [+0 T:0x41fbd490 S:0x41fbca84] OC - Comm_put> return (0)
@7,156,951us: [+0 T:0x41fbd490 S:0x41fbca7c] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbcb1c, timeout=-1)
@7,157,180us: [+0 T:0x41fbd490 S:0x41fbca7c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @10,553,691tk: [+5 T:0x8bbdca44 S:0x8bbe29dc] CN - NODE> 0x8fc66ce8(h264fhdvenc#0) call(algHandle=0x8fc66da8, msg=0x8ff04900); messageId=0x0002efc3
[DSP] @10,553,774tk: [+0 T:0x8bbdca44 S:0x8bbe283c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fc66da8, id=5, dynParams=0x8ff04934 (size=0x30), status=0x8ff04964 (size=0x9c)
[DSP] @10,553,871tk: [+5 T:0x8bbdca44 S:0x8bbe281c] CV - VISA_enter(visa=0x8fc66da8): algHandle = 0x8fc66de0
[DSP] @10,553,932tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fc66de0)
[DSP] @10,553,994tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @10,554,049tk: [+5 T:0x8bbdca44 S:0x8bbe281c] CV - VISA_exit(visa=0x8fc66da8): algHandle = 0x8fc66de0
[DSP] @10,554,110tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fc66de0)
[DSP] @10,554,172tk: [+0 T:0x8bbdca44 S:0x8bbe27fc] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @10,554,224tk: [+0 T:0x8bbdca44 S:0x8bbe283c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fc66da8, retVal=0x0)
[DSP] @10,554,292tk: [+5 T:0x8bbdca44 S:0x8bbe29dc] CN - NODE> returned from call(algHandle=0x8fc66da8, msg=0x8ff04900); messageId=0x0002efc3
[DSP] @10,556,316tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @10,556,371tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@7,158,710us: [+0 T:0x41fbd490 S:0x41fbcab4] CE - Engine_fwriteTrace> returning count [1487]
@7,158,840us: [+0 T:0x41fbd490 S:0x41fbcb34] CV - VISA_call Completed: messageId=0x0002efc3, command=0x1, return(status=0)
@7,158,955us: [+5 T:0x41fbd490 S:0x41fbcb3c] CV - VISA_freeMsg(0x6d180, 0x44381900): Freeing message with messageId=0x0002efc3
@7,159,065us: [+0 T:0x41fbd490 S:0x41fbcb8c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x6d180, retVal=0x0)
@7,159,343us: [+2 T:0x41fbd490 S:0x41fbccbc] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers
@7,159,483us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_alloc> Enter(0x97e00)
@7,159,591us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> Enter(size=622080, align=-1, cached=FALSE, heap=FALSE)
@7,159,859us: [+4 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> CMEM_alloc(622080) = 0x443f1000.
@7,160,073us: [+4 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> CMEM_getPhys(0x443f1000) = 0x8985a000.
@7,160,199us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> Enter(virtAddr=0x443f1000, size=622080, physAddr=0x8985a000)
@7,160,313us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> creating new contigBuf object
@7,160,413us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_alloc> Enter(0x10)
@7,160,516us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_alloc> return (0x6d278)
@7,160,615us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> returning: cb->phys=0x8985a000, cb->size=622080, cb->virt=0x443f1000
@7,160,720us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> return (0x443f1000)
@7,160,815us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_alloc> return (0x443f1000)
@7,494,782us: [+0 T:0x41fbd490 S:0x41fbcc5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x443f1000, size=4)
@7,494,918us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x443f1000, size=4)
@7,495,029us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x443f1000, Ec=0x44488e00, Ss=0x443f1000, Es=0x443f1004, PSc=0x8985a000)
@7,495,148us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8985a000
@7,495,247us: [+0 T:0x41fbd490 S:0x41fbcc5c] OM - Memory_getBufferPhysicalAddress> return (0x8985a000)
@7,495,346us: [+2 T:0x41fbd490 S:0x41fbcc94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 622080 at 0x443f1000 (0x8985a000 phys)
@7,495,464us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_alloc> Enter(0x97e00)
@7,495,568us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> Enter(size=622080, align=-1, cached=FALSE, heap=FALSE)
@7,495,835us: [+4 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> CMEM_alloc(622080) = 0x44def000.
@7,495,983us: [+4 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> CMEM_getPhys(0x44def000) = 0x8965c000.
@7,496,096us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> Enter(virtAddr=0x44def000, size=622080, physAddr=0x8965c000)
@7,496,210us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> creating new contigBuf object
@7,496,308us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_alloc> Enter(0x10)
@7,496,413us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_alloc> return (0x6d520)
@7,496,514us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> returning: cb->phys=0x8965c000, cb->size=622080, cb->virt=0x44def000
@7,496,621us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> return (0x44def000)
@7,496,721us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_alloc> return (0x44def000)
@7,496,820us: [+0 T:0x41fbd490 S:0x41fbcc5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x44def000, size=4)
@7,496,924us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x44def000, size=4)
@7,497,024us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x44def000, Ec=0x44e86e00, Ss=0x44def000, Es=0x44def004, PSc=0x8965c000)
@7,497,138us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8965c000
@7,497,237us: [+0 T:0x41fbd490 S:0x41fbcc5c] OM - Memory_getBufferPhysicalAddress> return (0x8965c000)
@7,497,337us: [+2 T:0x41fbd490 S:0x41fbcc94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 622080 at 0x44def000 (0x8965c000 phys)
@7,497,478us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_alloc> Enter(0x97e00)
@7,497,586us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> Enter(size=622080, align=-1, cached=FALSE, heap=FALSE)
@7,497,855us: [+4 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> CMEM_alloc(622080) = 0x44fed000.
@7,498,003us: [+4 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> CMEM_getPhys(0x44fed000) = 0x8945e000.
@7,498,119us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> Enter(virtAddr=0x44fed000, size=622080, physAddr=0x8945e000)
@7,498,232us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> creating new contigBuf object
@7,498,330us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_alloc> Enter(0x10)
@7,498,435us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_alloc> return (0x6d5b0)
@7,498,533us: [+1 T:0x41fbd490 S:0x41fbcbec] OM - Memory__addContigBuf> returning: cb->phys=0x8945e000, cb->size=622080, cb->virt=0x44fed000
@7,498,640us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_contigAlloc> return (0x44fed000)
@7,498,738us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_alloc> return (0x44fed000)
@7,498,838us: [+0 T:0x41fbd490 S:0x41fbcc5c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x44fed000, size=4)
@7,833,418us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x44fed000, size=4)
@7,833,550us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x44fed000, Ec=0x45084e00, Ss=0x44fed000, Es=0x44fed004, PSc=0x8945e000)
@7,833,671us: [+1 T:0x41fbd490 S:0x41fbcc5c] OM - Memory__getPhysicalAddress> returning physAddr=0x8945e000
@7,833,772us: [+0 T:0x41fbd490 S:0x41fbcc5c] OM - Memory_getBufferPhysicalAddress> return (0x8945e000)
@7,833,872us: [+2 T:0x41fbd490 S:0x41fbcc94] ti.sdo.dmai - [Buffer] Alloc Buffer of size 622080 at 0x44fed000 (0x8945e000 phys)
FRAME_SIZE=829440
@7,838,491us: [+2 T:0x44dee490 S:0x44dedd84] ti.sdo.dmai - [BufTab] Allocating BufTab for 2 buffers
@7,838,696us: [+0 T:0x44dee490 S:0x44dedd44] OM - Memory_alloc> Enter(0x65400)
@7,838,826us: [+0 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> Enter(size=414720, align=-1, cached=FALSE, heap=FALSE)
@7,839,134us: [+4 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> CMEM_alloc(414720) = 0x451eb000.
@7,839,286us: [+4 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> CMEM_getPhys(0x451eb000) = 0x89260000.
@7,839,405us: [+1 T:0x44dee490 S:0x44dedcb4] OM - Memory__addContigBuf> Enter(virtAddr=0x451eb000, size=414720, physAddr=0x89260000)
@7,839,521us: [+1 T:0x44dee490 S:0x44dedcb4] OM - Memory__addContigBuf> creating new contigBuf object
@7,839,623us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_alloc> Enter(0x10)
@7,839,733us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_alloc> return (0x6d618)
@7,839,835us: [+1 T:0x44dee490 S:0x44dedcb4] OM - Memory__addContigBuf> returning: cb->phys=0x89260000, cb->size=414720, cb->virt=0x451eb000
@7,839,948us: [+0 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> return (0x451eb000)
@7,840,132us: [+0 T:0x44dee490 S:0x44dedd44] OM - Memory_alloc> return (0x451eb000)
@7,840,248us: [+0 T:0x44dee490 S:0x44dedd24] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x451eb000, size=4)
@7,840,359us: [+1 T:0x44dee490 S:0x44dedd24] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x451eb000, size=4)
@7,840,465us: [+1 T:0x44dee490 S:0x44dedd24] OM - Memory__getPhysicalAddress> found in cb(Sc=0x451eb000, Ec=0x45250400, Ss=0x451eb000, Es=0x451eb004, PSc=0x89260000)
@7,840,583us: [+1 T:0x44dee490 S:0x44dedd24] OM - Memory__getPhysicalAddress> returning physAddr=0x89260000
@7,840,687us: [+0 T:0x44dee490 S:0x44dedd24] OM - Memory_getBufferPhysicalAddress> return (0x89260000)
@7,840,790us: [+2 T:0x44dee490 S:0x44dedd5c] ti.sdo.dmai - [Buffer] Alloc Buffer of size 414720 at 0x451eb000 (0x89260000 phys)
@7,840,909us: [+0 T:0x44dee490 S:0x44dedd44] OM - Memory_alloc> Enter(0x65400)
@7,841,014us: [+0 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> Enter(size=414720, align=-1, cached=FALSE, heap=FALSE)
@7,841,284us: [+4 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> CMEM_alloc(414720) = 0x453e9000.
@7,841,435us: [+4 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> CMEM_getPhys(0x453e9000) = 0x89062000.
@7,841,553us: [+1 T:0x44dee490 S:0x44dedcb4] OM - Memory__addContigBuf> Enter(virtAddr=0x453e9000, size=414720, physAddr=0x89062000)
@7,841,696us: [+1 T:0x44dee490 S:0x44dedcb4] OM - Memory__addContigBuf> creating new contigBuf object
@7,841,804us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_alloc> Enter(0x10)
@7,841,915us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_alloc> return (0x6d670)
@7,842,018us: [+1 T:0x44dee490 S:0x44dedcb4] OM - Memory__addContigBuf> returning: cb->phys=0x89062000, cb->size=414720, cb->virt=0x453e9000
@7,842,131us: [+0 T:0x44dee490 S:0x44dedcfc] OM - Memory_contigAlloc> return (0x453e9000)
@7,842,234us: [+0 T:0x44dee490 S:0x44dedd44] OM - Memory_alloc> return (0x453e9000)
@7,842,336us: [+0 T:0x44dee490 S:0x44dedd24] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x453e9000, size=4)
@8,177,663us: [+1 T:0x44dee490 S:0x44dedd24] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x453e9000, size=4)
@8,177,802us: [+1 T:0x44dee490 S:0x44dedd24] OM - Memory__getPhysicalAddress> found in cb(Sc=0x453e9000, Ec=0x4544e400, Ss=0x453e9000, Es=0x453e9004, PSc=0x89062000)
@8,177,927us: [+1 T:0x44dee490 S:0x44dedd24] OM - Memory__getPhysicalAddress> returning physAddr=0x89062000
@8,178,033us: [+0 T:0x44dee490 S:0x44dedd24] OM - Memory_getBufferPhysicalAddress> return (0x89062000)
@8,178,139us: [+2 T:0x44dee490 S:0x44dedd5c] ti.sdo.dmai - [Buffer] Alloc Buffer of size 414720 at 0x453e9000 (0x89062000 phys)
@8,178,373us: [+0 T:0x4001f960 S:0xbed479fc] CE - Engine_open> Enter('encode', 0x0, 0xbed47a6c)
@8,178,546us: [+0 T:0x4001f960 S:0xbed479e4] OM - Memory_alloc> Enter(0x2c)
@8,178,674us: [+0 T:0x4001f960 S:0xbed479e4] OM - Memory_alloc> return (0x6d688)
@8,178,779us: [+0 T:0x4001f960 S:0xbed479fc] CE - rserverOpen('cs.x64P'), count = 1
@8,178,880us: [+0 T:0x4001f960 S:0xbed479fc] CE - rserverOpen('cs.x64P'): 0x6b608 done.
@8,178,982us: [+0 T:0x4001f960 S:0xbed479e4] OM - Memory_alloc> Enter(0x24)
@8,179,083us: [+0 T:0x4001f960 S:0xbed479e4] OM - Memory_alloc> return (0x6d6b8)
@8,179,202us: [+0 T:0x4001f960 S:0xbed479d4] OC - Comm_create> Enter(queueName='encode_2076_2', queue=0x6d698, attrs=0x0)
@8,179,310us: [+0 T:0x4001f960 S:0xbed479bc] OM - Memory_alloc> Enter(0x4)
@8,179,409us: [+0 T:0x4001f960 S:0xbed479bc] OM - Memory_alloc> return (0x6d6e0)
@8,181,540us: [+0 T:0x4001f960 S:0xbed479d4] OC - Comm_create> return (0x6d6e0)
@8,181,671us: [+0 T:0x4001f960 S:0xbed479dc] OM - Memory_free> Enter(0x6d6b8, 0x24)
@8,181,781us: [+0 T:0x4001f960 S:0xbed479dc] OM - Memory_free> return (0x1)
@8,181,878us: [+0 T:0x4001f960 S:0xbed479dc] OC - Comm_alloc> Enter(poolId=0x0, msg=0x6d6a4, size=576)
@8,182,007us: [+0 T:0x4001f960 S:0xbed479dc] OC - Comm_alloc> msg=0x44382900, returning (0)
@8,182,116us: [+0 T:0x4001f960 S:0xbed479c4] OC - Comm_locate> Enter(queueName='rmsq', queue=0x6d694)
@8,182,897us: [+0 T:0x4001f960 S:0xbed479c4] OC - Comm_locate> return (0)
@8,183,028us: [+0 T:0x4001f960 S:0xbed479fc] CE - checkServer(0x6d688)
@8,183,173us: [+0 T:0x4001f960 S:0xbed479cc] OC - Comm_put> Enter(queue=0x0, msg=0x44382900)
@8,183,330us: [+0 T:0x4001f960 S:0xbed479cc] OC - Comm_put> return (0)
@8,183,534us: [+0 T:0x4001f960 S:0xbed479c4] OC - Comm_get> Enter(queue=0x10002, msg=0xbed47a68, timeout=-1)
@8,183,747us: [+0 T:0x4001f960 S:0xbed479c4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@8,183,885us: [+0 T:0x4001f960 S:0xbed47964] OC - Comm_put> Enter(queue=0x0, msg=0x44382900)
@8,184,035us: [+0 T:0x4001f960 S:0xbed47964] OC - Comm_put> return (0)
@8,184,236us: [+0 T:0x4001f960 S:0xbed4795c] OC - Comm_get> Enter(queue=0x10002, msg=0xbed479fc, timeout=-1)
@8,184,445us: [+0 T:0x4001f960 S:0xbed4795c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @14,526,059tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff05928, 4056): cmd = 6
[DSP] @14,528,786tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff05928, 4056): cmd = 5
[DSP] @14,528,841tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@8,184,880us: [+0 T:0x4001f960 S:0xbed47994] CE - Engine_fwriteTrace> returning count [297]
@8,184,982us: [+0 T:0x4001f960 S:0xbed479fc] CE - Engine_open> return(448136)
@8,190,694us: [+0 T:0x41fbd490 S:0x41fbcad4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x6d180, inBufs=0x41fbcc30, outBufs=0x41fbcc24, inArgs=0x41fbcc14, outArgs=0x41fbcb9c)
@8,191,025us: [+4 T:0x41fbd490 S:0x41fbca54] CV - VISA_getMaxMsgSize(0x6d180): returning 0x1000
@8,191,142us: [+5 T:0x41fbd490 S:0x41fbca5c] CV - VISA_allocMsg> Allocating message for messageId=0x0002efc4
@8,191,254us: [+0 T:0x41fbd490 S:0x41fbca2c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x443f1000, size=414720)
@8,191,363us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x443f1000, size=414720)
@8,524,704us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x443f1000, Ec=0x44488e00, Ss=0x443f1000, Es=0x44456400, PSc=0x8985a000)
@8,524,838us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> returning physAddr=0x8985a000
@8,524,942us: [+0 T:0x41fbd490 S:0x41fbca2c] OM - Memory_getBufferPhysicalAddress> return (0x8985a000)
@8,525,045us: [+0 T:0x41fbd490 S:0x41fbca2c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x44456400, size=207360)
@8,525,149us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x44456400, size=207360)
@8,525,253us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x443f1000, Ec=0x44488e00, Ss=0x44456400, Es=0x44488e00, PSc=0x8985a000)
@8,525,364us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> returning physAddr=0x898bf400
@8,525,462us: [+0 T:0x41fbd490 S:0x41fbca2c] OM - Memory_getBufferPhysicalAddress> return (0x898bf400)
@8,525,562us: [+0 T:0x41fbd490 S:0x41fbca2c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x451eb000, size=414720)
@8,525,664us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x451eb000, size=414720)
@8,525,765us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x451eb000, Ec=0x45250400, Ss=0x451eb000, Es=0x45250400, PSc=0x89260000)
@8,525,877us: [+1 T:0x41fbd490 S:0x41fbca2c] OM - Memory__getPhysicalAddress> returning physAddr=0x89260000
@8,525,973us: [+0 T:0x41fbd490 S:0x41fbca2c] OM - Memory_getBufferPhysicalAddress> return (0x89260000)
@8,526,075us: [+0 T:0x41fbd490 S:0x41fbca74] CV - VISA_call(visa=0x6d180, msg=0x44381900): messageId=0x0002efc4, command=0x0
@8,526,186us: [+0 T:0x41fbd490 S:0x41fbca3c] OC - Comm_put> Enter(queue=0x2, msg=0x44381900)
@8,526,334us: [+0 T:0x41fbd490 S:0x41fbca3c] OC - Comm_put> return (0)
@8,526,445us: [+0 T:0x41fbd490 S:0x41fbca34] OC - Comm_get> Enter(queue=0x10001, msg=0x41fbcaec, timeout=-1)
@8,527,048us: [+0 T:0x41fbd490 S:0x41fbca34] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@8,527,186us: [+0 T:0x41fbd490 S:0x41fbc9c4] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@8,527,338us: [+0 T:0x41fbd490 S:0x41fbc9c4] OC - Comm_put> return (0)
@8,527,496us: [+0 T:0x41fbd490 S:0x41fbc9bc] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbca5c, timeout=-1)
@8,527,731us: [+0 T:0x41fbd490 S:0x41fbc9bc] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @15,852,523tk: [+5 T:0x8bbdca44 S:0x8bbe29dc] CN - NODE> 0x8fc66ce8(h264fhdvenc#0) call(algHandle=0x8fc66da8, msg=0x8ff04900); messageId=0x0002efc4
[DSP] @15,852,612tk: [+0 T:0x8bbdca44 S:0x8bbe28a4] OM - Memory_cacheInv> Enter(addr=0x8985a000, sizeInBytes=414720)
[DSP] @15,853,123tk: [+0 T:0x8bbdca44 S:0x8bbe28a4] OM - Memory_cacheInv> return
[DSP] @15,853,167tk: [+0 T:0x8bbdca44 S:0x8bbe28a4] OM - Memory_cacheInv> Enter(addr=0x898bf400, sizeInBytes=207360)
[DSP] @15,853,453tk: [+0 T:0x8bbdca44 S:0x8bbe28a4] OM - Memory_cacheInv> return
[DSP] @15,853,497tk: [+0 T:0x8bbdca44 S:0x8bbe28a4] OM - Memory_cacheInv> Enter(addr=0x89260000, sizeInBytes=414720)
[DSP] @15,854,008tk: [+0 T:0x8bbdca44 S:0x8bbe28a4] OM - Memory_cacheInv> return
[DSP] @15,854,053tk: [+0 T:0x8bbdca44 S:0x8bbe286c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x8fc66da8, inBufs=0x8bbe290c, outBufs=0x8bbe29dc, inArgs=0x8ff04a84, outArgs=0x8ff04a90)
[DSP] @15,854,160tk: [+5 T:0x8bbdca44 S:0x8bbe284c] CV - VISA_enter(visa=0x8fc66da8): algHandle = 0x8fc66de0
[DSP] @15,854,219tk: [+0 T:0x8bbdca44 S:0x8bbe282c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fc66de0)
[DSP] @15,854,282tk: [+0 T:0x8bbdca44 S:0x8bbe282c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @15,854,339tk: [+5 T:0x8bbdca44 S:0x8bbe284c] CV - VISA_exit(visa=0x8fc66da8): algHandle = 0x8fc66de0
[DSP] @15,854,399tk: [+0 T:0x8bbdca44 S:0x8bbe282c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fc66de0)
[DSP] @15,854,462tk: [+0 T:0x8bbdca44 S:0x8bbe282c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @15,854,515tk: [+0 T:0x8bbdca44 S:0x8bbe286c] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x8fc66da8, retVal=0xffffffff)
[DSP] @15,854,589tk: [+5 T:0x8bbdca44 S:0x8bbe29dc] CN - NODE> returned from call(algHandle=0x8fc66da8, msg=0x8ff04900); messageId=0x0002efc4
[DSP] @15,856,410tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @15,856,465tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@8,864,065us: [+0 T:0x41fbd490 S:0x41fbc9f4] CE - Engine_fwriteTrace> returning count [2096]
@8,864,180us: [+0 T:0x41fbd490 S:0x41fbca74] CV - VISA_call Completed: messageId=0x0002efc4, command=0x0, return(status=-1)
@8,864,297us: [+5 T:0x41fbd490 S:0x41fbca64] CV - VISA_freeMsg(0x6d180, 0x44381900): Freeing message with messageId=0x0002efc4
@8,864,405us: [+0 T:0x41fbd490 S:0x41fbcad4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x6d180, retVal=0xffffffff)
@8,864,512us: [+2 T:0x41fbd490 S:0x41fbcb24] ti.sdo.dmai - [Venc1] VIDENC1_process() ret -1 inId 0 outID 0 generated 0 bytes
@8,864,618us: [+7 T:0x41fbd490 S:0x41fbcb24] ti.sdo.dmai - [Venc1] VIDENC1_process() failed with error (-1 ext: 0xc000)
Error: Failed to encode video buffer
@9,089,379us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x413c9000 (0x8b60b000 phys)
@9,089,554us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x413c9000, 0x3f4800)
@9,089,669us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1094488064, size=4147200)
@9,089,777us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x413c9000, size=4147200)
@9,089,883us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x8b60b000, cb->size=0x3f4800, cb->virt=0x413c9000
@9,089,991us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6c830, 0x10)
@9,090,181us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,092,056us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,092,187us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,092,322us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x41fbe000 (0x8b216000 phys)
@9,092,439us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x41fbe000, 0x3f4800)
@9,092,542us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1107025920, size=4147200)
@9,092,645us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x41fbe000, size=4147200)
@9,092,750us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x8b216000, cb->size=0x3f4800, cb->virt=0x41fbe000
@9,092,858us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6c9b0, 0x10)
@9,092,961us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,094,817us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,094,947us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,095,056us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x423b3000 (0x8ae21000 phys)
@9,095,196us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x423b3000, 0x3f4800)
@9,095,302us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1111175168, size=4147200)
@9,095,408us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x423b3000, size=4147200)
@9,095,513us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x8ae21000, cb->size=0x3f4800, cb->virt=0x423b3000
@9,095,623us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6ca40, 0x10)
@9,095,726us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,097,581us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,097,711us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,097,820us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x427a8000 (0x8aa2c000 phys)
@9,097,956us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x427a8000, 0x3f4800)
@9,098,061us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1115324416, size=4147200)
@9,098,164us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x427a8000, size=4147200)
@9,098,270us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x8aa2c000, cb->size=0x3f4800, cb->virt=0x427a8000
@9,098,376us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6cad0, 0x10)
@9,098,479us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,100,402us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,100,530us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,100,638us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x42b9d000 (0x8a637000 phys)
@9,100,773us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x42b9d000, 0x3f4800)
@9,100,879us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1119473664, size=4147200)
@9,100,983us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x42b9d000, size=4147200)
@9,101,086us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x8a637000, cb->size=0x3f4800, cb->virt=0x42b9d000
@9,101,194us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6cb60, 0x10)
@9,436,697us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,438,573us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,438,701us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,438,809us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x42f92000 (0x8a242000 phys)
@9,438,921us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x42f92000, 0x3f4800)
@9,439,022us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1123622912, size=4147200)
@9,439,126us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x42f92000, size=4147200)
@9,439,227us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x8a242000, cb->size=0x3f4800, cb->virt=0x42f92000
@9,439,355us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6cbf0, 0x10)
@9,439,463us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,441,388us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,441,517us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,441,628us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x43387000 (0x89e4d000 phys)
@9,441,738us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x43387000, 0x3f4800)
@9,441,840us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1127772160, size=4147200)
@9,441,944us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x43387000, size=4147200)
@9,442,047us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x89e4d000, cb->size=0x3f4800, cb->virt=0x43387000
@9,442,180us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6cc80, 0x10)
@9,442,286us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,444,139us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,444,267us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,444,377us: [+2 T:0x413c8490 S:0x413c7c74] ti.sdo.dmai - [Buffer] Free Buffer of size 4147200 at 0x4377c000 (0x89a58000 phys)
@9,444,487us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> Enter(0x4377c000, 0x3f4800)
@9,444,585us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> Enter(addr=1131921408, size=4147200)
@9,444,687us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x4377c000, size=4147200)
@9,444,789us: [+1 T:0x413c8490 S:0x413c7bf4] OM - Memory__removeContigBuf> removing cb->phys=0x89a58000, cb->size=0x3f4800, cb->virt=0x4377c000
@9,444,897us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> Enter(0x6cd10, 0x10)
@9,445,027us: [+0 T:0x413c8490 S:0x413c7bd4] OM - Memory_free> return (0x1)
@9,446,866us: [+0 T:0x413c8490 S:0x413c7c1c] OM - Memory_contigFree> return (0x1)
@9,446,995us: [+0 T:0x413c8490 S:0x413c7c54] OM - Memory_free> return (0x1)
@9,447,347us: [+2 T:0x41fbd490 S:0x41fbcc74] ti.sdo.dmai - [Buffer] Free Buffer of size 622080 at 0x443f1000 (0x8985a000 phys)
@9,447,540us: [+0 T:0x41fbd490 S:0x41fbcc54] OM - Memory_free> Enter(0x443f1000, 0x97e00)
@9,447,668us: [+0 T:0x41fbd490 S:0x41fbcc1c] OM - Memory_contigFree> Enter(addr=1144983552, size=622080)
@9,447,805us: [+1 T:0x41fbd490 S:0x41fbcbf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x443f1000, size=622080)
@9,447,915us: [+1 T:0x41fbd490 S:0x41fbcbf4] OM - Memory__removeContigBuf> removing cb->phys=0x8985a000, cb->size=0x97e00, cb->virt=0x443f1000
@9,448,024us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_free> Enter(0x6d278, 0x10)
@9,448,126us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_free> return (0x1)
@9,449,131us: [+0 T:0x41fbd490 S:0x41fbcc1c] OM - Memory_contigFree> return (0x1)
@9,449,257us: [+0 T:0x41fbd490 S:0x41fbcc54] OM - Memory_free> return (0x1)
@9,449,366us: [+2 T:0x41fbd490 S:0x41fbcc74] ti.sdo.dmai - [Buffer] Free Buffer of size 622080 at 0x44def000 (0x8965c000 phys)
@9,783,719us: [+0 T:0x41fbd490 S:0x41fbcc54] OM - Memory_free> Enter(0x44def000, 0x97e00)
@9,783,846us: [+0 T:0x41fbd490 S:0x41fbcc1c] OM - Memory_contigFree> Enter(addr=1155461120, size=622080)
@9,783,956us: [+1 T:0x41fbd490 S:0x41fbcbf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x44def000, size=622080)
@9,784,061us: [+1 T:0x41fbd490 S:0x41fbcbf4] OM - Memory__removeContigBuf> removing cb->phys=0x8965c000, cb->size=0x97e00, cb->virt=0x44def000
@9,784,171us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_free> Enter(0x6d520, 0x10)
@9,784,272us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_free> return (0x1)
@9,785,278us: [+0 T:0x41fbd490 S:0x41fbcc1c] OM - Memory_contigFree> return (0x1)
@9,785,406us: [+0 T:0x41fbd490 S:0x41fbcc54] OM - Memory_free> return (0x1)
@9,785,516us: [+2 T:0x41fbd490 S:0x41fbcc74] ti.sdo.dmai - [Buffer] Free Buffer of size 622080 at 0x44fed000 (0x8945e000 phys)
@9,785,628us: [+0 T:0x41fbd490 S:0x41fbcc54] OM - Memory_free> Enter(0x44fed000, 0x97e00)
@9,785,729us: [+0 T:0x41fbd490 S:0x41fbcc1c] OM - Memory_contigFree> Enter(addr=1157550080, size=622080)
@9,785,832us: [+1 T:0x41fbd490 S:0x41fbcbf4] OM - Memory__removeContigBuf> Enter(virtAddr=0x44fed000, size=622080)
@9,785,933us: [+1 T:0x41fbd490 S:0x41fbcbf4] OM - Memory__removeContigBuf> removing cb->phys=0x8945e000, cb->size=0x97e00, cb->virt=0x44fed000
@9,786,038us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_free> Enter(0x6d5b0, 0x10)
@9,786,139us: [+0 T:0x41fbd490 S:0x41fbcbd4] OM - Memory_free> return (0x1)
@9,787,173us: [+0 T:0x41fbd490 S:0x41fbcc1c] OM - Memory_contigFree> return (0x1)
@9,787,302us: [+0 T:0x41fbd490 S:0x41fbcc54] OM - Memory_free> return (0x1)
@9,787,414us: [+0 T:0x41fbd490 S:0x41fbccc4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> Enter (handle=0x6d180)
@9,787,521us: [+0 T:0x41fbd490 S:0x41fbcc9c] CV - VISA_delete(0x6d180)
@9,787,616us: [+5 T:0x41fbd490 S:0x41fbcc9c] CV - VISA_delete> deleting codec (localQueue=0x10001, remoteQueue=0x2)
@9,787,721us: [+0 T:0x41fbd490 S:0x41fbcc74] CE - Engine_ctrlNode(0x6cfd8, 0x6d1b8, 0x0)
@9,787,823us: [+0 T:0x41fbd490 S:0x41fbcc54] OC - Comm_put> Enter(queue=0x2, msg=0x44381900)
@9,787,969us: [+0 T:0x41fbd490 S:0x41fbcc54] OC - Comm_put> return (0)
@9,788,109us: [+0 T:0x41fbd490 S:0x41fbcc4c] OC - Comm_get> Enter(queue=0x10001, msg=0x6d1b8, timeout=-1)
@9,788,257us: [+2 T:0x44dee490 S:0x44dedd3c] ti.sdo.dmai - [Buffer] Free Buffer of size 414720 at 0x451eb000 (0x89260000 phys)
@9,788,441us: [+0 T:0x44dee490 S:0x44dedd1c] OM - Memory_free> Enter(0x451eb000, 0x65400)
@9,788,573us: [+0 T:0x44dee490 S:0x44dedce4] OM - Memory_contigFree> Enter(addr=1159639040, size=414720)
@9,788,686us: [+1 T:0x44dee490 S:0x44dedcbc] OM - Memory__removeContigBuf> Enter(virtAddr=0x451eb000, size=414720)
@9,788,795us: [+1 T:0x44dee490 S:0x44dedcbc] OM - Memory__removeContigBuf> removing cb->phys=0x89260000, cb->size=0x65400, cb->virt=0x451eb000
@9,788,909us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_free> Enter(0x6d618, 0x10)
@9,789,016us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_free> return (0x1)
@9,790,121us: [+0 T:0x44dee490 S:0x44dedce4] OM - Memory_contigFree> return (0x1)
@9,790,255us: [+0 T:0x44dee490 S:0x44dedd1c] OM - Memory_free> return (0x1)
@9,790,368us: [+2 T:0x44dee490 S:0x44dedd3c] ti.sdo.dmai - [Buffer] Free Buffer of size 414720 at 0x453e9000 (0x89062000 phys)
@9,790,482us: [+0 T:0x44dee490 S:0x44dedd1c] OM - Memory_free> Enter(0x453e9000, 0x65400)
@9,790,589us: [+0 T:0x44dee490 S:0x44dedce4] OM - Memory_contigFree> Enter(addr=1161728000, size=414720)
@9,790,697us: [+1 T:0x44dee490 S:0x44dedcbc] OM - Memory__removeContigBuf> Enter(virtAddr=0x453e9000, size=414720)
@9,790,802us: [+1 T:0x44dee490 S:0x44dedcbc] OM - Memory__removeContigBuf> removing cb->phys=0x89062000, cb->size=0x65400, cb->virt=0x453e9000
@10,125,190us: [+0 T:0x41fbd490 S:0x41fbcc4c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@10,125,378us: [+0 T:0x41fbd490 S:0x41fbcc74] CE - Engine_ctrlNode> Returning 0x0
@10,125,503us: [+0 T:0x41fbd490 S:0x41fbcc54] CE - Engine_deleteNode(0x6cfd8)
@10,125,604us: [+0 T:0x41fbd490 S:0x41fbcc34] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@10,125,753us: [+0 T:0x41fbd490 S:0x41fbcc34] OC - Comm_put> return (0)
@10,125,861us: [+0 T:0x41fbd490 S:0x41fbcc2c] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbccac, timeout=-1)
@10,126,013us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_free> Enter(0x6d670, 0x10)
@10,126,144us: [+0 T:0x44dee490 S:0x44dedc9c] OM - Memory_free> return (0x1)
@10,127,191us: [+0 T:0x44dee490 S:0x44dedce4] OM - Memory_contigFree> return (0x1)
@10,127,326us: [+0 T:0x44dee490 S:0x44dedd1c] OM - Memory_free> return (0x1)
@10,127,612us: [+0 T:0x4001f960 S:0xbed47a3c] CE - Engine_close(0x6d688)
@10,127,793us: [+0 T:0x4001f960 S:0xbed479a4] OC - Comm_put> Enter(queue=0x0, msg=0x44382900)
@10,127,989us: [+0 T:0x4001f960 S:0xbed479a4] OC - Comm_put> return (0)
@10,128,188us: [+0 T:0x4001f960 S:0xbed4799c] OC - Comm_get> Enter(queue=0x10002, msg=0xbed47a3c, timeout=-1)
@10,128,404us: [+0 T:0x41fbd490 S:0x41fbcc2c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@10,128,529us: [+5 T:0x41fbd490 S:0x41fbcc54] CE - Engine_deleteNode(0x6cfd8): algName = h264fhdvenc, algHandle = 0x8fc66da8, stack size = 20480, stack used = 743(4%)
@10,128,652us: [+0 T:0x41fbd490 S:0x41fbcc2c] OC - Comm_delete> Enter (comm=0x6d1c8)
@10,129,341us: [+0 T:0x41fbd490 S:0x41fbcc0c] OM - Memory_free> Enter(0x6d1c8, 0x4)
@10,129,478us: [+0 T:0x41fbd490 S:0x41fbcc0c] OM - Memory_free> return (0x1)
@10,129,583us: [+0 T:0x41fbd490 S:0x41fbcc4c] OC - Comm_delete> return
@10,129,678us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_free> Enter(0x6cfd8, 0x20)
@10,129,779us: [+0 T:0x41fbd490 S:0x41fbcc34] OM - Memory_free> return (0x1)
@10,129,875us: [+0 T:0x41fbd490 S:0x41fbcc8c] OC - Comm_free> Enter (msg=0x44381900)
@10,129,999us: [+0 T:0x41fbd490 S:0x41fbcc8c] OC - Comm_free> return (0)
@10,130,179us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_free> Enter(0x6d1b8, 0x4)
@10,130,289us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_free> return (0x1)
@10,130,385us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_free> Enter(0x6d180, 0x34)
@10,130,485us: [+0 T:0x41fbd490 S:0x41fbcc7c] OM - Memory_free> return (0x1)
@10,130,580us: [+0 T:0x41fbd490 S:0x41fbccd4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> return
@10,130,707us: [+0 T:0x41fbd490 S:0x41fbccc4] CE - Engine_close(0x6cd48)
@10,130,949us: [+0 T:0x4001f960 S:0xbed4799c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @20,731,535tk: [+0 T:0x8bbdca44 S:0x8bbe29dc] CN - NODE_EXECFXN(0x8fc66ce8): h264fhdvenc#0 exiting per request ...
[DSP] @22,037,775tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 2
[DSP] @22,038,437tk: [+0 T:0x8ba0006c S:0x8ba03fe4] CN - NODE_delete(0x8fc66ce8): h264fhdvenc#0
[DSP] @22,038,513tk: [+0 T:0x8ba0006c S:0x8ba03fc4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> Enter (handle=0x8fc66da8)
[DSP] @22,038,576tk: [+0 T:0x8ba0006c S:0x8ba03f94] CV - VISA_delete(0x8fc66da8)
[DSP] @22,038,624tk: [+5 T:0x8ba0006c S:0x8ba03f94] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQueue=0xffff)
[DSP] @22,038,686tk: [+5 T:0x8ba0006c S:0x8ba03f94] CV - VISA_delete> deleting codec 0x8fc66de0
[DSP] @22,038,738tk: [+0 T:0x8ba0006c S:0x8ba03f74] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x8fc66de0)
[DSP] @22,039,207tk: [+0 T:0x8ba0006c S:0x8ba03eb4] ti.sdo.ce.osal.Sem - Sem_delete> sem: 0x8bbdcde4
[DSP] @22,039,653tk: [+0 T:0x8ba0006c S:0x8ba03f44] OM - Memory_free> Enter(addr=0x8fc66de0, size=16)
[DSP] @22,039,711tk: [+0 T:0x8ba0006c S:0x8ba03f44] OM - Memory_free> return (0x1)
[DSP] @22,039,755tk: [+0 T:0x8ba0006c S:0x8ba03f74] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit
[DSP] @22,039,809tk: [+0 T:0x8ba0006c S:0x8ba03f64] OM - Memory_free> Enter(addr=0x8fc66da8, size=52)
[DSP] @22,039,865tk: [+0 T:0x8ba0006c S:0x8ba03f64] OM - Memory_free> return (0x1)
[DSP] @22,039,909tk: [+0 T:0x8ba0006c S:0x8ba03fc4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_delete> return
[DSP] @22,039,965tk: [+0 T:0x8ba0006c S:0x8ba03fac] OM - Memory_free> Enter(addr=0x8fc66d08, size=36)
[DSP] @22,040,021tk: [+0 T:0x8ba0006c S:0x8ba03fac] OM - Memory_free> return (0x1)
[DSP] @22,040,065tk: [+0 T:0x8ba0006c S:0x8ba03fb4] OM - Memory_free> Enter(addr=0x8fc66ce8, size=32)
[DSP] @22,040,121tk: [+0 T:0x8ba0006c S:0x8ba03fb4] OM - Memory_free> return (0x1)
[DSP] @22,040,167tk: [+0 T:0x8ba0006c S:0x8ba03fd4] OM - Memory_free> Enter(addr=0x8fc66cd8, size=14)
[DSP] @22,040,223tk: [+0 T:0x8ba0006c S:0x8ba03fd4] OM - Memory_free> return (0x1)
[DSP] @22,040,267tk: [+0 T:0x8ba0006c S:0x8ba03fd4] OM - Memory_free> Enter(addr=0x8fc66cc0, size=24)
[DSP] @22,040,323tk: [+0 T:0x8ba0006c S:0x8ba03fd4] OM - Memory_free> return (0x1)
[DSP] @22,046,445tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff05928, 4056): cmd = 5
[DSP] @22,046,503tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@10,467,888us: [+0 T:0x4001f960 S:0xbed479d4] CE - Engine_fwriteTrace> returning count [2469]
@10,468,081us: [+0 T:0x41fbd490 S:0x41fbcc2c] OC - Comm_put> Enter(queue=0x0, msg=0x44380900)
@10,468,257us: [+0 T:0x41fbd490 S:0x41fbcc2c] OC - Comm_put> return (0)
@10,468,399us: [+0 T:0x41fbd490 S:0x41fbcc24] OC - Comm_get> Enter(queue=0x10000, msg=0x41fbccc4, timeout=-1)
@10,468,599us: [+0 T:0x4001f960 S:0xbed47a1c] CS - Server_disconnectTrace('0x6d688', 0x0)
@10,468,722us: [+0 T:0x4001f960 S:0xbed47a1c] CS - Server_connectTrace> return(0)
@10,468,828us: [+0 T:0x4001f960 S:0xbed47a2c] OC - Comm_free> Enter (msg=0x44382900)
@10,468,951us: [+0 T:0x4001f960 S:0xbed47a2c] OC - Comm_free> return (0)
@10,469,053us: [+0 T:0x4001f960 S:0xbed47a1c] OC - Comm_delete> Enter (comm=0x6d6e0)
@10,469,760us: [+0 T:0x4001f960 S:0xbed479fc] OM - Memory_free> Enter(0x6d6e0, 0x4)
@10,469,896us: [+0 T:0x4001f960 S:0xbed479fc] OM - Memory_free> return (0x1)
@10,469,999us: [+0 T:0x4001f960 S:0xbed47a3c] OC - Comm_delete> return
@10,470,188us: [+0 T:0x4001f960 S:0xbed47a2c] OC - Comm_release> Enter(queue=0x0)
@10,470,308us: [+0 T:0x4001f960 S:0xbed47a2c] OC - Comm_release> return (0)
@10,470,410us: [+0 T:0x4001f960 S:0xbed47a3c] CE - rserverClose(0x6b608), count = 2
@10,470,509us: [+0 T:0x4001f960 S:0xbed47a3c] CE - rserverClose(0x6b608) done.
@10,470,604us: [+0 T:0x4001f960 S:0xbed47a3c] OM - Memory_free> Enter(0x6d688, 0x2c)
@10,470,703us: [+0 T:0x4001f960 S:0xbed47a3c] OM - Memory_free> return (0x1)
@10,470,968us: [+0 T:0x41fbd490 S:0x41fbcc24] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @23,362,303tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - processRmsCmd(0x8ff03928, 4056): cmd = 5
[DSP] @23,362,358tk: [+0 T:0x8ba0006c S:0x8ba0402c] CR - remote time = 0x0, trace buffer size = 4032
@10,471,315us: [+0 T:0x41fbd490 S:0x41fbcc5c] CE - Engine_fwriteTrace> returning count [199]
@10,471,464us: [+0 T:0x41fbd490 S:0x41fbcca4] CS - Server_disconnectTrace('0x6cd48', 0x0)
@10,471,586us: [+0 T:0x41fbd490 S:0x41fbcca4] CS - Server_connectTrace> return(0)
@10,471,689us: [+0 T:0x41fbd490 S:0x41fbccb4] OC - Comm_free> Enter (msg=0x44380900)
@10,471,815us: [+0 T:0x41fbd490 S:0x41fbccb4] OC - Comm_free> return (0)
@10,471,917us: [+0 T:0x41fbd490 S:0x41fbcca4] OC - Comm_delete> Enter (comm=0x6d000)
@10,472,628us: [+0 T:0x41fbd490 S:0x41fbcc84] OM - Memory_free> Enter(0x6d000, 0x4)
@10,472,764us: [+0 T:0x41fbd490 S:0x41fbcc84] OM - Memory_free> return (0x1)
@10,472,867us: [+0 T:0x41fbd490 S:0x41fbccc4] OC - Comm_delete> return
@10,807,977us: [+0 T:0x41fbd490 S:0x41fbccb4] OC - Comm_release> Enter(queue=0x0)
@10,808,110us: [+0 T:0x41fbd490 S:0x41fbccb4] OC - Comm_release> return (0)
@10,808,214us: [+0 T:0x41fbd490 S:0x41fbccc4] CE - rserverClose(0x6b608), count = 1
@10,808,315us: [+0 T:0x41fbd490 S:0x41fbccac] OP - Processor_delete> Enter(proc=0x6cd78)
@10,808,411us: [+0 T:0x41fbd490 S:0x41fbcc8c] OP - doCmd> Enter (cmdId=2, proc=0x6cd78)
@10,808,510us: [+0 T:0x41fbd490 S:0x41fbcc7c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x6c1c0]
@10,808,666us: [+0 T:0x41fbd490 S:0x41fbcc8c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x6c1c0]
@10,808,787us: [+0 T:0x41fbd490 S:0x41fbcc6c] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x6c1d8] timeout[0xffffffff]
@10,808,965us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x6c1c0] status[0]
@10,809,095us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Exit (result=2)
@10,809,200us: [+0 T:0x40bc8490 S:0x40bc7d5c] OP - Processor_delete_d> Enter (proc=0x6cd78)
@10,809,302us: [+2 T:0x40bc8490 S:0x40bc7d5c] OP - Processor_delete_d> Closing remote transport...
@10,809,678us: [+2 T:0x40bc8490 S:0x40bc7d5c] OP - Processor_delete_d> Stopping DSP...
@10,809,863us: [+2 T:0x40bc8490 S:0x40bc7d5c] OP - Processor_delete_d> Closing pool...
@10,810,339us: [+2 T:0x40bc8490 S:0x40bc7d5c] OP - Processor_delete_d> Detaching from DSP...
@10,825,362us: [+2 T:0x40bc8490 S:0x40bc7d5c] OP - Processor_delete_d> Destroying DSP... (object, that is)
@10,826,172us: [+0 T:0x40bc8490 S:0x40bc7d3c] OM - Memory_free> Enter(0x6cda0, 0x0)
@10,826,314us: [+0 T:0x40bc8490 S:0x40bc7d3c] OM - Memory_free> return (0x1)
@10,826,422us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - Processor_delete_d> return
@10,826,520us: [+0 T:0x40bc8490 S:0x40bc7d64] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x6c1d8]
@10,826,693us: [+0 T:0x41fbd490 S:0x41fbcc6c] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x6c1d8] status[0]
@10,826,824us: [+0 T:0x41fbd490 S:0x41fbcc8c] OP - doCmd> Exit (result=1)
@10,826,925us: [+1 T:0x41fbd490 S:0x41fbccac] OP - Processor_delete(0x6cd78) freeing object ...
@10,827,028us: [+0 T:0x41fbd490 S:0x41fbcc8c] OM - Memory_free> Enter(0x6cd78, 0x24)
@10,827,132us: [+0 T:0x41fbd490 S:0x41fbcc8c] OM - Memory_free> return (0x1)
@10,827,229us: [+0 T:0x41fbd490 S:0x41fbccc4] OP - Processor_delete> return.
@10,827,324us: [+0 T:0x41fbd490 S:0x41fbccc4] CE - rserverClose(0x6b608) done.
@10,827,420us: [+0 T:0x41fbd490 S:0x41fbccc4] OM - Memory_free> Enter(0x6cd48, 0x2c)
@10,827,547us: [+0 T:0x41fbd490 S:0x41fbccc4] OM - Memory_free> return (0x1)
@10,828,091us: [+0 T:0x4001f960 S:0xbed47a94] OG - Global_exit> enter
@10,828,217us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x2ae48()...
@10,828,364us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x2cc08()...
@10,828,478us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> Enter(0x6c420, 0x18)
@10,828,587us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> return (0x1)
@10,828,685us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> Enter(0x6c440, 0x18)
@10,828,787us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> return (0x1)
@10,828,883us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> Enter(0x6c460, 0x18)
@10,828,984us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> return (0x1)
@10,829,082us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x37d28()...
@10,829,185us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x2fa48()...
@10,829,288us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x353d4()...
@10,829,390us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x33088()...
@10,829,488us: [+0 T:0x4001f960 S:0xbed47a64] OP - doCmd> Enter (cmdId=3, proc=0x0)
@10,829,586us: [+0 T:0x4001f960 S:0xbed47a54] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x6c1c0]
@10,829,730us: [+0 T:0x4001f960 S:0xbed47a64] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x6c1c0]
@10,829,852us: [+0 T:0x4001f960 S:0xbed47a44] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x6c1d8] timeout[0xffffffff]
@11,163,567us: [+0 T:0x40bc8490 S:0x40bc7d74] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x6c1d8]
@11,163,741us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Enter (proc=0x40bc7de8)
@11,163,866us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x6c1c0] timeout[0xffffffff]
@11,163,978us: [+0 T:0x40bc8490 S:0x40bc7d54] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x6c1c0] status[0]
@11,164,084us: [+0 T:0x40bc8490 S:0x40bc7d74] OP - getCmd_d> Exit (result=3)
@11,164,185us: [+0 T:0x40bc8490 S:0x40bc7d64] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x6c1d8]
@11,164,360us: [+0 T:0x4001f960 S:0xbed47a44] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x6c1d8] status[0]
@11,164,492us: [+0 T:0x4001f960 S:0xbed47a64] OP - doCmd> Exit (result=1)
@11,164,593us: [+0 T:0x4001f960 S:0xbed47a6c] OT - Thread_delete> Enter (task=0x6c210)
@11,164,749us: [+4 T:0x4001f960 S:0xbed47a6c] OT - Thread_delete> pthread_cancel (0x0)
@11,165,270us: [+4 T:0x4001f960 S:0xbed47a6c] OT - Thread_delete> pthread_join (0x0)
@11,165,403us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_free> Enter(0x6c210, 0x64)
@11,165,516us: [+0 T:0x4001f960 S:0xbed47a4c] OM - Memory_free> return (0x1)
@11,165,615us: [+0 T:0x4001f960 S:0xbed47a84] OT - Thread_delete> Exit (task=0x6c210)
@11,165,713us: [+0 T:0x4001f960 S:0xbed47a74] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x6c1c0]
@11,165,836us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_free> Enter(0x6c1c0, 0x14)
@11,165,950us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_free> return (0x1)
@11,166,049us: [+0 T:0x4001f960 S:0xbed47a84] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@11,166,165us: [+0 T:0x4001f960 S:0xbed47a74] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x6c1d8]
@11,166,272us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_free> Enter(0x6c1d8, 0x14)
@11,166,376us: [+0 T:0x4001f960 S:0xbed47a54] OM - Memory_free> return (0x1)
@11,166,471us: [+0 T:0x4001f960 S:0xbed47a84] ti.sdo.ce.osal.Sem - Leaving Sem_delete>
@11,166,564us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> Enter(0x6c1f0, 0x18)
@11,166,664us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> return (0x1)
@11,166,761us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x37838()...
@11,166,885us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x34e88()...
@11,166,996us: [+0 T:0x4001f960 S:0xbed47a74] OM - Memory_free> Enter(0x6c140, 0x18)
@11,167,099us: [+0 T:0x4001f960 S:0xbed47a74] OM - Memory_free> return (0x1)
@11,167,201us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x3605c()...
@11,167,329us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> Enter(0x6c0f0, 0x18)
@11,167,439us: [+0 T:0x4001f960 S:0xbed47a64] OM - Memory_free> return (0x1)
@11,167,541us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x381d4()...
@11,167,644us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x38d88()...
@11,167,744us: [+2 T:0x4001f960 S:0xbed47a94] OG - Global_exit> calling function *0x38134()...