Hi,
Decode code of dm6446 hangs after "VIDDEC2_process" call in codec engine. This is due to DSP is running out of msg queues. Log is attached below. Kindly help me to resolve the issue.
Also send me the details of case "SDOCM00069685 DSP can hang if it runs out of MSGQs" . This may resolve the issue.
Thanks & Regards
Krutika B R
hcbf---------------------numDisplayBufs is 1
@7,518,824us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@7,518,955us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
@7,519,082us: [+2 T:0x427e9490] ti.sdo.dmai - [Buffer] Set user pointer 0x434a4278 (physical 0x87cd4278)
@7,519,208us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@7,519,333us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
frameNbr++==========10
while video stop
while video start
numDisplayBufs--==============6
start Vdec2_process
before decode process
@7,519,784us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x9a430, inBufs=0x427e84ac, outBufs=0x427e84a0, inArgs=0x427e8d10, outArgs=0x427e8570)
@7,520,050us: [+5 T:0x427e9490] CV - VISA_allocMsg> Allocating message for messageId=0x0002dc7c
@7,520,236us: [+0 T:0x427e9490] CV - VISA_call(visa=0x9a430, msg=0x42ffac80): messageId=0x0002dc7c, command=0x0
@7,520,506us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda698]
@7,520,677us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda698]
waitForStart(hLoader)
@7,520,847us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@7,520,966us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
lock(hLoader)
hLoader->w += numBytes
Numbytes written is 575064
@7,521,851us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@7,522,005us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
unlock(hLoader)2
while loop end load
while loop load
start loader_readdata
@7,522,261us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda698] timeout[0xffffffff]
end while loop disp
while loop disp
[DSP] @18,243,185tk: [+5 T:0x8fb8ca44] CN - NODE> 0x8fb8c368(h264dec#0) call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7c
[DSP] @18,243,277tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> Enter(addr=0x87cd4278, sizeInBytes=1500000)
[DSP] @18,244,957tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> return
[DSP] @18,244,994tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x8fb8c428, inBufs=0x8fb91cdc, outBufs=0x8fb91da0, inArgs=0x8fe06df8, outArgs=0x8fe06e04)
[DSP] @18,245,100tk: [+5 T:0x8fb8ca44] CV - VISA_enter(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @18,245,157tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fb8c458)
[DSP] @18,245,221tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @18,290,626tk: [+5 T:0x8fb8ca44] CV - VISA_exit(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @18,290,711tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fb8c458)
[DSP] @18,290,771tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @18,290,817tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x8fb8c428, retVal=0x0)
[DSP] @18,290,882tk: [+5 T:0x8fb8ca44] CN - NODE> returned from call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7c
@7,864,733us: [+0 T:0x427e9490] CE - Engine_fwriteTrace> returning count [1335]
@7,864,885us: [+0 T:0x427e9490] CV - VISA_call Completed: messageId=0x0002dc7c, command=0x0, return(status=0)
@7,865,045us: [+5 T:0x427e9490] CV - VISA_freeMsg(0x9a430, 0x42ffac80): Freeing message with messageId=0x0002dc7c
@7,865,166us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x9a430, retVal=0x0)
after decode process
@7,865,314us: [+2 T:0x427e9490] ti.sdo.dmai - [Vdec2] VIDDEC2_process() ret 0 inId 3 inUse 0 consumed 27830
Prepare buffers for display for loop
ifloop hVd->displayBufIdx = 0
hVd->displayBufIdx = 0
Prepare buffers to be freed for loop
ifloop hVd->freeBufIdx = 0
hVd->freeBufIdx = 0
stop Vdec2_process
handleCodecBufs
hcbf---------------------numDisplayBufs is 1
@7,865,986us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@7,866,127us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
@7,866,255us: [+2 T:0x427e9490] ti.sdo.dmai - [Buffer] Set user pointer 0x434aaf2e (physical 0x87cdaf2e)
@7,866,382us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@7,866,510us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
frameNbr++==========11
while video stop
while video start
numDisplayBufs--==============6
start Vdec2_process
before decode process
@7,866,969us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x9a430, inBufs=0x427e84ac, outBufs=0x427e84a0, inArgs=0x427e8d10, outArgs=0x427e8570)
@7,867,167us: [+5 T:0x427e9490] CV - VISA_allocMsg> Allocating message for messageId=0x0002dc7d
@7,867,319us: [+0 T:0x427e9490] CV - VISA_call(visa=0x9a430, msg=0x42ffac80): messageId=0x0002dc7d, command=0x0
@7,867,577us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda698] status[0]
@7,867,754us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda698]
@7,867,885us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda698]
waitForStart(hLoader)
@7,868,037us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@7,868,152us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
lock(hLoader)
end while loop disp
while loop disp
hLoader->w += numBytes
Numbytes written is 602894
@7,872,372us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
[DSP] @19,341,336tk: [+5 T:0x8fb8ca44] CN - NODE> 0x8fb8c368(h264dec#0) call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7d
[DSP] @19,341,423tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> Enter(addr=0x87cdaf2e, sizeInBytes=1500000)
[DSP] @19,343,100tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> return
[DSP] @19,343,141tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x8fb8c428, inBufs=0x8fb91cdc, outBufs=0x8fb91da0, inArgs=0x8fe06df8, outArgs=0x8fe06e04)
[DSP] @19,343,249tk: [+5 T:0x8fb8ca44] CV - VISA_enter(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @19,343,304tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fb8c458)
[DSP] @19,343,361tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @19,388,645tk: [+5 T:0x8fb8ca44] CV - VISA_exit(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @19,388,732tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fb8c458)
[DSP] @19,388,793tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @19,388,838tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x8fb8c428, retVal=0x0)
[DSP] @19,388,904tk: [+5 T:0x8fb8ca44] CN - NODE> returned from call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7d
@8,214,427us: [+0 T:0x427e9490] CE - Engine_fwriteTrace> returning count [1335]
@8,214,579us: [+0 T:0x427e9490] CV - VISA_call Completed: messageId=0x0002dc7d, command=0x0, return(status=0)
@8,214,739us: [+5 T:0x427e9490] CV - VISA_freeMsg(0x9a430, 0x42ffac80): Freeing message with messageId=0x0002dc7d
@8,214,862us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x9a430, retVal=0x0)
after decode process
@8,215,012us: [+2 T:0x427e9490] ti.sdo.dmai - [Vdec2] VIDDEC2_process() ret 0 inId 4 inUse 0 consumed 27772
Prepare buffers for display for loop
ifloop hVd->displayBufIdx = 0
hVd->displayBufIdx = 0
Prepare buffers to be freed for loop
ifloop hVd->freeBufIdx = 0
hVd->freeBufIdx = 0
stop Vdec2_process
handleCodecBufs
hcbf---------------------numDisplayBufs is 1
@8,215,680us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@8,215,891us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
@8,216,040us: [+2 T:0x427e9490] ti.sdo.dmai - [Buffer] Set user pointer 0x434b1baa (physical 0x87ce1baa)
@8,216,174us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@8,216,295us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
frameNbr++==========12
while video stop
while video start
numDisplayBufs--==============6
start Vdec2_process
before decode process
@8,216,744us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x9a430, inBufs=0x427e84ac, outBufs=0x427e84a0, inArgs=0x427e8d10, outArgs=0x427e8570)
@8,216,936us: [+5 T:0x427e9490] CV - VISA_allocMsg> Allocating message for messageId=0x0002dc7e
@8,217,095us: [+0 T:0x427e9490] CV - VISA_call(visa=0x9a430, msg=0x42ffac80): messageId=0x0002dc7e, command=0x0
@8,217,357us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
unlock(hLoader)2
while loop end load
while loop load
start loader_readdata
@8,217,632us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda698] timeout[0xffffffff]
@8,217,754us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda698] status[0]
@8,217,861us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda698]
@8,217,975us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda698]
waitForStart(hLoader)
@8,218,160us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@8,218,303us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
end while loop disp
while loop disp
[DSP] @20,448,075tk: [+5 T:0x8fb8ca44] CN - NODE> 0x8fb8c368(h264dec#0) call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7e
[DSP] @20,448,164tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> Enter(addr=0x87ce1baa, sizeInBytes=1500000)
[DSP] @20,449,843tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> return
[DSP] @20,449,881tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x8fb8c428, inBufs=0x8fb91cdc, outBufs=0x8fb91da0, inArgs=0x8fe06df8, outArgs=0x8fe06e04)
[DSP] @20,449,989tk: [+5 T:0x8fb8ca44] CV - VISA_enter(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @20,450,044tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fb8c458)
[DSP] @20,450,100tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @20,495,285tk: [+5 T:0x8fb8ca44] CV - VISA_exit(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @20,495,371tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fb8c458)
[DSP] @20,495,433tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @20,495,479tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x8fb8c428, retVal=0x0)
[DSP] @20,495,544tk: [+5 T:0x8fb8ca44] CN - NODE> returned from call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7e
@8,561,726us: [+0 T:0x427e9490] CE - Engine_fwriteTrace> returning count [1335]
@8,561,877us: [+0 T:0x427e9490] CV - VISA_call Completed: messageId=0x0002dc7e, command=0x0, return(status=0)
@8,562,034us: [+5 T:0x427e9490] CV - VISA_freeMsg(0x9a430, 0x42ffac80): Freeing message with messageId=0x0002dc7e
@8,562,156us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x9a430, retVal=0x0)
after decode process
@8,562,305us: [+2 T:0x427e9490] ti.sdo.dmai - [Vdec2] VIDDEC2_process() ret 0 inId 5 inUse 0 consumed 28185
Prepare buffers for display for loop
ifloop hVd->displayBufIdx = 0
hVd->displayBufIdx = 0
Prepare buffers to be freed for loop
ifloop hVd->freeBufIdx = 0
hVd->freeBufIdx = 0
stop Vdec2_process
handleCodecBufs
hcbf---------------------numDisplayBufs is 1
@8,562,971us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
lock(hLoader)
hLoader->w += numBytes
Numbytes written is 630666
@8,563,903us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@8,564,089us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
@8,564,240us: [+2 T:0x427e9490] ti.sdo.dmai - [Buffer] Set user pointer 0x434b89c3 (physical 0x87ce89c3)
@8,564,371us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@8,564,493us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
frameNbr++==========13
while video stop
while video start
numDisplayBufs--==============6
start Vdec2_process
before decode process
@8,564,960us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x9a430, inBufs=0x427e84ac, outBufs=0x427e84a0, inArgs=0x427e8d10, outArgs=0x427e8570)
@8,565,119us: [+5 T:0x427e9490] CV - VISA_allocMsg> Allocating message for messageId=0x0002dc7f
@8,565,273us: [+0 T:0x427e9490] CV - VISA_call(visa=0x9a430, msg=0x42ffac80): messageId=0x0002dc7f, command=0x0
@8,565,567us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
unlock(hLoader)2
while loop end load
while loop load
start loader_readdata
@8,565,839us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda698] timeout[0xffffffff]
@8,565,957us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda698] status[0]
@8,566,070us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda698]
@8,566,196us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda698]
end while loop disp
while loop disp
[DSP] @21,549,835tk: [+5 T:0x8fb8ca44] CN - NODE> 0x8fb8c368(h264dec#0) call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7f
[DSP] @21,549,924tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> Enter(addr=0x87ce89c3, sizeInBytes=1500000)
[DSP] @21,551,601tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> return
[DSP] @21,551,639tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x8fb8c428, inBufs=0x8fb91cdc, outBufs=0x8fb91da0, inArgs=0x8fe06df8, outArgs=0x8fe06e04)
[DSP] @21,551,754tk: [+5 T:0x8fb8ca44] CV - VISA_enter(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @21,551,810tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fb8c458)
[DSP] @21,551,869tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @21,597,087tk: [+5 T:0x8fb8ca44] CV - VISA_exit(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @21,597,173tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fb8c458)
[DSP] @21,597,234tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @21,597,280tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x8fb8c428, retVal=0x0)
[DSP] @21,597,346tk: [+5 T:0x8fb8ca44] CN - NODE> returned from call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc7f
@8,908,623us: [+0 T:0x427e9490] CE - Engine_fwriteTrace> returning count [1335]
@8,908,770us: [+0 T:0x427e9490] CV - VISA_call Completed: messageId=0x0002dc7f, command=0x0, return(status=0)
@8,908,930us: [+5 T:0x427e9490] CV - VISA_freeMsg(0x9a430, 0x42ffac80): Freeing message with messageId=0x0002dc7f
@8,909,053us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x9a430, retVal=0x0)
after decode process
@8,909,206us: [+2 T:0x427e9490] ti.sdo.dmai - [Vdec2] VIDDEC2_process() ret 0 inId 6 inUse 0 consumed 28566
Prepare buffers for display for loop
ifloop hVd->displayBufIdx = 0
hVd->displayBufIdx = 0
Prepare buffers to be freed for loop
ifloop hVd->freeBufIdx = 0
hVd->freeBufIdx = 0
stop Vdec2_process
handleCodecBufs
hcbf---------------------numDisplayBufs is 1
@8,909,872us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@8,910,126us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
@8,910,268us: [+2 T:0x427e9490] ti.sdo.dmai - [Buffer] Set user pointer 0x434bf959 (physical 0x87cef959)
@8,910,391us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@8,910,515us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
frameNbr++==========14
while video stop
while video start
numDisplayBufs--==============6
start Vdec2_process
before decode process
@8,911,007us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x9a430, inBufs=0x427e84ac, outBufs=0x427e84a0, inArgs=0x427e8d10, outArgs=0x427e8570)
@8,911,170us: [+5 T:0x427e9490] CV - VISA_allocMsg> Allocating message for messageId=0x0002dc80
@8,911,328us: [+0 T:0x427e9490] CV - VISA_call(visa=0x9a430, msg=0x42ffac80): messageId=0x0002dc80, command=0x0
waitForStart(hLoader)
@8,911,659us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@8,911,801us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
lock(hLoader)
hLoader->w += numBytes
Numbytes written is 671460
@8,912,906us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@8,913,064us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
unlock(hLoader)2cut off
while loop end load
while loop load
start loader_readdata
@8,913,316us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda698] timeout[0xffffffff]
@8,913,436us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda698] status[0]
end while loop disp
while loop disp
[DSP] @22,644,680tk: [+5 T:0x8fb8ca44] CN - NODE> 0x8fb8c368cut off(h264dec#0) call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc80
[DSP] @22,644,768tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> Enter(addr=0x87cef959, sizeInBytes=1500000)
[DSP] @22,646,446tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> return
[DSP] @22,646,485tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x8fb8c428, inBufs=0x8fb91cdc, outBufs=0x8fb91da0, inArgs=0x8fe06df8, outArgs=0x8fe06e04)
[DSP] @22,646,600tk: [+5 T:0x8fb8ca44] CV - VISA_enter(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @22,646,655tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fb8c458)
[DSP] @22,646,715tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @22,692,481tk: [+5 T:0x8fb8ca44] CV - VISA_exit(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @22,692,570tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fb8c458)
[DSP] @22,692,630tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @22,692,675tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x8fb8c428, retVal=0x0)
[DSP] @22,692,741tk: [+5 T:0x8fb8ca44] CN - NODE> returned from call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc80
@9,255,639us: [+0 T:0x427e9490] CE - Engine_fwriteTrace> returning count [1335]
@9,255,789us: [+0 T:0x427e9490] CV - VISA_call Completed: messageId=0x0002dc80, command=0x0, return(status=0)
@9,255,950us: [+5 T:0x427e9490] CV - VISA_freeMsg(0x9a430, 0x42ffac80): Freeing message with messageId=0x0002dc80
@9,256,070us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x9a430, retVal=0x0)
after decode process
@9,256,224us: [+2 T:0x427e9490] ti.sdo.dmai - [Vdec2] VIDDEC2_process() ret 0 inId 0 inUse 0 consumed 28915
Prepare buffers for display for loop
ifloop hVd->displayBufIdx = 0
hVd->displayBufIdx = 0
Prepare buffers to be freed for loop
ifloop hVd->freeBufIdx = 0
hVd->freeBufIdx = 0
stop Vdec2_process
handleCodecBufs
hcbf---------------------numDisplayBufs is 1
@9,256,894us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@9,257,027us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
@9,257,158us: [+2 T:0x427e9490] ti.sdo.dmai - [Buffer] Set user pointer 0x434c6a4c (physical 0x87cf6a4c)
@9,257,279us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@9,257,403us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
frameNbr++==========15
while video stop
while video start
numDisplayBufs--==============6
start Vdec2_process
before decode process
@9,257,853us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x9a430, inBufs=0x427e84ac, outBufs=0x427e84a0, inArgs=0x427e8d10, outArgs=0x427e8570)
@9,258,049us: [+5 T:0x427e9490] CV - VISA_allocMsg> Allocating message for messageId=0x0002dc81
@9,258,215us: [+0 T:0x427e9490] CV - VISA_call(visa=0x9a430, msg=0x42ffac80): messageId=0x0002dc81, command=0x0
@9,258,475us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda698]
@9,258,637us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda698]
waitForStart(hLoader)
@9,258,806us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@9,258,921us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
lock(hLoader)
hLoader->w += numBytes
Numbytes written is 671460
@9,259,209us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@9,259,366us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
ptr = hLoader->r1
@9,259,531us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda698] timeout[0xffffffff]
end while loop disp
while loop disp
[DSP] @23,742,244tk: [+5 T:0x8fb8ca44] CN - NODE> 0x8fb8c368(h264dec#0) call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc81
[DSP] @23,742,331tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> Enter(addr=0x87cf6a4c, sizeInBytes=1500000)
[DSP] @23,744,009tk: [+0 T:0x8fb8ca44] OM - Memory_cacheInv> return
[DSP] @23,744,047tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x8fb8c428, inBufs=0x8fb91cdc, outBufs=0x8fb91da0, inArgs=0x8fe06df8, outArgs=0x8fe06e04)
[DSP] @23,744,153tk: [+5 T:0x8fb8ca44] CV - VISA_enter(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @23,744,209tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x8fb8c458)
[DSP] @23,744,266tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @23,789,741tk: [+5 T:0x8fb8ca44] CV - VISA_exit(visa=0x8fb8c428): algHandle = 0x8fb8c458
[DSP] @23,789,828tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x8fb8c458)
[DSP] @23,789,889tk: [+0 T:0x8fb8ca44] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @23,789,935tk: [+0 T:0x8fb8ca44] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x8fb8c428, retVal=0x0)
[DSP] @23,790,000tk: [+5 T:0x8fb8ca44] CN - NODE> returned from call(algHandle=0x8fb8c428, msg=0x8fe06c80); messageId=0x0002dc81
@9,602,699us: [+0 T:0x427e9490] CE - Engine_fwriteTrace> returning count [1335]
@9,602,873us: [+0 T:0x427e9490] CV - VISA_call Completed: messageId=0x0002dc81, command=0x0, return(status=0)
@9,603,032us: [+5 T:0x427e9490] CV - VISA_freeMsg(0x9a430, 0x42ffac80): Freeing message with messageId=0x0002dc81
@9,603,153us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Exit (handle=0x9a430, retVal=0x0)
after decode process
@9,603,299us: [+2 T:0x427e9490] ti.sdo.dmai - [Vdec2] VIDDEC2_process() ret 0 inId 1 inUse 0 consumed 29224
Prepare buffers for display for loop
ifloop hVd->displayBufIdx = 0
hVd->displayBufIdx = 0
Prepare buffers to be freed for loop
ifloop hVd->freeBufIdx = 0
hVd->freeBufIdx = 0
stop Vdec2_process
handleCodecBufs
hcbf---------------------numDisplayBufs is 1
@9,603,961us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0xda6b0] timeout[0xffffffff]
@9,604,095us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda6b0] status[0]
@9,604,230us: [+2 T:0x427e9490] ti.sdo.dmai - [Buffer] Set user pointer 0x434cdc74 (physical 0x87cfdc74)
@9,604,356us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0xda6b0]
@9,604,482us: [+0 T:0x427e9490] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0xda6b0]
frameNbr++==========16
while video stop
while video start
numDisplayBufs--==============6
start Vdec2_process
before decode process
@9,604,966us: [+0 T:0x427e9490] ti.sdo.ce.video2.VIDDEC2 - VIDDEC2_process> Enter (handle=0x9a430, inBufs=0x427e84ac, outBufs=0x427e84a0, inArgs=0x427e8d10, outArgs=0x427e8570)
@9,605,131us: [+5 T:0x427e9490] CV - VISA_allocMsg> Allocating message for messageId=0x0002dc82
@9,605,285us: [+0 T:0x427e9490] CV - VISA_call(visa=0x9a430, msg=0x42ffac80): messageId=0x0002dc82, command=0x0
@9,605,547us: [+0 T:0x43fcf490] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0xda698] status[0]
ARM Load: 19% DSP Load: 3% Video fps: 2 fps Video bit rate: 379 kbps Sound bit rate: 0 kbps Time: 00:00:01 Demo: Decode Display: D1 NTSC Video Codec: H.264 BP Video Resolution: 720x576 Sound Codec: N/A Sampling Freq: N/A
end while loop disp
while loop disp
