Hi Deepali Uppal: You are right, each time when the DSP hanging, it run at: @6,001,216us: [+0 T:0x41baf490 S:0x41baea84] OC - Comm_get> Enter(queue=0x10001, msg=0x41baeb3c, timeout=-1)
and the next code is (according log): @6,021,210us: [+0 T:0x41baf490 S:0x41baea84] OC - Comm_get> MSGQ_get() status=0x8000, return (0) It seems DSPLink waiting to get a message... @6,000,282us: [+1 T:0x41baf490 S:0x41baea84] OM - Memory__getPhysicalAddress> returning physAddr=0x87965000 @6,000,443us: [+0 T:0x41baf490 S:0x41baea84] OM - Memory_getBufferPhysicalAddress> return (0x87965000) @6,000,612us: [+0 T:0x41baf490 S:0x41baeac4] CV - VISA_call(visa=0x60f90, msg=0x425d0c80): messageId=0x00023823, command=0x0 @6,000,792us: [+0 T:0x41baf490 S:0x41baea8c] OC - Comm_put> Enter(queue=0x2, msg=0x425d0c80) @6,001,036us: [+0 T:0x41baf490 S:0x41baea8c] OC - Comm_put> return (0) @6,001,216us: [+0 T:0x41baf490 S:0x41baea84] OC - Comm_get> Enter(queue=0x10001, msg=0x41baeb3c, timeout=-1) *** hang up here each time *** @6,021,210us: [+0 T:0x41baf490 S:0x41baea84] OC - Comm_get> MSGQ_get() status=0x8000, return (0) @6,021,508us: [+0 T:0x41baf490 S:0x41baea14] OC - Comm_put> Enter(queue=0x0, msg=0x425cfc80) @6,021,903us: [+0 T:0x41baf490 S:0x41baea14] OC - Comm_put> return (0) @6,022,158us: [+0 T:0x41baf490 S:0x41baea0c] OC - Comm_get> Enter(queue=0x10000, msg=0x41baeaac, timeout=-1) @6,022,541us: [+0 T:0x41baf490 S:0x41baea0c] OC - Comm_get> MSGQ_get() status=0x8000, return (0) [DSP] @7,792,696tk: [+5 T:0x8fa474e4 S:0x8fa4b8b4] CN - NODE> 0x8fa46f88(h264enc#0) call(algHandle=0x8fa47048, msg=0x8fe06c80); messageId=0x00023823 [DSP] @7,792,786tk: [+0 T:0x8fa474e4 S:0x8fa4b77c] OM - Memory_cacheInv> Enter(addr=0x87bc6000, sizeInBytes=691200) [DSP] @7,793,597tk: [+0 T:0x8fa474e4 S:0x8fa4b77c] OM - Memory_cacheInv> return [DSP] @7,793,647tk: [+0 T:0x8fa474e4 S:0x8fa4b744] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x8fa47048, inBufs=0x8fa4b7e4, outBufs=0x8fa4b8b4, inArgs=0x8fe06e04, outArgs=0x8fe06e10) [DSP] @7,793,754tk: [+5 T:0x8fa474e4 S:0x8fa4b724] CV - VISA_enter(visa=0x8fa47048): algHandle = 0x8fa47078 [DSP] @7,793,813tk: [+0 T:0x8fa474e4 S:0x8fa4b704] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fa47078) [DSP] @7,793,876tk: [+0 T:0x8fa474e4 S:0x8fa4b704] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit [DSP] @7,836,543tk: [+5 T:0x8fa474e4 S:0x8fa4b724] CV - VISA_exit(visa=0x8fa47048): algHandle = 0x8fa47078 [DSP] @7,836,637tk: [+0 T:0x8fa474e4 S:0x8fa4b704] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fa47078) [DSP] @7,836,707tk: [+0 T:0x8fa474e4 S:0x8fa4b704] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit [DSP] @7,836,763tk: [+0 T:0x8fa474e4 S:0x8fa4b744] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x8fa47048, retVal=0x0) [DSP] @7,836,836tk: [+0 T:0x8fa474e4 S:0x8fa4b77c] OM - Memory_cacheWb> Enter(addr=0x87965000, sizeInBytes=345600) [DSP] @7,837,300tk: [+0 T:0x8fa474e4 S:0x8fa4b77c] OM - Memory_cacheWb> return Cap: Complete cap 02 frame at:84300000 691200 [DSP] @7,837,345tk: [+5 T:0x8fa474e4 S:0x8fa4b8b4] CN - NODE> returned from call(algHandle=0x8fa47048, msg=0x8fe06c80); messageId=0x00023823 [DSP] @7,841,122tk: [+0 T:0x8fa424e4 S:0x8fa464a4] CR - processRmsCmd(0x8fe05ca8, 4056): cmd = 5 [DSP] @7,841,179tk: [+0 T:0x8fa424e4 S:0x8fa464a4] CR - remote time = 0x0, trace buffer size = 4032 @6,451,400us: [+0 T:0x41baf490 S:0x41baea44] CE - Engine_fwriteTrace> returning count [1869] @6,497,514us: [+0 T:0x41baf490 S:0x41baeac4] CV - VISA_call Completed: messageId=0x00023823, command=0x0, return(status=0) @6,497,759us: [+0 T:0x41baf490 S:0x41baeaa4] OM - Memory_getBufferVirtualAddress> Enter(physAddr=0x87965000, size=345600) -----Original Message----- From: davinci-linux-open-source-bounces+adscrz=gmail....@linux.davincidsp.com [mailto:davinci-linux-open-source-bounces+adscrz=gmail....@linux.davincidsp.com] On Behalf Of Uppal, Deepali Sent: Wednesday, September 23, 2009 3:54 PM To: Dasheng Li; '[email protected]' Subject: RE: DSP hang when run DVSDK Demo in DM6446 Hello, I do not know why the DSP is hanging. But I can give an explanation for the crash dump seen after CTRL C. DSPLink has a signal handler registered by default which clean up the DSPLink driver when process termination signals are sent to any process/thread which is using the driver on the Linux operating system. When you pressed CTRL C, the below crash dump has occurred because a thread in user space is waiting on notification of events in the kernel driver. Since the kernel semaphore on which the thread is waiting is deleted in the signal handler, a crash is seen. Thanks and Regards, Deepali Uppal DSP/BIOS Link Platform Support Products -----Original Message----- From: [email protected] [mailto:[email protected]] On Behalf Of Dasheng Li Sent: Wednesday, September 23, 2009 11:54 AM To: '[email protected]' Subject: DSP hang when run DVSDK Demo in DM6446 Hi All: I running encode demo with dvsdk_demos_2_00_00_07 in dvsdk_2_00_00_22, But system no respond after capture and encode some frame, It seems the DSP hand after running with CE_DEBUG=2 Lots of error message come out after press Ctrl+C. Below is the detail: 1, run: loadmodules.sh CMEMK module: built on Sep 21 2009 at 15:23:09 Reference Linux version 2.6.18 File /mnt/sdb/dvsdk_2_00_00_22/linuxutils_2_23_01/packages/ti/sdo/linuxutils/cmem/src/module/cmemk.c ioremap_nocache(0x87600000, 10485760)=0xc8000000 allocated heap buffer 0xc8000000 of size 0x2c000 cmem initialized 5 pools between 0x87600000 and 0x88000000 dsplinkk: no version for "struct_module" found: kernel tainted. DSPLINK Module (1.61.03) created on Date: Jul 17 2009 Time: 00:44:40 2, run : ./encode -v test.264 Encode demo started. imageWidth:720 imageHeight:480 Cap: Complete cap 00 frame at:86F00000 691200 Cap: Complete cap 01 frame at:85000000 691200 Video: Complete get 00 frame at:87BC6000 691200 Start Venc1, In:87BC6000 Out:87965000 Venc1 completed successful. Write: Complete get 00 frame at:87965000 345600 Write End. Cap: Complete cap 02 frame at:85100000 691200 Video: Complete get 01 frame at:87AFB000 691200 Start Venc1, In:87AFB000 Out:8789A000 Venc1 completed successful. Write: Complete get 01 frame at:8789A000 345600 Write End. ... Write: Complete get 12 frame at:87965000 345600 Write End. Cap: Complete cap 14 frame at:85100000 691200 Video: Complete get 13 frame at:87AFB000 691200 Start Venc1, In:87AFB000 Out:8789A000 Cap: Complete cap 15 frame at:86F00000 691200 *** Halt here, below message come out after press Ctrl+C *** Unable to handle kernel paging request at virtual address c797e010 pgd = c6ea0000 [c797e010] *pgd=80442011, *pte=00000000, *ppte=00000000 Internal error: Oops: 7 [#1] Modules linked in: dsplinkk cmemk davinci_capture mt9t001 tvp5146 CPU: 0 PC is at SYNC_WaitSEM+0x234/0x32c [dsplinkk] LR is at flush_signals+0x64/0x90 pc : [<bf01d710>] lr : [<c0053ae4>] Tainted: GF sp : c53fbe38 ip : c53fbe20 fp : c53fbe84 r10: ffffffff r9 : c0041680 r8 : c797e008 r7 : c53fbe44 r6 : c797e000 r5 : c53fa000 r4 : 00000002 r3 : 00000001 r2 : 00000000 r1 : c6503254 r0 : c6503254 Flags: nZCv IRQs on FIQs on Mode SVC_32 Segment user Control: 5317F Table: 86EA0000 DAC: 00000015 Process encode (pid: 941, stack limit = 0xc53fa258) Stack: (0xc53fbe38 to 0xc53fc000) be20: c7a09c80 00008000 be40: c53fbe5c 00000001 c0544d60 c0041680 c797e008 c797e008 bf025784 00000000 be60: 00008000 c53fbef4 c797a000 ffffffff 80008051 bf0325c8 c53fbeb4 c53fbe88 be80: bf021810 bf01d4ec bf021938 00006f0b 43641a94 00006f0b 00000008 c64fd180 bea0: c53fa000 00000000 c53fbec4 c53fbeb8 bf018a7c bf021790 c53fbf24 c53fbec8 bec0: bf018400 bf018a7c 00000026 c53fbef0 c53fbf24 c53fbee0 c013f988 c013e108 bee0: c53fbf04 c0142cfc c74f600c 00000026 00000049 00000000 00008000 00000000 bf00: 00010003 ffffffff 00000000 8789a000 c64fd180 43641a94 c53fbf44 c53fbf28 bf20: c00a169c bf01809c c6458558 c64fd180 00000008 43641a94 c53fbf74 c53fbf48 bf40: c00a197c c00a1630 c008c878 c00ba328 00000000 00000000 43641a94 00006f0b bf60: c64fd180 c53fa000 c53fbfa4 c53fbf78 c00a1a08 c00a16c8 00000000 00000001 bf80: c53fbfac ffffffff 0005d5ac 43641b3c 00000036 c0031fa8 00000000 c53fbfa8 bfa0: c0031e00 c00a19b4 ffffffff 0005d5ac 00000008 00006f0b 43641a94 00000008 bfc0: ffffffff 0005d5ac 43641b3c 00000036 00010003 00001d68 0005df68 43641a7c bfe0: 0005f314 436419a8 00031c10 4026650c 60000010 00000008 300c0363 353c33e6 Backtrace: [<bf01d4dc>] (SYNC_WaitSEM+0x0/0x32c [dsplinkk]) from [<bf021810>] (LDRV_MSGQ_get+0x90/0xd0 [dsplinkk]) [<bf021780>] (LDRV_MSGQ_get+0x0/0xd0 [dsplinkk]) from [<bf018a7c>] (PMGR_MSGQ_get+0x10/0x14 [dsplinkk]) [<bf018a6c>] (PMGR_MSGQ_get+0x0/0x14 [dsplinkk]) from [<bf018400>] (DRV_Ioctl+0x374/0x9a0 [dsplinkk]) [<bf01808c>] (DRV_Ioctl+0x0/0x9a0 [dsplinkk]) from [<c00a169c>] (do_ioctl+0x7c/0x98) r5 = 43641A94 r4 = C64FD180 [<c00a1620>] (do_ioctl+0x0/0x98) from [<c00a197c>] (vfs_ioctl+0x2c4/0x2ec) r6 = 43641A94 r5 = 00000008 r4 = C64FD180 [<c00a16b8>] (vfs_ioctl+0x0/0x2ec) from [<c00a1a08>] (sys_ioctl+0x64/0x8c) r9 = C53FA000 r8 = C64FD180 r6 = 00006F0B r5 = 43641A94 r4 = 00000000 [<c00a19a4>] (sys_ioctl+0x0/0x8c) from [<c0031e00>] (ret_fast_syscall+0x0/0x2c) r8 = C0031FA8 r7 = 00000036 r6 = 43641B3C r5 = 0005D5AC r4 = FFFFFFFF Code: e5834000 e5953004 e2833001 e5853004 (e5963010) <6>note: encode[941] exited with preempt_count 1 prev->state: 2 != TASK_RUNNING?? encode/941[CPU#0]: BUG in __schedule at kernel/sched.c:3826 [email protected]:/dm6446# Below are the message with CE_DEBUG=2 CE_DEBUG=2 ./encode -v test.264 Encode demo started. @0,426,725us: [+4 T:0x4001e950] OG - Global_init> This program was built with the following packages: @0,427,327us: [+4 T:0x4001e950] OG - package gnu.targets.rts470MV (/mnt/sdb/Ti/xdctools_3_10_03/packages/gnu/targets/rts470MV/) [1,0,0,0,1225517438755] @0,427,555us: [+4 T:0x4001e950] OG - package ti.sdo.codecs.h264enc (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264enc/) [1,0,0,1247800706000] @0,427,702us: [+4 T:0x4001e950] OG - package ti.sdo.codecs.mpeg4enc (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg4enc/) [1,0,0,1247800734000] @0,427,833us: [+4 T:0x4001e950] OG - package ti.sdo.codecs.g711enc (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711enc/) [1,0,0,1247800687000] @0,428,023us: [+4 T:0x4001e950] OG - package ti.sdo.ce.global (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464] @0,428,165us: [+4 T:0x4001e950] OG - package ti.xdais.dm (/mnt/sdb/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/dm/) [1,0,5,1236972452910] @0,428,291us: [+4 T:0x4001e950] OG - package ti.sdo.utils.trace (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890] @0,428,425us: [+4 T:0x4001e950] OG - package ti.sdo.ce.utils.xdm (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490] @0,428,553us: [+4 T:0x4001e950] OG - package dsplink.gpp (/mnt/sdb/dvsdk_2_00_00_22/dsplink-1_61_03-prebuilt/packages/dsplink/gpp/) [5,0,0,1239931267000] @0,428,680us: [+4 T:0x4001e950] OG - package ti.sdo.linuxutils.cmem (/mnt/sdb/dvsdk_2_00_00_22/linuxutils_2_23_01/packages/ti/sdo/linuxutils/cmem/) [2,2,0,1240253001679] @0,428,806us: [+4 T:0x4001e950] OG - package ti.xdais (/mnt/sdb/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/) [1,2,1,1236972427008] @0,428,928us: [+4 T:0x4001e950] OG - package ti.sdo.ce.node (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858] @0,429,051us: [+4 T:0x4001e950] OG - package ti.sdo.fc.global (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/global/) [1,0,0,1240266696499] @0,429,183us: [+4 T:0x4001e950] OG - package ti.sdo.fc.dman3 (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662] @0,429,312us: [+4 T:0x4001e950] OG - package ti.sdo.fc.memutils (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007] @0,429,438us: [+4 T:0x4001e950] OG - package ti.sdo.fc.acpy3 (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108] @0,429,679us: [+4 T:0x4001e950] OG - package gnu.targets (/mnt/sdb/Ti/xdctools_3_10_03/packages/gnu/targets/) [1,0,1,1225517427930] @0,429,837us: [+4 T:0x4001e950] OG - package ti.catalog.c470 (/mnt/sdb/Ti/xdctools_3_10_03/packages/ti/catalog/c470/) [1,0,1,0,0] @0,429,975us: [+4 T:0x4001e950] OG - package ti.platforms.evmDM6446 (/mnt/sdb/Ti/xdctools_3_10_03/packages/ti/platforms/evmDM6446/) [1,0,0,1,0] @0,430,103us: [+4 T:0x4001e950] OG - package ti.sdo.ce.osal (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,1240276730877] @0,430,229us: [+4 T:0x4001e950] OG - package ti.sdo.ce.osal.linux (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/linux/) [2,0,1,1240276736840] @0,430,359us: [+4 T:0x4001e950] OG - package ti.sdo.ce.ipc (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961] @0,430,484us: [+4 T:0x4001e950] OG - package ti.sdo.ce.ipc.dsplink (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/) [2,0,1,1240276714152] @0,430,612us: [+4 T:0x4001e950] OG - package ti.sdo.ce.alg (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798] @0,430,738us: [+4 T:0x4001e950] OG - package ti.sdo.ce (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491] @0,889,537us: [+4 T:0x4001e950] OG - package ti.sdo.ce.video1 (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video1/) [1,0,2,1240276935900] @0,889,808us: [+4 T:0x4001e950] OG - package ti.sdo.codecs.h264enc.ce (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1247800710000] @0,889,959us: [+4 T:0x4001e950] OG - package ti.sdo.codecs.mpeg4enc.ce (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg4enc/ce/) [1,0,0,1247800738000] @0,890,096us: [+4 T:0x4001e950] OG - package ti.sdo.ce.speech1 (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/speech1/) [1,0,1,1240276763928] @0,890,228us: [+4 T:0x4001e950] OG - package ti.sdo.codecs.g711enc.ce (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711enc/ce/) [1,0,0,1247800691000] @0,890,358us: [+4 T:0x4001e950] OG - package ti.sdo.ce.speech (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/speech/) [1,0,2,1240276762193] @0,890,484us: [+4 T:0x4001e950] OG - package ti.sdo.ce.audio (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/audio/) [1,0,2,1240276296374] @0,890,610us: [+4 T:0x4001e950] OG - package ti.sdo.ce.audio1 (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/audio1/) [1,0,1,1240276296900] @0,890,735us: [+4 T:0x4001e950] OG - package ti.sdo.ce.video (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video/) [1,0,3,1240276930771] @0,890,893us: [+4 T:0x4001e950] OG - package ti.sdo.ce.video2 (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video2/) [1,0,2,1240276933444] @0,891,027us: [+4 T:0x4001e950] OG - package ti.sdo.ce.image (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/image/) [1,0,3,1240276700525] @0,891,163us: [+4 T:0x4001e950] OG - package ti.sdo.ce.image1 (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/image1/) [1,0,1,1240276698808] @0,891,290us: [+4 T:0x4001e950] OG - package ti.sdo.dmai (/mnt/sdb/dvsdk_2_00_00_22/dmai_1_20_00_06/packages/ti/sdo/dmai/) [1,0,0,1253517803000] @0,891,413us: [+4 T:0x4001e950] OG - package ti.sdo.simplewidget (/mnt/sdb/dvsdk_2_00_00_22/dvsdk_demos_2_00_00_07/packages/ti/sdo/simplewidget/) [] @0,891,537us: [+4 T:0x4001e950] OG - package ti.sdo.ce.bioslog (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/bioslog/) [1,0,1,1240276303166] @0,891,661us: [+4 T:0x4001e950] OG - package ti.sdo.ce.utils.trace (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/trace/) [1,0,1,1240276915917] @0,891,787us: [+4 T:0x4001e950] OG - package encode_config (/mnt/sdb/dvsdk_2_00_00_22/dvsdk_demos_2_00_00_07/dm6446/encode/encode_config/) [] @0,892,726us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Sem_create> count: 0 @0,893,003us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x601c0] @0,893,166us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Sem_create> count: 0 @0,893,303us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x601d8] @0,893,447us: [+0 T:0x4001e950] OT - Thread_create> Enter (fxn=0x2b144, attrs=0x0) @0,894,327us: [+0 T:0x4001e950] OT - Thread_create> Exit (task=0x60210) @0,894,634us: [+0 T:0x4001e950] ti.sdo.ce.alg - ALG_init> Enter @0,894,791us: [+0 T:0x4001e950] ti.sdo.ce.alg - ALG_init> Exit @0,899,532us: [+1 T:0x40baf490] OP - daemon> thread created. @0,900,497us: [+0 T:0x40baf490] OP - getCmd_d> Enter (proc=0x40baedf0) @0,900,659us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x601c0] timeout[0xffffffff] @0,901,514us: [+6 T:0x4001e950] CE - Engine_init> CE debugging on (CE_DEBUG=2; allowed CE_DEBUG levels: 1=min, 2=good, 3=max) @0,901,919us: [+0 T:0x4001e950] CS - Server_init() @0,902,067us: [+0 T:0x4001e950] CS - Server_init> Global_useLinkArbiter = 0 TraceUtil_start> note: CE_DEBUG env. var is set, so TraceUtil is not active (unset CE_DEBUG if you need TraceUtil) imageWidth:720 imageHeight:480 @1,250,586us: [+2 T:0x413af490] ti.sdo.dmai - [Capture] Set video standard to V4L2_STD_MT9T001_480p_30FPS @1,250,835us: [+2 T:0x413af490] ti.sdo.dmai - [Capture] Capture input set to COMPOSITE @1,255,039us: [+2 T:0x413af490] ti.sdo.dmai - [Capture] Video input connected size 720x480 pitch 1440 @1,255,217us: [+7 T:0x413af490] ti.sdo.dmai - [Capture] Using V4L2 driver's buffer... @1,255,505us: [+2 T:0x413af490] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers @1,256,071us: [+2 T:0x413af490] ti.sdo.dmai - [Buffer] Set user pointer 0x413b0000 (physical 0x86f00000) @1,272,103us: [+2 T:0x413af490] ti.sdo.dmai - [Dmai] Driver buffer 0 mapped to 0x413b0000 has physical address 0x86f00000 @1,272,618us: [+2 T:0x413af490] ti.sdo.dmai - [Buffer] Set user pointer 0x41461000 (physical 0x85000000) @1,288,520us: [+2 T:0x413af490] ti.sdo.dmai - [Dmai] Driver buffer 1 mapped to 0x41461000 has physical address 0x85000000 @1,288,973us: [+2 T:0x413af490] ti.sdo.dmai - [Buffer] Set user pointer 0x41512000 (physical 0x85100000) @1,304,938us: [+2 T:0x413af490] ti.sdo.dmai - [Dmai] Driver buffer 2 mapped to 0x41512000 has physical address 0x85100000 @1,318,417us: [+0 T:0x41dc2490] CE - Engine_open> Enter('encode', 0x0, 0x41dc1d34) @1,318,637us: [+0 T:0x41dc2490] CE - rserverOpen('encodeCombo.x64P'), count = 0 @1,318,791us: [+0 T:0x41dc2490] OP - Processor_create> Enter(imageName='encodeCombo.x64P', linkCfg='(null)', attrs=0x41dc1d18) @1,320,369us: [+0 T:0x41dc2490] OP - doCmd> Enter (cmdId=1, proc=0x60bc0) @1,320,562us: [+0 T:0x41dc2490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x601c0] @1,320,783us: [+0 T:0x41dc2490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x601c0] @1,320,939us: [+0 T:0x41dc2490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x601d8] timeout[0xffffffff] @1,321,126us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x601c0] status[0] @1,321,283us: [+0 T:0x40baf490] OP - getCmd_d> Exit (result=1) @1,321,411us: [+0 T:0x40baf490] OP - Processor_create_d> Enter(proc=0x60bc0) @1,321,536us: [+2 T:0x40baf490] OP - Processor_create_d> Initializing DSP PROC... @1,321,671us: [+2 T:0x40baf490] OP - Processor_create_d> Using DspLink config data for entry #0 [server 'encodeCombo.x64P'] @1,321,948us: [+2 T:0x40baf490] OP - Processor_create_d> Adding DSP segment #0 to Link configuration: name='DDR2', startAddress=0x8fa00000, sizeInBytes=0x400000, shared=1, syncd=0 @1,322,153us: [+2 T:0x40baf490] OP - Processor_create_d> Adding DSP segment #1 to Link configuration: name='DSPLINKMEM', startAddress=0x8fe00000, sizeInBytes=0x100000, shared=1, syncd=0 @1,322,332us: [+2 T:0x40baf490] OP - Processor_create_d> Adding DSP segment #2 to Link configuration: name='RESET_VECTOR', startAddress=0x8ff00000, sizeInBytes=0x80, shared=1, syncd=0 @1,322,501us: [+2 T:0x40baf490] OP - Processor_create_d> Adding DSP segment #3 to Link configuration: name='DDRALGHEAP', startAddress=0x88000000, sizeInBytes=0x7a00000, shared=0, syncd=0 @1,322,669us: [+2 T:0x40baf490] OP - Processor_create_d> DODSPCTRL was=1; now=0 @1,332,338us: [+2 T:0x40baf490] OP - Processor_create_d> Attaching to DSP PROC... @1,342,855us: [+2 T:0x40baf490] OP - Processor_create_d> Opening MSGQ pool... @1,343,629us: [+2 T:0x40baf490] OP - Processor_create_d> Loading encodeCombo.x64P on DSP (1 args)... @1,545,869us: [+2 T:0x40baf490] OP - Processor_create_d> Starting DSP PROC... @1,600,005us: [+2 T:0x40baf490] OP - Processor_create_d> Opening remote transport... @1,601,085us: [+2 T:0x40baf490] OP - Processor_create_d> return (1) @1,601,288us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x601d8] @1,601,500us: [+0 T:0x41dc2490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x601d8] status[0] @1,601,663us: [+0 T:0x41dc2490] OP - doCmd> Exit (result=1) @1,601,794us: [+0 T:0x41dc2490] OP - Processor_create> return (0x60bc0) @1,601,954us: [+0 T:0x41dc2490] CE - rserverOpen('encodeCombo.x64P'): 0x5f2b4 done. @1,603,032us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x601d8] @1,603,231us: [+0 T:0x40baf490] OP - getCmd_d> Enter (proc=0x40baedf0) @1,603,408us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x601c0] timeout[0xffffffff] @1,603,842us: [+0 T:0x41dc2490] CE - checkServer(0x60b90) @1,604,361us: [+0 T:0x41dc2490] CE - rmsInit> RMS initialized(0x60b90); CE_DEBUG on, setting DSP trace mask to *+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3 @1,604,574us: [+0 T:0x41dc2490] CE - Engine_setTrace> Enter(engine=0x60b90, mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3') @1,604,794us: [+1 T:0x41dc2490] CE - Engine_setTrace> Requesting DSP set trace ... @1,606,451us: [+0 T:0x41dc2490] CE - Engine_setTrace> return(0) [DSP] @0,011,862tk: [+0 T:0x8fa424e4] OG - Global_setSpecialTrace> enter(mask='*+01234567,CR=67,ti.sdo.fc.dman3-2,ti.sdo.fc.dskt2-2,GT_prefix=1235,GT_time=3') [DSP] @0,011,969tk: [+4 T:0x8fa424e4] OG - Global_setSpecialTrace> This program was built with the following packages: [DSP] @0,012,021tk: [+4 T:0x8fa424e4] OG - package ti.targets.rts6000 (/mnt/sdb/Ti/xdctools_3_10_03/packages/ti/targets/rts6000/) [1,0,0,0,1225517497925] [DSP] @0,012,095tk: [+4 T:0x8fa424e4] OG - package ti.sdo.codecs.h264enc (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264enc/) [1,0,0,1247800706000] [DSP] @0,012,171tk: [+4 T:0x8fa424e4] OG - package ti.sdo.codecs.mpeg4enc (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg4enc/) [1,0,0,1247800734000] [DSP] @0,012,247tk: [+4 T:0x8fa424e4] OG - package ti.sdo.codecs.g711enc (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711enc/) [1,0,0,1247800687000] [DSP] @0,012,323tk: [+4 T:0x8fa424e4] OG - package ti.sdo.fc.global (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/global/) [1,0,0,1240266696499] [DSP] @0,012,396tk: [+4 T:0x8fa424e4] OG - package ti.sdo.fc.dman3 (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/dman3/) [1,0,4,1240266658662] [DSP] @0,012,469tk: [+4 T:0x8fa424e4] OG - package ti.rtdx (/mnt/sdb/Ti/bios_5_33_03/packages/ti/rtdx/) [2,0,0,4,1219531643983] [DSP] @0,012,525tk: [+4 T:0x8fa424e4] OG - package ti.psl (/mnt/sdb/Ti/bios_5_33_03/packages/ti/psl/) [5,0,0,0,0] [DSP] @0,012,577tk: [+4 T:0x8fa424e4] OG - package ti.bios (/mnt/sdb/Ti/bios_5_33_03/packages/ti/bios/) [5,2,5,6,1227035764854] [DSP] @0,012,633tk: [+4 T:0x8fa424e4] OG - package ti.sdo.fc.dskt2 (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/dskt2/) [1,0,4,1240266678055] [DSP] @0,012,705tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.global (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/global/) [1,0,0,1240276693464] [DSP] @0,012,776tk: [+4 T:0x8fa424e4] OG - package ti.xdais.dm (/mnt/sdb/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/dm/) [1,0,5,1236972452910] [DSP] @0,012,839tk: [+4 T:0x8fa424e4] OG - package ti.xdais (/mnt/sdb/dvsdk_2_00_00_22/xdais_6_23/packages/ti/xdais/) [1,2,1,1236972427008] [DSP] @0,012,899tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.node (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/node/) [1,0,0,1240276734858] [DSP] @0,012,969tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.ipc.dsplink.dsp (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,0,1,1240276720026] [DSP] @0,013,046tk: [+4 T:0x8fa424e4] OG - package ti.sdo.utils.trace (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/utils/trace/) [1,0,0,1240266922890] [DSP] @0,013,121tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.utils.xdm (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/utils/xdm/) [1,0,2,1240276919490] [DSP] @0,013,193tk: [+4 T:0x8fa424e4] OG - package ti.sdo.fc.memutils (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/memutils/) [1,0,0,1240266801007] [DSP] @0,013,268tk: [+4 T:0x8fa424e4] OG - package ti.sdo.fc.acpy3 (/mnt/sdb/dvsdk_2_00_00_22/framework_components_2_23_01/packages/ti/sdo/fc/acpy3/) [1,0,4,1240266659108] [DSP] @0,013,341tk: [+4 T:0x8fa424e4] OG - package dsplink.dsp (/mnt/sdb/dvsdk_2_00_00_22/dsplink-1_61_03-prebuilt/packages/dsplink/dsp/) [1,4,0,1239931280000] [DSP] @0,013,410tk: [+4 T:0x8fa424e4] OG - package ti.bios.utils (/mnt/sdb/dvsdk_2_00_00_22/biosutils_1_01_00/packages/ti/bios/utils/) [2,0,1,0,0] [DSP] @0,013,472tk: [+4 T:0x8fa424e4] OG - package ti.catalog.c6000 (/mnt/sdb/Ti/xdctools_3_10_03/packages/ti/catalog/c6000/) [1,0,0,0,0] [DSP] @0,013,533tk: [+4 T:0x8fa424e4] OG - package ti.platforms.evmDM6446 (/mnt/sdb/Ti/bios_5_33_03/packages/ti/platforms/evmDM6446/) [1,0,0,1,0] [DSP] @0,013,597tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.osal (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/) [2,0,2,1240276730877] [DSP] @0,013,666tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.osal.bios (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/osal/bios/) [2,0,1,1240276734107] [DSP] @0,013,738tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.ipc (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/) [2,0,1,1240276698961] [DSP] @0,013,806tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.ipc.bios (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/ipc/bios/) [2,0,1,1240276705217] [DSP] @0,013,878tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.alg (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/alg/) [1,0,1,1240276276798] [DSP] @0,013,946tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/) [1,0,6,1240276276491] [DSP] @0,014,012tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.bioslog (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/bioslog/) [1,0,1,1240276303166] [DSP] @0,014,082tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.video1 (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/video1/) [1,0,2,1240276935900] [DSP] @0,014,153tk: [+4 T:0x8fa424e4] OG - package ti.sdo.codecs.h264enc.ce (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/h264enc/ce/) [1,0,0,1247800710000] [DSP] @0,014,230tk: [+4 T:0x8fa424e4] OG - package ti.sdo.codecs.mpeg4enc.ce (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/mpeg4enc/ce/) [1,0,0,1247800738000] [DSP] @0,014,309tk: [+4 T:0x8fa424e4] OG - package ti.sdo.ce.speech1 (/mnt/sdb/dvsdk_2_00_00_22/codec_engine_2_23_01/packages/ti/sdo/ce/speech1/) [1,0,1,1240276763928] [DSP] @0,014,380tk: [+4 T:0x8fa424e4] OG - package ti.sdo.codecs.g711enc.ce (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/codecs/g711enc/ce/) [1,0,0,1247800691000] [DSP] @0,014,463tk: [+4 T:0x8fa424e4] OG - package ti.sdo.servers.encode (/mnt/sdb/dvsdk_2_00_00_22/dm6446_dvsdk_combos_2_05/packages/ti/sdo/servers/encode/) [] [DSP] @0,014,532tk: [+0 T:0x8fa424e4] OG - Global_setSpecialTrace> return @1,957,270us: [+0 T:0x41dc2490] CE - Engine_fwriteTrace> returning count [6368] @2,297,499us: [+0 T:0x41dc2490] CE - Engine_open> return(396176) @2,297,689us: [+2 T:0x41dc2490] ti.sdo.dmai - [Venc1] Creating encoder h264enc for max 720x480 bitrate 2000000 ratectrl 4 @2,297,966us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x60b90, name='h264enc', params=0x41dc1dd8) @2,298,162us: [+0 T:0x41dc2490] CV - VISA_create(0x60b90, 'h264enc', 0x41dc1dd8, 0x2496, 'ti.sdo.ce.video1.IVIDENC1') @2,298,326us: [+0 T:0x41dc2490] CV - VISA_create2(0x60b90, 'h264enc', 0x41dc1dd8, 0x30, 0x2496, 'ti.sdo.ce.video1.IVIDENC1') @2,298,515us: [+0 T:0x41dc2490] CE - Engine_createNode(0x60b90, 'h264enc', 2496, 0x41dc1dd8, 0x30, 0x41dc1bec) @2,298,674us: [+0 T:0x41dc2490] CE - Engine> allocNode Enter(engine=0x60b90, impId='h264enc') @2,298,881us: [+0 T:0x41dc2490] CE - Engine> allocNode(). Calling Comm_create(gppfromnode_927_1, 0x60e28, NULL) @2,310,514us: [+4 T:0x41dc2490] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=0x60fc8, algName='h264enc', rmsNode=0x8fa46fa0, algHandle=0x8fa47088) [DSP] @1,623,337tk: [+0 T:0x8fa424e4] OM - Memory_alloc> Enter(size=0x18) [DSP] @1,623,376tk: [+0 T:0x8fa424e4] OM - Memory_alloc> return (0x8fa46fa0) [DSP] @1,623,419tk: [+0 T:0x8fa424e4] OM - Memory_alloc> Enter(size=0xa) [DSP] @1,623,455tk: [+0 T:0x8fa424e4] OM - Memory_alloc> return (0x8fa46fb8) [DSP] @1,623,502tk: [+0 T:0x8fa424e4] OM - Memory_alloc> Enter(size=0x20) [DSP] @1,623,539tk: [+0 T:0x8fa424e4] OM - Memory_alloc> return (0x8fa46fc8) [DSP] @1,623,581tk: [+0 T:0x8fa424e4] OM - Memory_alloc> Enter(size=0x24) [DSP] @1,623,619tk: [+0 T:0x8fa424e4] OM - Memory_alloc> return (0x8fa46fe8) [DSP] @1,623,685tk: [+0 T:0x8fa424e4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> Enter (engine=0x0, name='h264enc', params=0x8fe05cc0) [DSP] @1,623,755tk: [+0 T:0x8fa424e4] CV - VISA_create(0x0, 'h264enc', 0x8fe05cc0, 0x2496, 'ti.sdo.ce.video1.IVIDENC1') [DSP] @1,623,817tk: [+0 T:0x8fa424e4] CV - VISA_create2(0x0, 'h264enc', 0x8fe05cc0, 0x30, 0x2496, 'ti.sdo.ce.video1.IVIDENC1') [DSP] @1,623,894tk: [+0 T:0x8fa424e4] CE - Engine_open> Enter('local', 0x8fa461e4, 0x8fe05cc0) [DSP] @1,623,944tk: [+0 T:0x8fa424e4] OM - Memory_alloc> Enter(size=0x2c) [DSP] @1,623,982tk: [+0 T:0x8fa424e4] OM - Memory_alloc> return (0x8fa47058) [DSP] @1,624,031tk: [+0 T:0x8fa424e4] CE - Engine_open> return(-1885048744) [DSP] @1,624,081tk: [+0 T:0x8fa424e4] OM - Memory_alloc> Enter(size=0x30) [DSP] @1,624,117tk: [+0 T:0x8fa424e4] OM - Memory_alloc> return (0x8fa47088) [DSP] @1,624,162tk: [+0 T:0x8fa424e4] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x8fa62f38, idma3Fxns=0x8fa62f64, iresFxns=0x0, params=0x8fe05cc0, attrs=0x8fa462f8) [DSP] @1,624,249tk: [+0 T:0x8fa424e4] OM - Memory_alloc> Enter(size=0x10) [DSP] @1,624,286tk: [+0 T:0x8fa424e4] OM - Memory_alloc> return (0x8fa470b8) [DSP] @1,647,314tk: [+0 T:0x8fa424e4] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x8fa470b8) [DSP] @1,647,370tk: [+5 T:0x8fa424e4] CV - VISA_create> local codec created (name='h264enc', handle=0x8fa470b8) [DSP] @1,647,426tk: [+0 T:0x8fa424e4] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x8fa47088) [DSP] @1,647,483tk: [+4 T:0x8fa424e4] OT - Thread_create > name: "h264enc#0", pri: -1, stack size: 16384, stack seg: 0 @2,314,261us: [+0 T:0x41dc2490] CE - Engine_fwriteTrace> returning count [2223] @2,314,421us: [+2 T:0x41dc2490] CE - Engine_createNode> Returning 0x60e20 @2,314,681us: [+5 T:0x41dc2490] CV - VISA_create> remote codec created (name='h264enc', localQueueID=0x10001, remoteQueueID=0x0002) @2,314,866us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_create> return (0x60f90) @2,315,009us: [+2 T:0x41dc2490] ti.sdo.dmai - [Venc1] Setting dynParams size 720x480 bitrate 2000000 @2,315,153us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x60f90, id=1, dynParams=0x41dc1da8 (size=0x30), status=0x41dc1cb0 (size=0x9c) @2,315,320us: [+5 T:0x41dc2490] CV - VISA_allocMsg> Allocating message for messageId=0x00023815 @2,655,907us: [+0 T:0x41dc2490] CV - VISA_call(visa=0x60f90, msg=0x425d0c80): messageId=0x00023815, command=0x1 [DSP] @2,450,863tk: [+5 T:0x8fa47524] CN - NODE> 0x8fa46fc8(h264enc#0) call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023815 [DSP] @2,450,945tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fa47088, id=1, dynParams=0x8fe06cb4 (size=0x30), status=0x8fe06ce4 (size=0x9c) [DSP] @2,451,037tk: [+5 T:0x8fa47524] CV - VISA_enter(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @2,451,089tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fa470b8) [DSP] @2,451,211tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit [DSP] @2,451,305tk: [+5 T:0x8fa47524] CV - VISA_exit(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @2,451,367tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fa470b8) [DSP] @2,451,424tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit [DSP] @2,451,468tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fa47088, retVal=0x0) [DSP] @2,451,529tk: [+5 T:0x8fa47524] CN - NODE> returned from call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023815 @2,658,608us: [+0 T:0x41dc2490] CE - Engine_fwriteTrace> returning count [1144] @2,658,800us: [+0 T:0x41dc2490] CV - VISA_call Completed: messageId=0x00023815, command=0x1, return(status=0) @2,658,964us: [+5 T:0x41dc2490] CV - VISA_freeMsg(0x60f90, 0x425d0c80): Freeing message with messageId=0x00023815 @2,659,115us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x60f90, retVal=0x0) @2,659,256us: [+2 T:0x41dc2490] ti.sdo.dmai - [Venc1] Made XDM_SETPARAMS control call @2,659,378us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x60f90, id=5, dynParams=0x41dc1da8 (size=0x30), status=0x41dc1cb0 (size=0x9c) @2,659,542us: [+5 T:0x41dc2490] CV - VISA_allocMsg> Allocating message for messageId=0x00023816 @2,659,808us: [+0 T:0x41dc2490] CV - VISA_call(visa=0x60f90, msg=0x425d0c80): messageId=0x00023816, command=0x1 [DSP] @2,459,831tk: [+5 T:0x8fa47524] CN - NODE> 0x8fa46fc8(h264enc#0) call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023816 [DSP] @2,459,903tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Enter (handle=0x8fa47088, id=5, dynParams=0x8fe06cb4 (size=0x30), status=0x8fe06ce4 (size=0x9c) [DSP] @2,459,993tk: [+5 T:0x8fa47524] CV - VISA_enter(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @2,460,045tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fa470b8) [DSP] @2,460,096tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit [DSP] @2,460,147tk: [+5 T:0x8fa47524] CV - VISA_exit(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @2,460,198tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fa470b8) [DSP] @2,460,250tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit [DSP] @2,460,291tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x8fa47088, retVal=0x0) [DSP] @2,460,347tk: [+5 T:0x8fa47524] CN - NODE> returned from call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023816 @2,662,389us: [+0 T:0x41dc2490] CE - Engine_fwriteTrace> returning count [1144] @2,662,549us: [+0 T:0x41dc2490] CV - VISA_call Completed: messageId=0x00023816, command=0x1, return(status=0) @2,662,708us: [+5 T:0x41dc2490] CV - VISA_freeMsg(0x60f90, 0x425d0c80): Freeing message with messageId=0x00023816 @2,662,858us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_control> Exit (handle=0x60f90, retVal=0x0) @2,663,118us: [+2 T:0x41dc2490] ti.sdo.dmai - [BufTab] Allocating BufTab for 3 buffers @2,663,518us: [+4 T:0x41dc2490] OM - Memory_contigAlloc> CMEM_alloc(691200) = 0x42640000. @3,004,406us: [+4 T:0x41dc2490] OM - Memory_contigAlloc> CMEM_getPhys(0x42640000) = 0x87bc6000. @3,004,620us: [+2 T:0x41dc2490] ti.sdo.dmai - [Buffer] Alloc Buffer of size 691200 at 0x42640000 (0x87bc6000 phys) @3,004,961us: [+4 T:0x41dc2490] OM - Memory_contigAlloc> CMEM_alloc(691200) = 0x42f0b000. @3,005,172us: [+4 T:0x41dc2490] OM - Memory_contigAlloc> CMEM_getPhys(0x42f0b000) = 0x87afb000. @3,005,350us: [+2 T:0x41dc2490] ti.sdo.dmai - [Buffer] Alloc Buffer of size 691200 at 0x42f0b000 (0x87afb000 phys) @3,005,740us: [+4 T:0x41dc2490] OM - Memory_contigAlloc> CMEM_alloc(691200) = 0x42fd6000. @3,005,955us: [+4 T:0x41dc2490] OM - Memory_contigAlloc> CMEM_getPhys(0x42fd6000) = 0x87a30000. @3,006,143us: [+2 T:0x41dc2490] ti.sdo.dmai - [Buffer] Alloc Buffer of size 691200 at 0x42fd6000 (0x87a30000 phys) @3,006,750us: [+2 T:0x413af490] ti.sdo.dmai - [Smooth] Configuring smooth job of size 720x480 @3,007,175us: [+2 T:0x42f0a490] ti.sdo.dmai - [BufTab] Allocating BufTab for 2 buffers @3,007,559us: [+4 T:0x42f0a490] OM - Memory_contigAlloc> CMEM_alloc(345600) = 0x430a1000. @3,007,779us: [+4 T:0x42f0a490] OM - Memory_contigAlloc> CMEM_getPhys(0x430a1000) = 0x87965000. @3,007,962us: [+2 T:0x42f0a490] ti.sdo.dmai - [Buffer] Alloc Buffer of size 345600 at 0x430a1000 (0x87965000 phys) @3,008,325us: [+4 T:0x42f0a490] OM - Memory_contigAlloc> CMEM_alloc(345600) = 0x4316c000. @3,008,569us: [+4 T:0x42f0a490] OM - Memory_contigAlloc> CMEM_getPhys(0x4316c000) = 0x8789a000. @3,008,759us: [+2 T:0x42f0a490] ti.sdo.dmai - [Buffer] Alloc Buffer of size 345600 at 0x4316c000 (0x8789a000 phys) Cap: Complete cap 00 frame at:86F00000 691200 Cap: Complete cap 01 frame at:85000000 691200 Video: Complete get 00 frame at:87BC6000 691200 Start Venc1, In:87BC6000 Out:87965000 @3,173,352us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x60f90, inBufs=0x41dc1c78, outBufs=0x41dc1c6c, inArgs=0x41dc1c5c, outArgs=0x41dc1be4) @3,173,596us: [+5 T:0x41dc2490] CV - VISA_allocMsg> Allocating message for messageId=0x00023817 @3,218,856us: [+0 T:0x41dc2490] CV - VISA_call(visa=0x60f90, msg=0x425d0c80): messageId=0x00023817, command=0x0 [DSP] @3,757,042tk: [+5 T:0x8fa47524] CN - NODE> 0x8fa46fc8(h264enc#0) call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023817 [DSP] @3,757,120tk: [+0 T:0x8fa47524] OM - Memory_cacheInv> Enter(addr=0x87bc6000, sizeInBytes=691200) [DSP] @3,757,915tk: [+0 T:0x8fa47524] OM - Memory_cacheInv> return [DSP] @3,757,954tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x8fa47088, inBufs=0x8fa4b824, outBufs=0x8fa4b8f4, inArgs=0x8fe06e04, outArgs=0x8fe06e10) [DSP] @3,758,051tk: [+5 T:0x8fa47524] CV - VISA_enter(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @3,758,100tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fa470b8) [DSP] @3,758,152tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit [DSP] @3,800,734tk: [+5 T:0x8fa47524] CV - VISA_exit(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @3,800,814tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fa470b8) [DSP] @3,800,875tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit [DSP] @3,800,921tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x8fa47088, retVal=0x0) [DSP] @3,800,985tk: [+0 T:0x8fa47524] OM - Memory_cacheWb> Enter(addr=0x87965000, sizeInBytes=345600) [DSP] @3,801,475tk: [+0 T:0x8fa47524] OM - Memory_cacheWb> return [DSP] @3,801,511tk: [+5 T:0x8fa47524] CN - NODE> returned from call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023817 @3,241,800us: [+0 T:0x41dc2490] CE - Engine_fwriteTrace> returning count [1490] @3,241,969us: [+0 T:0x41dc2490] CV - VISA_call Completed: messageId=0x00023817, command=0x0, return(status=0) @3,242,148us: [+5 T:0x41dc2490] CV - VISA_freeMsg(0x60f90, 0x425d0c80): Freeing message with messageId=0x00023817 @3,242,302us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x60f90, retVal=0x0) @3,242,440us: [+2 T:0x41dc2490] ti.sdo.dmai - [Venc1] VIDENC1_process() ret 0 generated 5473 bytes Venc1 completed successful. Write: Complete get 00 frame at:87965000 345600 Write End. Cap: Complete cap 02 frame at:85100000 691200 Video: Complete get 01 frame at:87AFB000 691200 Start Venc1, In:87AFB000 Out:8789A000 @3,336,971us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x60f90, inBufs=0x41dc1c78, outBufs=0x41dc1c6c, inArgs=0x41dc1c5c, outArgs=0x41dc1be4) @3,382,090us: [+5 T:0x41dc2490] CV - VISA_allocMsg> Allocating message for messageId=0x00023818 @3,382,324us: [+0 T:0x41dc2490] CV - VISA_call(visa=0x60f90, msg=0x425d0c80): messageId=0x00023818, command=0x0 [DSP] @4,136,320tk: [+5 T:0x8fa47524] CN - NODE> 0x8fa46fc8(h264enc#0) call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023818 [DSP] @4,136,401tk: [+0 T:0x8fa47524] OM - Memory_cacheInv> Enter(addr=0x87afb000, sizeInBytes=691200) [DSP] @4,137,200tk: [+0 T:0x8fa47524] OM - Memory_cacheInv> return [DSP] @4,137,239tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x8fa47088, inBufs=0x8fa4b824, outBufs=0x8fa4b8f4, inArgs=0x8fe06e04, outArgs=0x8fe06e10) [DSP] @4,137,336tk: [+5 T:0x8fa47524] CV - VISA_enter(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @4,137,389tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fa470b8) [DSP] @4,137,444tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit [DSP] @4,193,231tk: [+5 T:0x8fa47524] CV - VISA_exit(visa=0x8fa47088): algHandle = 0x8fa470b8 [DSP] @4,193,320tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fa470b8) [DSP] @4,193,384tk: [+0 T:0x8fa47524] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit [DSP] @4,193,429tk: [+0 T:0x8fa47524] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x8fa47088, retVal=0x0) [DSP] @4,193,536tk: [+0 T:0x8fa47524] OM - Memory_cacheWb> Enter(addr=0x8789a000, sizeInBytes=345600) [DSP] @4,194,019tk: [+0 T:0x8fa47524] OM - Memory_cacheWb> return [DSP] @4,194,056tk: [+5 T:0x8fa47524] CN - NODE> returned from call(algHandle=0x8fa47088, msg=0x8fe06c80); messageId=0x00023818 @3,410,861us: [+0 T:0x41dc2490] CE - Engine_fwriteTrace> returning count [1490] @3,411,030us: [+0 T:0x41dc2490] CV - VISA_call Completed: messageId=0x00023818, command=0x0, return(status=0) @3,411,206us: [+5 T:0x41dc2490] CV - VISA_freeMsg(0x60f90, 0x425d0c80): Freeing message with messageId=0x00023818 @3,411,360us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Exit (handle=0x60f90, retVal=0x0) @3,411,497us: [+2 T:0x41dc2490] ti.sdo.dmai - [Venc1] VIDENC1_process() ret 0 generated 10577 bytes Venc1 completed successful. Write: Complete get 01 frame at:8789A000 345600 Write End. Cap: Complete cap 03 frame at:86F00000 691200 Video: Complete get 02 frame at:87A30000 691200 Start Venc1, In:87A30000 Out:87965000 @3,502,339us: [+0 T:0x41dc2490] ti.sdo.ce.video1.VIDENC1 - VIDENC1_process> Enter (handle=0x60f90, inBufs=0x41dc1c78, outBufs=0x41dc1c6c, inArgs=0x41dc1c5c, outArgs=0x41dc1be4) @3,503,199us: [+5 T:0x41dc2490] CV - VISA_allocMsg> Allocating message for messageId=0x00023819 @3,503,397us: [+0 T:0x41dc2490] CV - VISA_call(visa=0x60f90, msg=0x425d0c80): messageId=0x00023819, command=0x0 Cap: Complete cap 04 frame at:85000000 691200 *** Halt here, below message come out after press Ctrl+C *** Unable to handle kernel paging request at virtual address c796e010 @15,249,789us: [pgd = c5238000 +0 T:0x4001e950][c796e010] *pgd=80442011 OP - doCmd> Ent, *pte=00000000er (cmdId=3, pro, *ppte=00000000c=0x0) @15,250, 007us: [+0 T:0x4Internal error: Oops: 7 [#1] Modules linked in: dsplinkk cmemk davinci_capture mt9t001 tvp5146 CPU: 0 PC is at SYNC_WaitSEM+0x234/0x32c [dsplinkk] LR is at flush_signals+0x64/0x90 pc : [<bf01d710>] lr : [<c0053ae4>] Tainted: GF sp : c52d5e38 ip : c52d5e20 fp : c52d5e84 r10: ffffffff r9 : c0041680 r8 : c796e008 r7 : c52d5e44 r6 : c796e000 r5 : c52d4000 r4 : 00000002 r3 : 00000001 r2 : 00000000 r1 : c05466b4 r0 : c05466b4 Flags: nZCv IRQs on FIQs on Mode SVC_32 Segment user Control: 5317F Table: 85238000 DAC: 00000015 Process encode (pid: 930, stack limit = 0xc52d4258) Stack: (0xc52d5e38 to 0xc52d6000) 5e20: c7a06c80 00008000 5e40: c52d5e5c 00000001 c046b2e0 c0041680 c796e008 c796e008 bf025784 00000000 5e60: 00008000 c52d5ef4 c796a000 ffffffff 80008051 bf0325c8 c52d5eb4 c52d5e88 5e80: bf021810 bf01d4ec bf021938 00006f0b 41dc1a94 00006f0b 0000000e c66e40c0 5ea0: c52d4000 00000000 c52d5ec4 c52d5eb8 bf018a7c bf021790 c52d5f24 c52d5ec8 5ec0: bf018400 bf018a7c 00000070 c52d5ef0 c52d5f24 c52d5ee0 c013f988 c013e108 5ee0: c52d5f04 c0142cfc c70ae80c 00000070 00000040 00000000 00008000 41dc1c5c 5f00: 00010001 ffffffff 00000000 00000004 c66e40c0 41dc1a94 c52d5f44 c52d5f28 5f20: c00a169c bf01809c c64ed358 c66e40c0 0000000e 41dc1a94 c52d5f74 c52d5f48 5f40: c00a197c c00a1630 c008c878 c00ba328 00000000 00000000 41dc1a94 00006f0b 5f60: c66e40c0 c52d4000 c52d5fa4 c52d5f78 c00a1a08 c00a16c8 00000000 00000001 5f80: 00000040 ffffffff 0005d5ac 41dc1b3c 00000036 c0031fa8 00000000 c52d5fa8 5fa0: c0031e00 c00a19b4 ffffffff 0005d5ac 0000000e 00006f0b 41dc1a94 0000000e 5fc0: ffffffff 0005d5ac 41dc1b3c 00000036 00010001 00001d68 0005df68 41dc1a7c 5fe0: 0005f314 41dc19a8 00031c10 4026650c 60000010 0000000e 00000000 00000000 Backtrace: [<bf01d4dc>] (SYNC_WaitSEM+0x0/0x32c [dsplinkk]) from [<bf021810>] (LDRV_MSGQ_get+0x90/0xd0 [dsplinkk]) [<bf021780>] (LDRV_MSGQ_get+0x0/0xd0 [dsplinkk]) from [<bf018a7c>] (PMGR_MSGQ_get+0x10/0x14 [dsplinkk]) [<bf018a6c>] (PMGR_MSGQ_get+0x0/0x14 [dsplinkk]) from [<bf018400>] (DRV_Ioctl+0x374/0x9a0 [dsplinkk]) [<bf01808c>] (DRV_Ioctl+0x0/0x9a0 [dsplinkk]) from [<c00a169c>] (do_ioctl+0x7c/0x98) r5 = 41DC1A94 r4 = C66E40C0 [<c00a1620>] (do_ioctl+0x0/0x98) from [<c00a197c>] (vfs_ioctl+0x2c4/0x2ec) r6 = 41DC1A94 r5 = 0000000E r4 = C66E40C0 [<c00a16b8>] (vfs_ioctl+0x0/0x2ec) from [<c00a1a08>] (sys_ioctl+0x64/0x8c) r9 = C52D4000 r8 = C66E40C0 r6 = 00006F0B r5 = 41DC1A94 r4 = 00000000 [<c00a19a4>] (sys_ioctl+0x0/0x8c) from [<c0031e00>] (ret_fast_syscall+0x0/0x2c) r8 = C0031FA8 r7 = 00000036 r6 = 41DC1B3C r5 = 0005D5AC r4 = FFFFFFFF Code: e5834000 e5953004 e2833001 e5853004 (e5963010) 001e950] ti.sdo.<6>note: encode[930] exited with preempt_count 1 ce.osal.Sem - Enprev->state: 2 != TASK_RUNNING?? encode/930[CPU#0]: BUG in __schedule at kernel/sched.c:3826 tered Sem_post> sem[0x601c0] @15,250,222us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x601c0] status[0] @15,250,385us: [+0 T:0x40baf490] OP - getCmd_d> Exit (result=3) @15,250,519us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x601d8] @15,250,664us: [+0 T:0x40baf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x601d8] @15,251,033us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x601c0] @15,251,219us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x601d8] timeout[0xffffffff] @15,251,369us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x601d8] status[0] @15,251,501us: [+0 T:0x4001e950] OP - doCmd> Exit (result=1) @15,251,621us: [+0 T:0x4001e950] OT - Thread_delete> Enter (task=0x60210) @15,251,811us: [+4 T:0x4001e950] OT - Thread_delete> pthread_cancel (0x3) @15,251,967us: [+4 T:0x4001e950] OT - Thread_delete> pthread_join (0x0) @15,252,111us: [+0 T:0x4001e950] OT - Thread_delete> Exit (task=0x60210) @15,252,237us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x601c0] @15,252,406us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Leaving Sem_delete> @15,252,541us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Entered Sem_delete> sem[0x601d8] @15,252,676us: [+0 T:0x4001e950] ti.sdo.ce.osal.Sem - Leaving Sem_delete> [email protected]:/dm6446# Does the DSP no respond and how to resolve it ? Thanks. Jack _______________________________________________ Davinci-linux-open-source mailing list [email protected] http://linux.davincidsp.com/mailman/listinfo/davinci-linux-open-source _______________________________________________ Davinci-linux-open-source mailing list [email protected] http://linux.davincidsp.com/mailman/listinfo/davinci-linux-open-source _______________________________________________ Davinci-linux-open-source mailing list [email protected] http://linux.davincidsp.com/mailman/listinfo/davinci-linux-open-source
