The Vdec_requestBitstreamBuffer can't get available bitstream buffer!

Can you share the full console log from create time onwards.Also share the log of emptyBufList..numBufs and log of Vsys_printBufferStatistics(). WHich RDK version are you using

Hi

   the rdk version is 03.00.00.00.   emptyBufList.numBufs also equal to 0. Now can't get the message of Vsys_printBufferStatistics().   I will add this function soon.

Hi

 The Vsys_printBufferStatistics() print nothing. 

 // code

OSA_printf("-----------------------------------------------------------\n");
 Vsys_printBufferStatistics();
 OSA_printf("-----------------------------------------------------------\n");

// log

 [host] -----------------------------------------------------------

 [host] -----------------------------------------------------------

[host] -----------------------------------------------------------

 IPCBITSOUTLINK:Buffer Statistics
 Num Alloc Pools:4
 PoolId | TotalBufCnt | FreeBufCnt | BufSize
       0|            6|          6| 2073600
       1|            6|          6| 2073600
       2|            6|          6| 2073600
       3|            6|          6| 2073600

 VDEC:Buffer Statistics
 ChId | InBufCnt | OutBufCnt
     0|         0|         0
 [m3vpss ]  12035: DISPLAY: Start in progress !!!
 [m3vpss ]  12035: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
     1|         0|         0
     2|         0|         0
     3|         0|         0
 [m3vpss ]  12081: DISPLAY: Start Done !!!
 [m3vpss ]  12082: DISPLAY: DVO2(BP1)  : 42 fps, Latency (Min / Max) = ( 255 / 0 ), Callback Interval (Min / Max) = ( 255 / 0 ) !!!
 [m3vpss ]  12082: SWMS: Start in Progress !!!
 [m3vpss ]  12082: SWMS: Start Done !!!
 [m3vpss ]  12082: SWMS: Start in Progress !!!
 [m3vpss ]  12082: SWMS: Start Done !!!
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 12419: SWMS: Rcvd from prev = 0, Returned to prev = 0
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 13, rdPtr 9
 [m3vpss ] Full Q -> count 1, wrPtr 9, rdPtr 8
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 12420: SWMS: Rcvd from prev = 0, Returned to prev = 0
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 5, wrPtr 13, rdPtr 8
 [m3vpss ] Full Q -> count 0, wrPtr 8, rdPtr 8
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 12420: DISPLAY: Rcvd from prev = 8, Returned to prev = 6, BufsInDriver = 4
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 12420: DISPLAY: Rcvd from prev = 8, Returned to prev = 6, BufsInDriver = 4

 [host] -----------------------------------------------------------

Hi Badri Narayanan

I delete the statement "reqInfo.u[0].minBufSize = 1036800;" , then can work correctly.  But  times emptyBufList.numBufs equal to 1 is smaller than the times it equal to 0. 

The configuration of IpcBitsOutLInk_HLOS is correct and it has 6 empty buffers . The issue is the requesting buffers:

     reqInfo.u[0].chNum = 0;
     reqInfo.u[0].minBufSize = 1036800; --> Delete this line.

    reqInfo.u is a union and either chNum or minBufSize  should be set based on whether reqType is chId or bufSize.Both param should not be set as minBufSize will overwrite chNum since it is a union

Hi Badri Narayanan

  When i pass the h.264 bitstream data to Vdec, get the following error message.    Before function Vdec_putBitstreamBuffer,  I write the emptyBufList.bitsBuf[0].filledBufSize and emptyBufList.bitsBuf[0].bufVirtAddr data to file, the data is the same as got from the Vdec_Vdis demo.  

 After use function Vdec_requestBitstreamBuffer to get the available bitstream buffer, Before call Vdec_putBitstreamBuffer, I modify the following variables of emptyBufList.

emptyBufList.bitsBuf[0].filledBufSize     copy data to emptyBufList.bitsBuf[0].bufVirtAddr       emptyBufList.bitsBuf[0].lowerTimeStamp   emptyBufList.bitsBuf[0].upperTimeStamp.  Any other variables need to be modify?

 [m3vpss ] AVSYNC:AVSYNC_LINK_CMD_SET_FIRST_VIDPTS successConfig:DisplayID[0],ChID[0],FirstPTS[0]
 [m3vpss ] AVSYNC:AVSYNC_LINK_CMD_SET_FIRST_VIDPTS successConfig:DisplayID[1],ChID[0],FirstPTS[0]
 [m3vpss ] AVSYNC:Media Time Base:0,FirstVidPTS:0,FirstAudPTS:-1
 [m3vpss ] AVSYNC:Media Time Base:0,FirstVidPTS:0,FirstAudPTS:-1
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3538],AjustPTS[462],MaxLead[750],MaxLag[180]
 [m3video] 19779:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3538],AjustPTS[462],MaxLead[750],MaxLag[180]
 [m3video] Sequence called number 29
[DECODER ERROR] 9239: DECODE CH <0> ERROR: IH264VDEC_ERR_NOSLICE : 0, 
[DECODER ERROR] 9239: DECODE CH <0> ERROR: IH264VDEC_ERR_UNAVAILABLESPS : 5,
[DECODER ERROR] 9239: DECODE CH <0> ERROR: XDM_CORRUPTEDHEADER : 12,
 [m3video] 19848:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 30
 [m3video] 19910:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 31
 [m3video] 19915:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 32
 [m3video] 19958:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 33
 [m3video] 21753K::linksdec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 35
 [m3video] 21848:DECLINK::links_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 36
 [m3video] 21910:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 37
 [m3video] 21960:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 38
 [m3video] 21963:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 39
 [m3video] 22086:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 41
 [m3video] 22091:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 42
 [m3video] 22150:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 43
 [m3video] 22200:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 44
 [m3video] 22202:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 45
 [m3video] 22264:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extenedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 46
 [m3video] 22326:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 47
 [m3video] 22331:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 48
 [m3video] 22390:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 49
 [m3video] 22438:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 50
 [m3video] 22444:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 51
 [m3video] 22503:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 52
 [m3video] 22567:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 53
 [m3video] 22615:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 54
 [m3video] 22678:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 55
 [m3video] 22743:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 56
 [m3video] 22854:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 57
 [m3video] 22903:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 58
 [m3video] 22966:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021
 [m3video] Sequence called number 59
 [m3video] 23016:DECLINK::links_m3video/iva_dec/decLink_h264.c:[376]::INTERNAL ERROR:-1
 [m3video] ALGPROCESS FAILED:STATUS
 [m3video] outArgs->viddec3OutArgs.extendedError for channel 0 Error: 0x1021

You should not modify bufVirtAddr.You should copy the bitstream into address pointed to by bufVirtAddr and set the filledBufSize correctly as :memcoy(emptyBuf->bufVirtAddr,bitStreamSrc,fillledBufSize). Pls refer demo_vdec_vdis_bits_rd.c for reference

I didn't modify the value of  bufVirtAddr, i use the memcpy to copy the data of a picture to  bufVirtAddr. 

      memcpy(dstBuf->bufVirtAddr,srcBuf->bufVirtAddr,srcBuf->filledBufSize);

Pls check the following:

1. filledBufSize is set correctly.

2. YOu always feed bitstream corresponding to one entire frame.

3. You are always requesting buffers only for channel 0 in your code.Pls ensure you are feeding data from a single file (single channel data) and not feeding multipls channel data to a single channel

4. Stream starts with IDR/SPS/PPS

The code i used:

  pEmptyBuf->filledBufSize = pFullBuf->filledBufSize;
  WRITER_videoCopyBufDataMem2Mem(pEmptyBuf, pFullBuf);
  IpncVdecVdis_setFrameTimeStamp(pEmptyBuf);
  fwrite(pEmptyBuf->bufVirtAddr,1,pEmptyBuf->filledBufSize,fstream);
  fprintf(flen,"%d\n",pEmptyBuf->filledBufSize);
  fflush(fstream);
  fflush(flen);
  pEmptyBuf->seqId = Demo_displayGetCurSeqId();
  Vdec_putBitstreamBuffer(&emptyBufList);

  the fstream and flen is uesd to write bistream data and picture nal len to file.

  1. the filledBufSize is correctly.  it's the same as the value got from the Vdec_Vdis demo .

  2.  I use function similar to Demo_generateH264HdrFile to decide if got a entire frame.  The result of the function is same as Demo_generateH264HdrFile.

  3.   Now I just use one ipnc channel,

  4.  The first picture data pass to Vdec is sps+pps+sei+idr.    I wirte the first picture data pass to Vdec, it is the same as the Vdec_Vdis demo got.

I am sorry I dont understand what pFullBuf is in decode_display usecase. Can you pls attach the source code (full file) which feeds data to mcfw. That will be easier to analyze

Why the Vdec_requestBitstreamBuffer can't got the available buffer?  I add code to count the times got the available. every 1000 times ,only 6 times got the available buffer.

My code is base the gui demo.    The different is gui demo use live555 server.   I use live555 client to got data.       

1. live555 client got one nal data ,put it to a share memory. then notify the second task.

2. the second task will decide whether a entire frame is got, if so , memcpy the entire frame data to a queue. then notify the third task.

3. the third task got a available frame bitstream  from the queue, then memcpy the data to the buffer got from Vdec.

The functon of the third task is :

Void WRITER_videoProcessFullBufs(WRITER_CtrlThrObj *thrObj)
{
    int status=OSA_SOK, outBufId_Motion, i ;
    VCODEC_BITSBUF_LIST_S fullBufList;
    VCODEC_BITSBUF_S *pFullBuf;
 VCODEC_BITSBUF_LIST_S emptyBufList;
    VCODEC_BITSBUF_S *pEmptyBuf;
 VDEC_BUF_REQUEST_S reqInfo;
    VCODEC_BITSBUF_S *pEmptyBufStm;
 
 emptyBufList.numBufs = 0;
 reqInfo.numBufs = 1;
 reqInfo.reqType = VDEC_BUFREQTYPE_CHID;
 reqInfo.u[0].chNum = 0;
 Vdec_requestBitstreamBuffer(&reqInfo, &emptyBufList, 0);

 requireTimes++;
 if(emptyBufList.numBufs != 0)
  getTimes++;

 if(requireTimes == 1000)
  printf("getTimes = %d\n",getTimes);

 for(i = 0; i < emptyBufList.numBufs; i++)
 {
  pEmptyBuf = &emptyBufList.bitsBuf[i];
  status =  OSA_queGet(&thrObj->bufQFullBufsVidStream,(Int32 *)(&pFullBuf), OSA_TIMEOUT_NONE);
  if(status != OSA_EFAIL)
     {
      if(pFullBuf->chnId < MAX_DVR_CHANNELS)
         {
             pEmptyBuf->filledBufSize = pFullBuf->filledBufSize;
             WRITER_videoCopyBufDataMem2Mem(pEmptyBuf, pFullBuf);
    IpncVdecVdis_setFrameTimeStamp(pEmptyBuf);
   pEmptyBuf->seqId = Demo_displayGetCurSeqId();
    Vdec_putBitstreamBuffer(&emptyBufList);
         }
   
   WRITER_bufFreeStream(pFullBuf, VIDEO_STREAM);
         pEmptyBuf = WRITER_bufAllocStream(VIDEO_STREAM);
   OSA_quePut(&thrObj->bufQFreeBufsVidStream, (Int32)pEmptyBuf, OSA_TIMEOUT_NONE);
     }

  
 }

}

Vdec_requestBitstreamBuffer can't get the available buffer when the buffers are held by the decoder link. THe buffers will be freed at the rate at which SwMs is consuming frames. This is 30 fps in decode display demo.So your application should invoke Vdec_requestBitstreamBuffer say every 16 ms and you should get free buffer every alternate call atleast. HOw often are you invoking  Vdec_requestBitstreamBuffer (WHat is the frequency of calling Vdec_requestBitstreamBuffer) ?

how to set the frequency of call one function ?

while (!done)
    {
        WRITER_videoProcessFullBufs(thrObj);
        OSA_waitMsecs(16);  // use this statement ?
 }

Yes above code is correct to control the rate of invoking Vdec_requestBitstreamBuffer.

I have some questions about your code.

- Can you share the code of task2 that is putting full frames in the fullBufQue ?

Also there are some issue with the code in task3:

- You should not invoke  Vdec_putBitstreamBuffer inside for(i = 0; i < emptyBufList.numBufs; i++)

   This will result in the same buffers in emptyBufList being fed to RDK multiple times.

- What does below code do:

   pEmptyBuf = WRITER_bufAllocStream(VIDEO_STREAM);
   OSA_quePut(&thrObj->bufQFreeBufsVidStream, (Int32)pEmptyBuf, OSA_TIMEOUT_NONE);

- Where are you handling the case where status =  OSA_queGet(&thrObj->bufQFullBufsVidStream,(Int32 *)(&pFullBuf), OSA_TIMEOUT_NONE);

   return status == OSA_EFAIL.

  As per your current code it will result in losing bitstream buffer if status = OSA_EFAIL.Application should always return all buffers it gets from Vdec-requestBitstreamBuffer. If you want to cancel a buffer you got you can just set filledBufSize to zero and call Vdec-putBitstreamBuffer

 I modify the code to：

   emptyBufList.numBufs = 0;
    reqInfo.numBufs = 1;
    reqInfo.reqType = VDEC_BUFREQTYPE_CHID;
    reqInfo.u[0].chNum = chnId;
    while(emptyBufList.numBufs == 0)
     Vdec_requestBitstreamBuffer(&reqInfo, &emptyBufList, 0);

  then can see the picutre from monitor, but the display is less than 5 i think.   got the message from console. 

 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3018],AjustPTS[462],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3604],AjustPTS[858],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3571],AjustPTS[1287],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3605],AjustPTS[1683],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3603],AjustPTS[2079],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3604],AjustPTS[2475],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3604],AjustPTS[2871],MaxLead[750],MaxLag[180]

I modify the task 2 and task3. now the function of the two task:

//----------task 2--------------------------

void Video_Data_Insert(int chnId, VIDEO_BLK_INFO *pVideo_info)
{
 OSA_BufInfo *pInBufInfo, *pAudInBufInfo;
 int status=OSA_EFAIL, inBufId, inAudBufId;
 
 pInBufInfo = AVSERVER_bufGetEmpty( VIDEO_TSK_DECODE, chnId, &inBufId, OSA_TIMEOUT_FOREVER);
 
 if(pInBufInfo!=NULL)
 {
     if(pVideo_info->frame->realsize> 0)
     {
      Video_Data_shmCopy(chnId,pInBufInfo,pVideo_info->frame);
   pInBufInfo->size = pVideo_info->frame->realsize;
     }
  AVSERVER_bufPutFull( VIDEO_TSK_DECODE, chnId, inBufId); 
 }

 return ;
 
}

unsigned long SaveOneNal(MSG_BUF msgbuf, STREAM_PARM *pParm)
{
 unsigned long  nextAddr = msgbuf.mem_info.addr;
 unsigned char *dataPos = (unsigned char *)nextAddr;
 int chnId = msgbuf.frame_info.format;
 VIDEO_BLK_INFO *pVideo_info = &pParm->MemInfo.video_info[chnId];
 unsigned char *stream = (unsigned char *)(msgbuf.mem_info.addr);
    unsigned short int  firstMbInSliceFlag;
    unsigned short int NewNalType;
    int vcl_nal_flag;
 int newNalFlag = 0;
 static int frmCnt = 1;

 NewNalType         = stream[4] & 0x1f;
    firstMbInSliceFlag = stream[5] & 0x80;
    vcl_nal_flag       = ((NewNalType <=5) && (NewNalType > 0));

 newNalFlag = 0;
 if(vcl_nal_flag && prev_vcl_nal_flag[chnId])
 {
     if( (firstMbInSliceFlag))
      newNalFlag = 1;
 }

 if ((prev_vcl_nal_flag[chnId] && !vcl_nal_flag))
 {
  newNalFlag = 1;
 }

 prev_nal_type[chnId]     = NewNalType;
 prev_vcl_nal_flag[chnId] = vcl_nal_flag;
 

 if(newNalFlag == 1)
 {

  Video_Data_Insert(chnId,pVideo_info);
  nextAddr = GetNextNalAddr(msgbuf,pVideo_info);
  
 }
 else
 {
 
  pVideo_info->frame->realsize += msgbuf.mem_info.size;
  nextAddr = (unsigned long)(pVideo_info->frame->realsize + pVideo_info->frame->frameStartAddr);  
 }
 
 return nextAddr;
}

// task 3

static int Stream_GetRun(int type, int chId, VCODEC_BITSBUF_S *pBufInfo)
{
    int outBufIdRtsp ;
    OSA_BufInfo *pOutBufRtsp ;

    pOutBufRtsp = AVSERVER_bufGetFull( VIDEO_TSK_STREAM, chId, &outBufIdRtsp, OSA_TIMEOUT_FOREVER);
 if(pOutBufRtsp != NULL)
    {
   pBufInfo->filledBufSize = pOutBufRtsp->size;
   pBufInfo->chnId = chId;
  
        memcpy(pBufInfo->bufVirtAddr,pOutBufRtsp->virtAddr,pBufInfo->filledBufSize) ;
        AVSERVER_bufPutEmpty( VIDEO_TSK_STREAM, chId, outBufIdRtsp);
 }
 

    return 0;
}

#define VDEC_VDIS_FRAME_DURATION_MS (33)

Void IpncVdecVdis_setFrameTimeStamp(VCODEC_BITSBUF_S *pEmptyBuf)
{
    UInt64 curTimeStamp = gIpncVdecVdis_config.frameCnt[pEmptyBuf->chnId] * VDEC_VDIS_FRAME_DURATION_MS;
    pEmptyBuf->lowerTimeStamp = (UInt32)(curTimeStamp & 0xFFFFFFFF);
    pEmptyBuf->upperTimeStamp = (UInt32)((curTimeStamp >> 32)& 0xFFFFFFFF);
    if (0 == gIpncVdecVdis_config.frameCnt[pEmptyBuf->chnId])
    {
        UInt32 displayChId;
        Vdec_mapDec2DisplayChId(VDIS_DEV_HDMI,pEmptyBuf->chnId,&displayChId);
        Vdis_setFirstVidPTS(VDIS_DEV_HDMI,displayChId,curTimeStamp);
    }
    gIpncVdecVdis_config.frameCnt[pEmptyBuf->chnId] += 1;
}

while (!done)
    {
  status = OSA_tskWaitMsg(pTsk, &pMsg);
  if(status!=OSA_SOK)
      break;
  cmd = OSA_msgGetCmd(pMsg);
  chnId = (int)(pMsg->pPrm);
  switch(cmd)
  {

   case AVSERVER_CMD_NEW_VDATA:
    emptyBufList.numBufs = 0;
    reqInfo.numBufs = 1;
    reqInfo.reqType = VDEC_BUFREQTYPE_CHID;
    reqInfo.u[0].chNum = chnId;
    while(emptyBufList.numBufs == 0)
     Vdec_requestBitstreamBuffer(&reqInfo, &emptyBufList, 0);

    pEmptyBuf = &emptyBufList.bitsBuf[0];
    
    streamType = VIDEO_STREAM;
          Stream_GetRun(streamType, chnId, pEmptyBuf) ;

    IpncVdecVdis_setFrameTimeStamp(pEmptyBuf);
    pEmptyBuf->seqId = Demo_displayGetCurSeqId();
    Vdec_putBitstreamBuffer(&emptyBufList);
    break;

   case AVSERVER_MAIN_CMD_STOP:
    done = TRUE;
    ackMsg = TRUE;
   default:
    break;
  }
       
   }

 if(ackMsg)
  OSA_tskAckOrFreeMsg(pMsg, OSA_SOK);

 
    OSA_printf("APP_WRITER:%s:Leaving...",__func__);
    return NULL;
}

The code you have shared looks good.I dont see any issues.How does the task 3 get triggered .i.e Who sends the new data cmd to task 3 ? Is the issue now play back stopping ? Can you invoke Vsys_printDetailedStatistics and Vsys_printBufferStatistics after the hang occurs and share the logs

The function AVSERVER_bufPutFull will send the AVSERVER_CMD_NEW_VDATA message to task3.

The log message of the two functions:   Now the display fps looks less than 10.

 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 7 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 19 fps (137 frames)
 [m3vpss ]  Output Actual  FPS   : 19 fps (137 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 57 ms
 [m3vpss ]  Scaling Internal min : 7 ms
 [m3vpss Internal max : 941 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     12     15    2    0    3          0        0 (  0/255)         0          0      0 255 / 18966
 [m3vpss ]    1 |      0     19    0    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ]    2 |      0     19    0    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ]    3 |      0     19    0    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 29
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x   1080 |  2048 /  2048 | NON-TILED   |  130,    0 |   872 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    1 |   1 |    0,    0 |  1920 x   1080 |  2048 /  2048 | NON-TILED   | 1005,    0 |   872 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   ON  |
 [m3vpss ]    2 |   2 |    0,    0 |  1920 x   1080 |  2048 /  2048 | NON-TILED   |  130,  540 |   872 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   ON  |
 [m3vpss ]    3 |   3 |    0,    0 |  1920 x   1080 |  2048 /  2048 | NON-TILED   | 1005,  540 |   872 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   ON  |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 7 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 20 fps (143 frames)
 [m3vpss ]  Output Actual  FPS   : 20 fps (143 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 54 ms
 [m3vpss ]  Scaling Internal min : 2 ms
 [m3vpss ]  Scaling Internal max : 912 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |      0     20    5    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 30
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x   1080 |  2048 /  2048 | NON-TILED   |    0,    0 |  1920 x   1080 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   ON  |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  18990: DISPLAY: HDDAC(BP0) : 59 fps, Latency (Min / Max) = ( 7 / 887 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ]  18990: DISPLAY: UNDERFLOW COUNT: HDMI(BP0) 264, HDDAC(BP0) 262, DVO2(BP1) 262, SDDAC(SEC1) 467
 [m3vpss ]  18990: SYSTEM  : FREE SPACE : System Heap      = 5792 B, Mbx = 10239 msgs)
 [m3vpss ]  18990: SYSTEM  : FREE SPACE : SR0 Heap         = 11003648 B (10 MB)
 [m3vpss ]  18990: SYSTEM  : FREE SPACE : Frame Buffer     = 2493312 B (2 MB)
 [m3vpss ]  18990: SYSTEM  : FREE SPACE : Bitstream Buffer = 168337280 B (160 MB)
 [m3vpss ]  18991: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
 [m3vpss ]  18991: DISPLAY: DVO2(BP1)  : 59 fps, Latency (Min / Max) = ( 1 / 913 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3video]  22992: HDVICP-ID:0
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :12 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :12 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :12 %
 [m3video]    totalAcq2acqDelay :87 %
 [m3video]    totalElapsedTime in msec :    3410
 [m3video]    numAccessCnt:     528
 [m3video]   IVA-FPS :     176
 [m3video]   Average time spent per frame in microsec:     774
 [m3video]  22993: HDVICP-ID:1
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :0 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :0 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :0 %
 [m3video]    totalAcq2acqDelay :0 %
 [m3video]    totalElapsedTime in msec :       0
 [m3video]    numAccessCnt:       0
 [m3video]   IVA-FPS :       0
 [m3video]   Average time spent per frame in microsec:       0
 [m3video]  22993: HDVICP-ID:2
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :0 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :0 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :0 %
 [m3video]    totalAcq2acqDelay :0 %
 [m3video]    totalElapsedTime in msec :       0
 [m3video]    numAccessCnt:       0
 [m3video]   IVA-FPS :       0
 [m3video]   Average time spent per frame in microsec:       0
 [m3video] 
 [m3video]  *** DECODE Statistics ***
 [m3video] 
 [m3video]  Elasped Time           : 9 secs
 [m3video] 
 [m3video] 
 [m3video]  CH  | In Recv In User  Out
 [m3video]  Num | FPS     Skip FPS FPS
 [m3video]  -----------------------------------
 [m3video]    0 |       4        0   4
 [m3video]    1 |       0        0   0
 [m3video]    2 |       0        0   0
 [m3video]    3 |       0        0   0
 [m3video] 
 [m3video] Multi Channel Decode Average Submit Batch Size
 [m3video] Max Submit Batch Size : 24
 [m3video] IVAHD_0 Average Batch Size : 1
 [m3video] IVAHD_0 Max achieved Batch Size : 1
 [m3video] IVAHD_1 Average Batch Size : 0
 [m3video] IVAHD_1 Max achieved Batch Size : 0
 [m3video] IVAHD_2 Average Batch Size : 0
 [m3video] IVAHD_2 Max achieved Batch Size : 0
 [m3video] 
 [m3video] Multi Channel Decode Batch break Stats
 [m3video] Total Number of Batches created: 43
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 0
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 0 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 0
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 0 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] 
 [m3vpss ] 
 [m3vpss ]  *** [MP_SCLR0 ] Statistics ***
 [m3vpss ] 
 [m3vpss ]  Total Frames Received  : 40
 [m3vpss ]  Total Frames Forwarded : 40
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  CH  | In Recv In Reject Processed  Latency(DRV) Processed  Rejected
 [m3vpss ]  Num | FPS     FPS       FPS        Min / Max    Frames     Frames 
 [m3vpss ]  -------------------------------------------------------------------
 [m3vpss ] 
 [m3vpss ]  24998: LOAD: CPU: 31.4% HWI: 1.2%, SWI:0.6%
 [m3vpss ] 
 [m3vpss ]  24998: LOAD: TSK: DISPLAY0            : 0.2%
 [m3vpss ]  24998: LOAD: TSK: DISPLAY1            : 0.2%
 [m3vpss ]  24998: LOAD: TSK: SWMS0               : 1.3%
 [m3vpss ]  24998: LOAD: TSK: SWMS1               : 1.3%
 [m3vpss ]  24998: LOAD: TSK: MISC                : 26.6%
 [m3vpss ] 
 [m3video] 
 [m3video]  25499: LOAD: CPU: 1.6% HWI: 0.3%, SWI:0.4%
 [m3video] 
 [m3video]  25499: LOAD: TSK: IPC_BITS_IN0        : 0.1%
 [m3video]  25499: LOAD: TSK: DEC0                : 0.4%
 [m3video]  25499: LOAD: TSK: MISC                : 0.4%
 [m3video] 
 [c6xdsp ] 
 [c6xdsp ]  23620: LOAD: CPU: 0.2% HWI: 0.0%, SWI:0.0%
 [c6xdsp ] 
 [c6xdsp ]  23620: LOAD: TSK: MISC                : 0.2%
 [c6xdsp ] 

 IPCBITSOUTLINK:Buffer Statistics

 Num Alloc Pools:4

 PoolId | TotalBufCnt | FreeBufCnt | BufSize

       0|            6|          0| 2073600

       1|            6|          6| 2073600

       2|            6|          6| 2073600

       3|            6|          6| 2073600

 VDEC:Buffer Statistics

 ChId | InBufCnt | OutBufCnt

     0|         5|         5

     1|         0|         0

     2|         0|         0

     3|         0|         0
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 26501: SWMS: Rcvd from prev = 0, Returned to prev = 39
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 367, rdPtr 363
 [m3vpss ] Full Q -> count 1, wrPtr 363, rdPtr 362
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 26501: SWMS: Rcvd from prev = 0, Returned to prev = 40
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 373, rdPtr 369
 [m3vpss ] Full Q -> count 1, wrPtr 369, rdPtr 368
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 26502: DISPLAY: Rcvd from prev = 362, Returned to prev = 360, BufsInDriver = 4
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 26502: DISPLAY: Rcvd from prev = 368, Returned to prev = 366, BufsInDriver = 4

There are a couple of problems:

totalAcq2acqDelay :87 % - This indicates IVA_HD is idle most of the time.

This could be due to application not feeding data in time.

Can you have timestamps when Vdec_putBitstreamBuffer is done in your application and measure avg time between successive Vdec_putBitstreamBuffer

The SwMs is doing 4 channel 1080P scaling which makes it out of realtime and lowCost scaling is disabled. Also the scaler id assigned to both the SwMs instances appear to be the same.

Are you sure you are using RDK 3.0 ? In RDK 3.0 blank frame is of size 352x288 not 1920x1080.I dont know why you are seeing the frame size as 1920x1080.

Anyhow to resolve the situation pls try the following:

1. Set SwMsLink_LayoutPrm.winInfo[windId].bypass = TRUE for all windows from win 0 - win 3.

2. In SwMsLink createParams set (in /dvr_rdk/mcfw/src_linux/mcfw_api/usecases/multich_vdec_vdis.c)

    swMsPrm[0].swMsInstId[0]        = SYSTEM_SW_MS_SC_INST_VIP1_SC;
    swMsPrm[0].swMsInstId[1]        = SYSTEM_SW_MS_SC_INST_DEI_SC_NO_DEI;

    swMsPrm[1].swMsInstId[0]        = SYSTEM_SW_MS_SC_INST_DEIHQ_SC_NO_DEI;
    swMsPrm[1].swMsInstId[1]        = SYSTEM_SW_MS_SC_INST_SC5;

    swMsPrm[0].numSwMsInst          = 2;

    swMsPrm[0].swMsInstStartWin[0]  = 0;
    swMsPrm[0].swMsInstStartWin[1]  = 2;

    swMsPrm[1].numSwMsInst          = swMsPrm[0].numSwMsInst;
    swMsPrm[1].swMsInstStartWin[0]  = swMsPrm[0].swMsInstStartWin[0];
    swMsPrm[1].swMsInstStartWin[1]  = swMsPrm[0].swMsInstStartWin[1];

1.  The RDK version is 03.00.00.00 .

2.  I add the SwMsLink_LayoutPrm.winInfo[windId].bypass = TRUE for win 0 - win 3 and swMsPrm[0].swMsInstStartWin[1]  = 2. Other parameters is same.

3.  The average time for Vdec_putBitstreamBuffer () is 188ms. I use function get_current_time_to_msec to get time.

4. The IVA_HD is idle, I think you are right, it's due to application not feeding data in time.   I try other h264 source file, this file has less slices per frame.  display fps got "Output Actual  FPS   : 29 fps (147 frames) ". Any other fast way to copy h264 stream data from live555 task to vdec task?

Can you measure the time before and after

   -- START_TIME

   while(emptyBufList.numBufs == 0)     

     Vdec_requestBitstreamBuffer(&reqInfo, &emptyBufList, 0);

 -- END_TIME

and calculate the avg time in ms.Want to confirm if issue is with free buffer availability from mcfw or input bitstream availability from application.

The avg time is 118ms.  I got the time as  you say.

startTime = get_current_time_to_msec();
while(emptyBufList.numBufs == 0)
{
  Vdec_requestBitstreamBuffer(&reqInfo, &emptyBufList, 0);
}
stopTime = get_current_time_to_msec();
counTimes ++;
stopTime -= startTime;

aveTime += stopTime;

if(stopTime > maxTime)
  maxTime = stopTime;
if(stopTime < minTime)
  minTime = stopTime;  

if(counTimes == 1000)
{
 OSA_printf("max:%lld,min:%lld,ave:%lld\n",maxTime,minTime,aveTime/counTimes);
}

 console log:    max:1059,min:1,ave:118

I get the time of Vdec_requestBitstreamBuffer in Vdec_Vdis demo.  the avg time is less than 1ms .  The numbufs for vdec is the same. why in my code ,this function spend so long time?

Can you try adding a sleep before retrying for empty Buffers as below in your code:

while(emptyBufList.numBufs == 0)
{
   Vdec_requestBitstreamBuffer(&reqInfo, &emptyBufList, 0);

   OSA_waitMsec(2);
} 

else it would result in a CPU busy loop.

I've add this statement ,and still got  70ms avg time.       I print the address of emptyBufList.bitsBuf[0].bufVirtAddr.  The Vdec_Vdis demo's address is start at 0x2c8xxxxx, my code is start at 0x37b0xxxx,  does this will cause the Vdec_requestBitstreamBuffer spend more time?

I dont think BufVirtAddr has any impact on delay. To debug further can you disable Vdec channel as Vdec_disableChn(0) and check if there is any improvement. I assume you are feeding only to decoder channel 0 correct ?

The code got 70 ms avg time is only have one channel.  I've disable other 3 channels. Following is the output of Vsys_printDetailedStatistics();   Vsys_printBufferStatistics();     The system now only have one channel. just do one channel HD decode.

[m3vpss ]    
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 1508 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 14 fps (21471 frames)
 [m3vpss ]  Output Actual  FPS   : 14 fps (21471 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 70 ms
 [m3vpss ]  Scaling Internal min : 3 ms
 [m3vpss ]  Scaling Internal max : 201 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     14      3    4    0   10          0        0 (  0/255)         0          0      0 255 / -281454
 [m3vpss ]    1 |      0      0    0    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ]    2 |      0      0    0    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ]    3 |      0      0    0    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 29
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x   1080 |  2048 /  2048 | NON-TILED   |    0,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    1 | 255 |    0,    0 |   352 x    264 |   704 /   704 | NON-TILED   |  960,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  422I  |   ON  |
 [m3vpss ]    2 | 255 |    0,    0 |   352 x    264 |   704 /   704 | NON-TILED   |    0,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  422I  |   ON  |
 [m3vpss ]    3 | 255 |    0,    0 |   352 x    264 |   704 /   704 | NON-TILED   |  960,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  422I  |   ON  |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 1508 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 14 fps (22003 frames)
 [m3vpss ]  Output Actual  FPS   : 14 fps (22003 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 68 ms
 [m3vpss ]  Scaling Internal min : 1 ms
 [m3vpss ]  Scaling Internal max : 199 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |      0     14   14    0    0          0        0 (  0/255)         0          0      0 255 /   0
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 30
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x   1080 |  2048 /  2048 | NON-TILED   |    0,    0 |  1920 x   1080 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   ON  |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  1816779: DISPLAY: HDDAC(BP0) : 59 fps, Latency (Min / Max) = ( 3 / 201 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ]  1816779: DISPLAY: UNDERFLOW COUNT: HDMI(BP0) 31922, HDDAC(BP0) 22127, DVO2(BP1) 22127, SDDAC(SEC1) 85237
 [m3vpss ]  1816779: SYSTEM  : FREE SPACE : System Heap      = 5792 B, Mbx = 10239 msgs)
 [m3vpss ]  1816780: SYSTEM  : FREE SPACE : SR0 Heap         = 11003648 B (10 MB)
 [m3vpss ]  1816780: SYSTEM  : FREE SPACE : Frame Buffer     = 137673600 B (131 MB)
 [m3vpss ]  1816780: SYSTEM  : FREE SPACE : Bitstream Buffer = 205662080 B (196 MB)
 [m3vpss ]  1816780: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
 [m3vpss ]  1816907: DISPLAY: DVO2(BP1)  : 59 fps, Latency (Min / Max) = ( 1 / 200 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3024],AjustPTS[868725],MaxLead[750],MaxLag[180]
 [m3video]      1820910: HDVICP-ID:0
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]               totalAcquire2wait :0 %
 [m3video]               totalWait2Isr :14 %
 [m3video]               totalIsr2Done :0 %
 [m3video]               totalWait2Done :14 %
 [m3video]               totalDone2Release :0 %
 [m3video]               totalAcquire2Release :14 %
 [m3video]               totalAcq2acqDelay :85 %
 [m3video]               totalElapsedTime in msec : 1808047
 [m3video]               numAccessCnt:  315972
 [m3video]              IVA-FPS :     174
 [m3video]              Average time spent per frame in microsec:     801
 [m3video]      1820910: HDVICP-ID:1
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]               totalAcquire2wait :0 %
 [m3video]               totalWait2Isr :0 %
 [m3video]               totalIsr2Done :0 %
 [m3video]               totalWait2Done :0 %
 [m3video]               totalDone2Release :0 %
 [m3video]               totalAcquire2Release :0 %
 [m3video]               totalAcq2acqDelay :0 %
 [m3video]               totalElapsedTime in msec :       0
 [m3video]               numAccessCnt:       0
 [m3video]              IVA-FPS :       0
 [m3video]              Average time spent per frame in microsec:       0
 [m3video]      1820911: HDVICP-ID:2
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]               totalAcquire2wait :0 %
 [m3video]               totalWait2Isr :0 %
 [m3video]               totalIsr2Done :0 %
 [m3video]               totalWait2Done :0 %
 [m3video]               totalDone2Release :0 %
 [m3video]               totalAcquire2Release :0 %
 [m3video]               totalAcq2acqDelay :0 %
 [m3video]               totalElapsedTime in msec :       0
 [m3video]               numAccessCnt:       0
 [m3video]              IVA-FPS :       0
 [m3video]              Average time spent per frame in microsec:       0
 [m3video] 
 [m3video]  *** DECODE Statistics ***
 [m3video] 
 [m3video]  Elasped Time           : 1508 secs
 [m3video] 
 [m3video] 
 [m3video]  CH  | In Recv In User  Out
 [m3video]  Num | FPS     Skip FPS FPS
 [m3video]  -----------------------------------
 [m3video]    0 |      14        0  14
 [m3video] 
 [m3video] Multi Channel Decode Average Submit Batch Size
 [m3video] Max Submit Batch Size : 24
 [m3video] IVAHD_0 Average Batch Size : 1
 [m3video] IVAHD_0 Max achieved Batch Size : 1
 [m3video] IVAHD_1 Average Batch Size : 0
 [m3video] IVAHD_1 Max achieved Batch Size : 0
 [m3video] IVAHD_2 Average Batch Size : 0
 [m3video] IVAHD_2 Max achieved Batch Size : 0
 [m3video] 
 [m3video] Multi Channel Decode Batch break Stats
 [m3video] Total Number of Batches created: 22002
 [m3video] All numbers are based off total number of Batches created
 [m3video]       Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]       Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]       Batch breaks due to changed resolution class: 0 %
 [m3video]       Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]       Batch breaks due to channel repeat: 0 %
 [m3video]       Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 0
 [m3video] All numbers are based off total number of Batches created
 [m3video]       Batch breaks due to batch sizeexceeding limit: 0 %
 [m3video]       Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]       Batch breaks due to changed resolution class: 0 %
 [m3video]       Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]       Batch breaks due to channel repeat: 0 %
 [m3video]       Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 0
 [m3video] All numbers are based off total number of Batches created
 [m3video]       Batch breaks due to batch sizeexceeding limit: 0 %
 [m3video]       Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]       Batch breaks due to changed resolution class: 0 %
 [m3video]       Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]       Batch breaks due to channel repeat: 0 %
 [m3video]       Batch breaks due to different codec: 0 %
 [m3video] 
 [m3vpss ] 
 [m3vpss ]  *** [MP_SCLR0 ] Statistics ***
 [m3vpss ] 
 [m3vpss ]  Total Frames Received  : 26357
 [m3vpss ]  Total Frames Forwarded : 26357
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  CH  | In Recv In Reject Processed  Latency(DRV) Processed  Rejected
 [m3vpss ]  Num | FPS     FPS       FPS        Min / Max    Frames     Frames 
 [m3vpss ]  -------------------------------------------------------------------
 [m3vpss ] 
 [m3vpss ]  1822989: LOAD: CPU: 72.8% HWI: 1.2%, SWI:0.7%
 [m3vpss ] 
 [m3vpss ]  1822989: LOAD: TSK: DISPLAY0            : 0.1%
 [m3vpss ]  1822989: LOAD: TSK: DISPLAY1            : 0.1%
 [m3vpss ]  1822989: LOAD: TSK: SWMS0               : 0.3%
 [m3vpss ]  1822989: LOAD: TSK: SWMS1               : 0.3%
 [m3vpss ]  1822990: LOAD: TSK: MISC                : 70.1%
 [m3vpss ] 
 [m3video] 
 [m3video]  1823605: LOAD: CPU: 2.2% HWI: 0.3%, SWI:0.4%
 [m3video] 
 [m3video]  1823605: LOAD: TSK: IPC_OUT_M30         : 0.2%
 [m3video]  1823605: LOAD: TSK: IPC_BITS_IN0        : 0.1%
 [m3video]  1823605: LOAD: TSK: DEC0                : 0.5%
 [m3video]  1823605: LOAD: TSK: DEC_PROCESS_TSK_0   : 0.3%
 [m3video]  1823606: LOAD: TSK: MISC                : 0.4%
 [m3video] 
 [c6xdsp ] 
 [c6xdsp ]  1821774: LOAD: CPU: 0.2% HWI: 0.0%, SWI:0.0%
 [c6xdsp ] 
 [c6xdsp ]  1821774: LOAD: TSK: MISC                : 0.2%
 [c6xdsp ] 
 IPCBITSOUTLINK:Buffer Statistics
 Num Alloc Pools:1
 PoolId | TotalBufCnt | FreeBufCnt | BufSize
       0|            6|          0| 2073600

 VDEC:Buffer Statistics
 ChId | InBufCnt | OutBufCnt
     0|         5|        10
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 1824651: SWMS: Rcvd from prev = 0, Returned to prev = 26380
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 16, rdPtr 12
 [m3vpss ] Full Q -> count 1, wrPtr 12, rdPtr 11
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 1824651: SWMS: Rcvd from prev = 0, Returned to prev = 26376
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 275, rdPtr 271
 [m3vpss ] Full Q -> count 1, wrPtr 271, rdPtr 270
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 1824652: DISPLAY: Rcvd from prev = 25739, Returned to prev = 25737, BufsInDriver = 4
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 1824652: DISPLAY: Rcvd from prev = 26382, Returned to prev = 26380, BufsInDriver = 4

Pls disable channel 0 also as Vdec_disableChn(0) and check the Vdec_requestBitstreamBuffer time. This is only for debug. This looks like most likely SwMs is the bottleneck since scalar performance is exceeded.

There seem to  be some problem with SwMs configuration. Do you have enableProcessTieWitHDisplay = TRUE in your SwMs create params ? If not can you set it to TRUe and try.What is the layoutFps set to for the SwmS layout ?

After disable channel 0, the avg time is 2ms.   

Badri Narayanan said:

There seem to  be some problem with SwMs configuration. Do you have enableProcessTieWitHDisplay = TRUE in your SwMs create params ? If not can you set it to TRUe and try.What is the layoutFps set to for the SwmS layout ?

The code used to configure swms:

    swMsPrm[0].swMsInstId[0]        = SYSTEM_SW_MS_SC_INST_VIP1_SC;
    swMsPrm[0].swMsInstId[1]        = SYSTEM_SW_MS_SC_INST_DEI_SC_NO_DEI;

    swMsPrm[1].swMsInstId[0]        = SYSTEM_SW_MS_SC_INST_DEIHQ_SC_NO_DEI;
    swMsPrm[1].swMsInstId[1]        = SYSTEM_SW_MS_SC_INST_SC5;

    swMsPrm[0].numSwMsInst          = 2;

    swMsPrm[0].swMsInstStartWin[0]  = 0;
    swMsPrm[0].swMsInstStartWin[1]  = 2;

    swMsPrm[1].numSwMsInst          = swMsPrm[0].numSwMsInst;
    swMsPrm[1].swMsInstStartWin[0]  = swMsPrm[0].swMsInstStartWin[0];
    swMsPrm[1].swMsInstStartWin[1]  = swMsPrm[0].swMsInstStartWin[1];

    swMsPrm[0].enableProcessTieWithDisplay = TRUE;
    swMsPrm[1].enableProcessTieWithDisplay = TRUE;

 swMsPrm[0].layoutPrm.winInfo[0].bypass = TRUE;
 swMsPrm[0].layoutPrm.winInfo[1].bypass = TRUE; 
 swMsPrm[0].layoutPrm.winInfo[2].bypass = TRUE;
 swMsPrm[0].layoutPrm.winInfo[3].bypass = TRUE;
 
    for(i=0; i<gVsysModuleContext.vsysConfig.numDisplays; i++)
    {
        VDIS_DEV vdDevId = VDIS_DEV_HDMI;

        swMsPrm[i].inQueParams.prevLinkId     = gMultiCh_VdecVdisObj.dupId;
        swMsPrm[i].inQueParams.prevLinkQueId  = i;
        swMsPrm[i].outQueParams.nextLink      = gVdisModuleContext.displayId[i];
        swMsPrm[i].numOutBuf                 = MULTICH_NUM_SWMS_MAX_BUFFERS;

        /* Disable inQue drop at SwMs as input may arrive very fast in VDEC->VDIS use case */
        swMsPrm[i].maxInputQueLen             = SYSTEM_SW_MS_INVALID_INPUT_QUE_LEN;
        if (i == 0)
        {
            vdDevId = VDIS_DEV_HDMI;
            swMsPrm[i].maxOutRes              = VSYS_STD_1080P_60;
            swMsPrm[i].initOutRes             = gVdisModuleContext.vdisConfig.deviceParams[VDIS_DEV_HDMI].resolution;
        }
        else if (i == 1)
        {
            vdDevId = VDIS_DEV_DVO2;
            swMsPrm[i].maxOutRes              = VSYS_STD_1080P_60;
            swMsPrm[i].initOutRes             = gVdisModuleContext.vdisConfig.deviceParams[VDIS_DEV_DVO2].resolution;
        }
        /* low cost line skip mode of scaling can be used, when tiler is off */
        if(tilerEnable)
            swMsPrm[i].lineSkipMode           = FALSE;
        else
            swMsPrm[i].lineSkipMode           = TRUE;

        swMsPrm[i].enableLayoutGridDraw = gVdisModuleContext.vdisConfig.enableLayoutGridDraw;

        MultiCh_swMsGetDefaultLayoutPrm(vdDevId, &swMsPrm[i], FALSE);    /* both from 0-16 chnl */

        displayPrm[i].inQueParams[0].prevLinkId    = gVdisModuleContext.swMsId[i];
        displayPrm[i].inQueParams[0].prevLinkQueId = 0;
        displayPrm[i].displayRes                = swMsPrm[i].initOutRes;
        if (i == 1)
   displayPrm[i].displayRes            = gVdisModuleContext.vdisConfig.deviceParams[VDIS_DEV_DVO2].resolution;

        mulich_vdec_vdis_set_avsync_prm(&gMultiCh_VdecVdisObj.avsyncCfg[i],i,vdDevId);
    }

Okay, this shows bottleneck is inside MCFW. Pls check your swms configuration as mentioned in previous post.

I've post all the code used to configure the swms.   the enableProcessTieWithDisplay is equal to TRUE.

 I use vsysParams.systemUseCase = VSYS_USECASE_MULTICHN_VDEC_VDIS;   the use case configuration code i didn't change.  

The initial layout is 4x4.Your application I guess would be calling Vdis_setMosaicParam API to switch layout to 2x2.Is that correct. If so pls share each parameter of Vdis_setMosaicParam arguments.Additionally check your uboot is configuring M3 for 280Mhz.

Demo_swMsGenerateLayout(VDIS_DEV_HDMI, 0, 1,
                          DEMO_LAYOUT_MODE_4CH,
                          &vdisParams.mosaicParams[i], false,
                         DEMO_TYPE_PROGRESSIVE,
                         DEMO_HD_DISPLAY_DEFAULT_STD);

The log of console:

/opt/dvr_rdk/ti816x
Attached to slave procId 2.
Loaded file ../firmware/dvr_rdk_fw_m3vpss.xem3 on slave procId 2.
Started slave procId 2.
After Ipc_loadcallback status [0x00000000]
 [m3vpss ] ***** SYSTEM  : Frequency <ORG> - 250000000, <NEW> - 280000000  // does this means M3_vpss configure with 280MHz?
 [m3vpss ] notify_attach  rtnVal  0
 [m3vpss ] initProxyServer  rtnVal  0
 [m3vpss ] 
 [m3vpss ]  *** UTILS: CPU KHz = 560000 Khz ***
 [m3vpss ] 
 [m3vpss ]  43: SYSTEM  : System Common Init in progress !!!
 [m3vpss ]  43: SYSTEM: IPC init in progress !!!
 [m3vpss ]  43: SYSTEM: Attaching to [HOST] ...
 [m3vpss ]  1042: SYSTEM: Attaching to [HOST] ...
 [m3vpss ]  1044: SYSTEM: Attaching to [HOST] ... SUCCESS !!!
 [m3vpss ]  1044: SYSTEM: Attaching to [DSP] ...

No this does not mean M3 is configured for 280.uboot will configure M3 for 280. Pls use flash uboot that is part of RDK 3.0 on your board and when board boots up you should see prints showing the frequency printed on console.

Also pls try disabling enableProcessTieWithDisplay and check if there is any difference in performance.

swms Link just use the frame buffer.      I think the bit stream buffer is just used by vdec Link and a8 task.  i don't understand  why the swms be the bottleneck of my system?  

the output log of u-boot:

ARM clk: 1000MHz
DDR clk: 796MHz
HDVICP clk: 600MHz
L3 Fast clk: 560MHz
HDVPSS clk: 280MHz
Ducati M3 clk: 280MHz

 swMsPrm[0].enableProcessTieWithDisplay = FALSE;  the channel 0 is enable

max:873,min:2,ave:67ms

Hi Badri Narayanan

  Now the avg time for Vdec_requestBitstreamBuffer is down to 2ms, still larger than vdec_vdis demo . And the decode fps and display fps is only about half of the vdec_vdis demo.

  why print this log:

 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3025],AjustPTS[2607],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3056],AjustPTS[5247],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3023],AjustPTS[7920],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3057],AjustPTS[10527],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3024],AjustPTS[13167],MaxLead[750],MaxLag[180]
 [m3vpss ] AVSYNC:RefCLk Adjust .Delta[3023],AjustPTS[15840],MaxLead[750],MaxLag[180]

With what change did Vdec_requestBitstreamBuffer  time come down to 2 msec ?

The remaining issue is due to application feeding data slowly. The msg indicates AVSYNC is adjusting the system time since frames are coming in with lot of delay. Pls time the successive calls to feeding data to mcfw from application.You can also try disabling avsync in

/dvr_rdk/mcfw/src_linux/mcfw_api/usecases/multich_vdec_vdis.c

Change

queCfg->avsyncEnable = TRUE;

to

queCfg->avsyncEnable = FALSE;

and check if there is any improvement in fps.

To answer your question

"swms Link just use the frame buffer.      I think the bit stream buffer is just used by vdec Link and a8 task.  i don't understand  why the swms be the bottleneck of my system?  "

Decoder works as follows:

1. Check if new input buffer available.

2. Check if output buffer is available.

3. If both input and output are available do_decode

    - After decode free input and send output to next link.

In the decode_display usecase decoder output is connected to SwMs input. If SwMs does not process frames in time , decoder will not have output buffers available. This will result in decoder input buffers not getting consumed.So you will see delay in getting bitstream buffers from Vdec_requestBitstreamBuffer

Hi Badri Narayanan

   Sorry for reply late.

   I add OSA_waitMsecs(1)  in task2's main function.  then Vdec_requestBitstreamBuffer  time down to 2ms.     When i use 4 channels , the time is 9ms.

   [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 293415
 [m3vpss ]    1 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 293415
 [m3vpss ]    2 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 293415
 [m3vpss ]    3 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 293415

Mr.Mao,

 We have to  isolate the performance issue is caused by bottleneck in application feeding data to mcfw or mcfw configuration issue. For this provide the following data :

1. Is performance realtime if the same 4 channel 1080P stream is fed to mcfw decode_display demo .

2. Have you measured the time between successive Vdec_putBitstreamBuffer for the same channel in your application. This will provide info on how fast application is feeding data to mcfw.

3. Invoke Vsys_printDetailedStatistics multiple time at 1 min interval (atleast 5 times) and share the log. There seems to be issue with SwMs output fps and I want to check if it is a real issue or if it is due to wrong statistics as system has not reached steady state yet.

1.  I get  the feed  data time of one channel :  sendMin:9,sendMax:598,sendAve:47   I've never tested  this time before, maybe this is the bottleneck. 

2.  The time of whole task3 function　:　　max:111,min:0,ave:10  start from Vdec_requestBitstreamBuffer  end at  Vdec_putBitstreamBuffer ;

3.  log message:

 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 19 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 22 fps (433 frames)
 [m3vpss ]  Output Actual  FPS   : 22 fps (433 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 44 ms
 [m3vpss ]  Scaling Internal min : 11 ms
 [m3vpss ]  Scaling Internal max : 189 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     22      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 136757
 [m3vpss ]    1 |     22      0    0    0   22          0        0 (  0/255)         0          0      0 255 / 136757
 [m3vpss ]    2 |     22      0    0    0   22          0        0 (  0/255)         0          0      0 255 / 136757
 [m3vpss ]    3 |     22      0    0    0   22          0        0 (  0/255)         0          0      0 255 / 136757
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 29
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    1 |   1 |    0,    0 |  1920 x    812 |  2048 /  2048 | NON-TILED   |  960,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    2 |   2 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ]    3 |   3 |    0,    0 |  1920 x   1036 |  2048 /  2048 | NON-TILED   |  960,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 19 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 25 fps (485 frames)
 [m3vpss ]  Output Actual  FPS   : 25 fps (485 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 40 ms
 [m3vpss ]  Scaling Internal min : 3 ms
 [m3vpss ]  Scaling Internal max : 177 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     25      3    0    0   22          0        0 (  0/255)         0          0      0 255 / 136877
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 30
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |  1920 x   1080 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  136888: DISPLAY: HDDAC(BP0) : 59 fps, Latency (Min / Max) = ( 11 / 190 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ]  136888: DISPLAY: UNDERFLOW COUNT: HDMI(BP0) 691, HDDAC(BP0) 639, DVO2(BP1) 639, SDDAC(SEC1) 1128
 [m3vpss ]  136888: SYSTEM  : FREE SPACE : System Heap      = 5792 B, Mbx = 10238 msgs)
 [m3vpss ]  136889: SYSTEM  : FREE SPACE : SR0 Heap         = 11003648 B (10 MB)
 [m3vpss ]  136889: SYSTEM  : FREE SPACE : Frame Buffer     = 2493312 B (2 MB)
 [m3vpss ]  136889: SYSTEM  : FREE SPACE : Bitstream Buffer = 168337280 B (160 MB)
 [m3vpss ]  136889: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
 [m3vpss ]  136890: DISPLAY: DVO2(BP1)  : 59 fps, Latency (Min / Max) = ( 4 / 178 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3video]  140960: HDVICP-ID:0
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :48 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :49 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :49 %
 [m3video]    totalAcq2acqDelay :50 %
 [m3video]    totalElapsedTime in msec :  128589
 [m3video]    numAccessCnt:   65604
 [m3video]   IVA-FPS :     512
 [m3video]   Average time spent per frame in microsec:     940
 [m3video]  140961: HDVICP-ID:1
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :33 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :33 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :33 %
 [m3video]    totalAcq2acqDelay :66 %
 [m3video]    totalElapsedTime in msec :  127859
 [m3video]    numAccessCnt:   32796
 [m3video]   IVA-FPS :     258
 [m3video]   Average time spent per frame in microsec:    1286
 [m3video]  140961: HDVICP-ID:2
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :28 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :28 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :29 %
 [m3video]    totalAcq2acqDelay :70 %
 [m3video]    totalElapsedTime in msec :  127725
 [m3video]    numAccessCnt:   32736
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1092
 [m3video] 
 [m3video]  *** DECODE Statistics ***
 [m3video] 
 [m3video]  Elasped Time           : 19 secs
 [m3video] 
 [m3video] 
 [m3video]  CH  | In Recv In User  Out
 [m3video]  Num | FPS     Skip FPS FPS
 [m3video]  -----------------------------------
 [m3video]    0 |      22        0  22
 [m3video]    1 |      22        0  22
 [m3video]    2 |      21        0  22
 [m3video]    3 |      22        0  22
 [m3video] 
 [m3video] Multi Channel Decode Average Submit Batch Size
 [m3video] Max Submit Batch Size : 24
 [m3video] IVAHD_0 Average Batch Size : 1
 [m3video] IVAHD_0 Max achieved Batch Size : 1
 [m3video] IVAHD_1 Average Batch Size : 1
 [m3video] IVAHD_1 Max achieved Batch Size : 1
 [m3video] IVAHD_2 Average Batch Size : 1
 [m3video] IVAHD_2 Max achieved Batch Size : 1
 [m3video] 
 [m3video] Multi Channel Decode Batch break Stats
 [m3video] Total Number of Batches created: 838
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 425
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 418
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] 
 [m3vpss ] 
 [m3vpss ]  *** [MP_SCLR0 ] Statistics ***
 [m3vpss ] 
 [m3vpss ]  Total Frames Received  : 11073
 [m3vpss ]  Total Frames Forwarded : 11073
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  CH  | In Recv In Reject Processed  Latency(DRV) Processed  Rejected
 [m3vpss ]  Num | FPS     FPS       FPS        Min / Max    Frames     Frames 
 [m3vpss ]  -------------------------------------------------------------------
 [m3vpss ] 
 [m3vpss ]  143016: LOAD: CPU: 55.7% HWI: 3.2%, SWI:1.4%
 [m3vpss ] 
 [m3vpss ]  143016: LOAD: TSK: IPC_IN_M30          : 0.5%
 [m3vpss ]  143016: LOAD: TSK: DISPLAY0            : 0.3%
 [m3vpss ]  143016: LOAD: TSK: DISPLAY1            : 0.3%
 [m3vpss ]  143016: LOAD: TSK: DUP0                : 0.3%
 [m3vpss ]  143016: LOAD: TSK: SWMS0               : 1.1%
 [m3vpss ]  143016: LOAD: TSK: SWMS1               : 0.9%
 [m3vpss ]  143017: LOAD: TSK: MP_SCLR_FWD_Q0      : 0.3%
 [m3vpss ]  143017: LOAD: TSK: MISC                : 47.4%
 [m3vpss ] 
 [m3video] 
 [m3video]  143590: LOAD: CPU: 7.8% HWI: 1.1%, SWI:1.0%
 [m3video] 
 [m3video]  143590: LOAD: TSK: IPC_OUT_M30         : 0.8%
 [m3video]  143590: LOAD: TSK: IPC_BITS_IN0        : 0.6%
 [m3video]  143590: LOAD: TSK: DEC0                : 1.9%
 [m3video]  143590: LOAD: TSK: DEC_PROCESS_TSK_0   : 0.9%
 [m3video]  143590: LOAD: TSK: DEC_PROCESS_TSK_1   : 0.5%
 [m3video]  143591: LOAD: TSK: DEC_PROCESS_TSK_2   : 0.6%
 [m3video]  143591: LOAD: TSK: MISC                : 0.4%
 [m3video] 
 [c6xdsp ] 
 [c6xdsp ]  141753: LOAD: CPU: 0.2% HWI: 0.0%, SWI:0.0%
 [c6xdsp ] 
 [c6xdsp ]  141753: LOAD: TSK: MISC                : 0.2%
 [c6xdsp ] 

 IPCBITSOUTLINK:Buffer Statistics

 Num Alloc Pools:4

 PoolId | TotalBufCnt | FreeBufCnt | BufSize

       0|            6|          1| 2073600

       1|            6|          3| 2073600

       2|            6|          1| 2073600

       3|            6|          0| 2073600

 VDEC:Buffer Statistics

 ChId | InBufCnt | OutBufCnt

     0|         5|        10

     1|         3|        10

     2|         5|        10

     3|         6|        10
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 144648: SWMS: Rcvd from prev = 0, Returned to prev = 11192
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 5, wrPtr 164, rdPtr 159
 [m3vpss ] Full Q -> count 1, wrPtr 159, rdPtr 158
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 144650: SWMS: Rcvd from prev = 0, Returned to prev = 11204
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 5, wrPtr 145, rdPtr 140
 [m3vpss ] Full Q -> count 1, wrPtr 140, rdPtr 139
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 144658: DISPLAY: Rcvd from prev = 2847, Returned to prev = 2845, BufsInDriver = 4
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 144658: DISPLAY: Rcvd from prev = 3212, Returned to prev = 3210, BufsInDriver = 4

i
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 126 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 21 fps (2730 frames)
 [m3vpss ]  Output Actual  FPS   : 21 fps (2730 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 46 ms
 [m3vpss ]  Scaling Internal min : 11 ms
 [m3vpss ]  Scaling Internal max : 192 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 262823
 [m3vpss ]    1 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 262823
 [m3vpss ]    2 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 262823
 [m3vpss ]    3 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 262823
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 29
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    1 |   1 |    0,    0 |  1920 x    812 |  2048 /  2048 | NON-TILED   |  960,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    2 |   2 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ]    3 |   3 |    0,    0 |  1920 x   1036 |  2048 /  2048 | NON-TILED   |  960,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 125 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 24 fps (3059 frames)
 [m3vpss ]  Output Actual  FPS   : 24 fps (3059 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 41 ms
 [m3vpss ]  Scaling Internal min : 3 ms
 [m3vpss ]  Scaling Internal max : 182 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     24      2    0    0   21          0        0 (  0/255)         0          0      0 255 / 262835
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 30
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |  1920 x   1080 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  262870: DISPLAY: HDDAC(BP0) : 59 fps, Latency (Min / Max) = ( 10 / 193 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ]  262870: DISPLAY: UNDERFLOW COUNT: HDMI(BP0) 4453, HDDAC(BP0) 4095, DVO2(BP1) 4095, SDDAC(SEC1) 7257
 [m3vpss ]  262871: SYSTEM  : FREE SPACE : System Heap      = 5792 B, Mbx = 10238 msgs)
 [m3vpss ]  262871: SYSTEM  : FREE SPACE : SR0 Heap         = 11003648 B (10 MB)
 [m3vpss ]  262871: SYSTEM  : FREE SPACE : Frame Buffer     = 2493312 B (2 MB)
 [m3vpss ]  262871: SYSTEM  : FREE SPACE : Bitstream Buffer = 168337280 B (160 MB)
 [m3vpss ]  262872: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
 [m3vpss ]  262943: DISPLAY: DVO2(BP1)  : 59 fps, Latency (Min / Max) = ( 3 / 183 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3video]  266963: HDVICP-ID:0
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :49 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :49 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :49 %
 [m3video]    totalAcq2acqDelay :50 %
 [m3video]    totalElapsedTime in msec :  254629
 [m3video]    numAccessCnt:  130488
 [m3video]   IVA-FPS :     513
 [m3video]   Average time spent per frame in microsec:     955
 [m3video]  266964: HDVICP-ID:1
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :33 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :33 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :33 %
 [m3video]    totalAcq2acqDelay :66 %
 [m3video]    totalElapsedTime in msec :  253891
 [m3video]    numAccessCnt:   65328
 [m3video]   IVA-FPS :     258
 [m3video]   Average time spent per frame in microsec:    1282
 [m3video]  266965: HDVICP-ID:2
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :28 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :29 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :29 %
 [m3video]    totalAcq2acqDelay :70 %
 [m3video]    totalElapsedTime in msec :  253782
 [m3video]    numAccessCnt:   65100
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1091
 [m3video] 
 [m3video]  *** DECODE Statistics ***
 [m3video] 
 [m3video]  Elasped Time           : 126 secs
 [m3video] 
 [m3video] 
 [m3video]  CH  | In Recv In User  Out
 [m3video]  Num | FPS     Skip FPS FPS
 [m3video]  -----------------------------------
 [m3video]    0 |      21        0  21
 [m3video]    1 |      21        0  21
 [m3video]    2 |      21        0  21
 [m3video]    3 |      21        0  21
 [m3video] 
 [m3video] Multi Channel Decode Average Submit Batch Size
 [m3video] Max Submit Batch Size : 24
 [m3video] IVAHD_0 Average Batch Size : 1
 [m3video] IVAHD_0 Max achieved Batch Size : 1
 [m3video] IVAHD_1 Average Batch Size : 1
 [m3video] IVAHD_1 Max achieved Batch Size : 1
 [m3video] IVAHD_2 Average Batch Size : 1
 [m3video] IVAHD_2 Max achieved Batch Size : 1
 [m3video] 
 [m3video] Multi Channel Decode Batch break Stats
 [m3video] Total Number of Batches created: 5408
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 2712
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 2697
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] 
 [m3vpss ] 
 [m3vpss ]  *** [MP_SCLR0 ] Statistics ***
 [m3vpss ] 
 [m3vpss ]  Total Frames Received  : 21899
 [m3vpss ]  Total Frames Forwarded : 21899
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  CH  | In Recv In Reject Processed  Latency(DRV) Processed  Rejected
 [m3vpss ]  Num | FPS     FPS       FPS        Min / Max    Frames     Frames 
 [m3vpss ]  -------------------------------------------------------------------
 [m3vpss ] 
 [m3vpss ]  269101: LOAD: CPU: 55.8% HWI: 3.2%, SWI:1.4%
 [m3vpss ] 
 [m3vpss ]  269101: LOAD: TSK: IPC_IN_M30          : 0.5%
 [m3vpss ]  269101: LOAD: TSK: DISPLAY0            : 0.3%
 [m3vpss ]  269102: LOAD: TSK: DISPLAY1            : 0.3%
 [m3vpss ]  269102: LOAD: TSK: DUP0                : 0.3%
 [m3vpss ]  269102: LOAD: TSK: SWMS0               : 1.1%
 [m3vpss ]  269102: LOAD: TSK: SWMS1               : 0.9%
 [m3vpss ]  269102: LOAD: TSK: MP_SCLR_FWD_Q0      : 0.3%
 [m3vpss ]  269102: LOAD: TSK: MISC                : 47.5%
 [m3vpss ] 
 [m3video] 
 [m3video]  269653: LOAD: CPU: 7.9% HWI: 1.2%, SWI:1.0%
 [m3video] 
 [m3video]  269653: LOAD: TSK: IPC_OUT_M30         : 0.8%
 [m3video]  269653: LOAD: TSK: IPC_BITS_IN0        : 0.6%
 [m3video]  269653: LOAD: TSK: DEC0                : 1.9%
 [m3video]  269653: LOAD: TSK: DEC_PROCESS_TSK_0   : 0.9%
 [m3video]  269653: LOAD: TSK: DEC_PROCESS_TSK_1   : 0.5%
 [m3video]  269654: LOAD: TSK: DEC_PROCESS_TSK_2   : 0.6%
 [m3video]  269654: LOAD: TSK: MISC                : 0.4%
 [m3video] 
 [c6xdsp ] 
 [c6xdsp ]  267812: LOAD: CPU: 0.2% HWI: 0.0%, SWI:0.0%
 [c6xdsp ] 
 [c6xdsp ]  267812: LOAD: TSK: MISC                : 0.2%
 [c6xdsp ] 

 IPCBITSOUTLINK:Buffer Statistics

 Num Alloc Pools:4

 PoolId | TotalBufCnt | FreeBufCnt | BufSize

       0|            6|          3| 2073600

       1|            6|          0| 2073600

       2|            6|          5| 2073600

       3|            6|          1| 2073600

 VDEC:Buffer Statistics

 ChId | InBufCnt | OutBufCnt

     0|         2|        10

     1|         5|        10

     2|         0|        10

     3|         4|        10
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 270750: SWMS: Rcvd from prev = 0, Returned to prev = 22018
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 5, wrPtr 210, rdPtr 205
 [m3vpss ] Full Q -> count 1, wrPtr 205, rdPtr 204
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 270752: SWMS: Rcvd from prev = 0, Returned to prev = 22031
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 5, wrPtr 137, rdPtr 132
 [m3vpss ] Full Q -> count 1, wrPtr 132, rdPtr 131
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 270753: DISPLAY: Rcvd from prev = 5580, Returned to prev = 5579, BufsInDriver = 3
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 270754: DISPLAY: Rcvd from prev = 6276, Returned to prev = 6274, BufsInDriver = 4
hrtimer: interrupt took 39704 ns

i
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 159 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 21 fps (3449 frames)
 [m3vpss ]  Output Actual  FPS   : 21 fps (3449 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 46 ms
 [m3vpss ]  Scaling Internal min : 6 ms
 [m3vpss ]  Scaling Internal max : 197 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 422062
 [m3vpss ]    1 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 422062
 [m3vpss ]    2 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 422062
 [m3vpss ]    3 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 422062
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 29
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    1 |   1 |    0,    0 |  1920 x    812 |  2048 /  2048 | NON-TILED   |  960,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    2 |   2 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ]    3 |   3 |    0,    0 |  1920 x   1036 |  2048 /  2048 | NON-TILED   |  960,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 159 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 24 fps (3892 frames)
 [m3vpss ]  Output Actual  FPS   : 24 fps (3892 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 40 ms
 [m3vpss ]  Scaling Internal min : 2 ms
 [m3vpss ]  Scaling Internal max : 187 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     24      3    0    0   21          0        0 (  0/255)         0          0      0 255 / 422153
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 30
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |  1920 x   1080 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  422179: DISPLAY: HDDAC(BP0) : 59 fps, Latency (Min / Max) = ( 12 / 164 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ]  422179: DISPLAY: UNDERFLOW COUNT: HDMI(BP0) 5619, HDDAC(BP0) 5180, DVO2(BP1) 5179, SDDAC(SEC1) 9169
 [m3vpss ]  422179: SYSTEM  : FREE SPACE : System Heap      = 5792 B, Mbx = 10237 msgs)
 [m3vpss ]  422179: SYSTEM  : FREE SPACE : SR0 Heap         = 11003648 B (10 MB)
 [m3vpss ]  422179: SYSTEM  : FREE SPACE : Frame Buffer     = 2493312 B (2 MB)
 [m3vpss ]  422179: SYSTEM  : FREE SPACE : Bitstream Buffer = 168337280 B (160 MB)
 [m3vpss ]  422180: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
 [m3vpss ]  422181: DISPLAY: DVO2(BP1)  : 59 fps, Latency (Min / Max) = ( 2 / 152 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3video]  426226: HDVICP-ID:0
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :49 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :49 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :49 %
 [m3video]    totalAcq2acqDelay :50 %
 [m3video]    totalElapsedTime in msec :  413826
 [m3video]    numAccessCnt:  212100
 [m3video]   IVA-FPS :     513
 [m3video]   Average time spent per frame in microsec:     955
 [m3video]  426227: HDVICP-ID:1
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :32 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :32 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :32 %
 [m3video]    totalAcq2acqDelay :67 %
 [m3video]    totalElapsedTime in msec :  413094
 [m3video]    numAccessCnt:  106368
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1242
 [m3video]  426228: HDVICP-ID:2
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :28 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :28 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :28 %
 [m3video]    totalAcq2acqDelay :71 %
 [m3video]    totalElapsedTime in msec :  412957
 [m3video]    numAccessCnt:  106272
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1087
 [m3video] 
 [m3video]  *** DECODE Statistics ***
 [m3video] 
 [m3video]  Elasped Time           : 159 secs
 [m3video] 
 [m3video] 
 [m3video]  CH  | In Recv In User  Out
 [m3video]  Num | FPS     Skip FPS FPS
 [m3video]  -----------------------------------
 [m3video]    0 |      21        0  21
 [m3video]    1 |      21        0  21
 [m3video]    2 |      21        0  21
 [m3video]    3 |      21        0  21
 [m3video] 
 [m3video] Multi Channel Decode Average Submit Batch Size
 [m3video] Max Submit Batch Size : 24
 [m3video] IVAHD_0 Average Batch Size : 1
 [m3video] IVAHD_0 Max achieved Batch Size : 1
 [m3video] IVAHD_1 Average Batch Size : 1
 [m3video] IVAHD_1 Max achieved Batch Size : 1
 [m3video] IVAHD_2 Average Batch Size : 1
 [m3video] IVAHD_2 Max achieved Batch Size : 1
 [m3video] 
 [m3video] Multi Channel Decode Batch break Stats
 [m3video] Total Number of Batches created: 6801
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 3420
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit:00 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 3432
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] 
 [m3vpss ] 
 [m3vpss ]  *** [MP_SCLR0 ] Statistics ***
 [m3vpss ] 
 [m3vpss ]  Total Frames Received  : 35559
 [m3vpss ]  Total Frames Forwarded : 35559
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  CH  | In Recv In Reject Processed  Latency(DRV) Processed  Rejected
 [m3vpss ]  Num | FPS     FPS       FPS        Min / Max    Frames     Frames 
 [m3vpss ]  -------------------------------------------------------------------
 [m3vpss ] 
 [m3vpss ]  428280: LOAD: CPU: 55.8% HWI: 3.2%, SWI:1.4%
 [m3vpss ] 
 [m3vpss ]  428280: LOAD: TSK: IPC_IN_M30          : 0.5%
 [m3vpss ]  428280: LOAD: TSK: DISPLAY0            : 0.3%
 [m3vpss ]  428280: LOAD: TSK: DISPLAY1            : 0.3%
 [m3vpss ]  428280: LOAD: TSK: DUP0                : 0.3%
 [m3vpss ]  428280: LOAD: TSK: SWMS0               : 1.1%
 [m3vpss ]  428281: LOAD: TSK: SWMS1               : 0.9%
 [m3vpss ]  428281: LOAD: TSK: MP_SCLR_FWD_Q0      : 0.3%
 [m3vpss ]  428281: LOAD: TSK: MISC                : 47.5%
 [m3vpss ] 
 [m3video] 
 [m3video]  428884: LOAD: CPU: 7.9% HWI: 1.2%, SWI:1.0%
 [m3video] 
 [m3video]  428885: LOAD: TSK: IPC_OUT_M30         : 0.8%
 [m3video]  428885: LOAD: TSK: IPC_BITS_IN0        : 0.6%
 [m3video]  428885: LOAD: TSK: DEC0                : 1.9%
 [m3video]  428885: LOAD: TSK: DEC_PROCESS_TSK_0   : 0.9%
 [m3video]  428885: LOAD: TSK: DEC_PROCESS_TSK_1   : 0.5%
 [m3video]  428885: LOAD: TSK: DEC_PROCESS_TSK_2   : 0.6%
 [m3video]  428885: LOAD: TSK: MISC                : 0.4%
 [m3video] 
 [c6xdsp ] 
 [c6xdsp ]  427231: LOAD: CPU: 0.2% HWI: 0.0%, SWI:0.0%
 [c6xdsp ] 
 [c6xdsp ]  427231: LOAD: TSK: MISC                : 0.2%
 [c6xdsp ] 

 IPCBITSOUTLINK:Buffer Statistics

 Num Alloc Pools:4

 PoolId | TotalBufCnt | FreeBufCnt | BufSize

       0|            6|          3| 2073600

       1|            6|          4| 2073600

       2|            6|          0| 2073600

       3|            6|          6| 2073600

 VDEC:Buffer Statistics

 ChId | InBufCnt | OutBufCnt

     0|         3|        10

     1|         1|        10

     2|         5|        10

     3|         0|         7
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 430183: SWMS: Rcvd from prev = 0, Returned to prev = 35717
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 218, rdPtr 214
 [m3vpss ] Full Q -> count 1, wrPtr 214, rdPtr 213
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 430184: SWMS: Rcvd from prev = 0, Returned to prev = 35724
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 195, rdPtr 191
 [m3vpss ] Full Q -> count 1, wrPtr 191, rdPtr 190
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 430184: DISPLAY: Rcvd from prev = 9045, Returned to prev = 9043, BufsInDriver = 4
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 430184: DISPLAY: Rcvd from prev = 10174, Returned to prev = 10172, BufsInDriver = 4

i
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 101 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 21 fps (2203 frames)
 [m3vpss ]  Output Actual  FPS   : 21 fps (2203 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 45 ms
 [m3vpss ]  Scaling Internal min : 11 ms
 [m3vpss ]  Scaling Internal max : 206 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 523278
 [m3vpss ]    1 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 523278
 [m3vpss ]    2 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 523278
 [m3vpss ]    3 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 523278
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 29
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    1 |   1 |    0,    0 |  1920 x    812 |  2048 /  2048 | NON-TILED   |  960,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    2 |   2 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ]    3 |   3 |    0,    0 |  1920 x   1036 |  2048 /  2048 | NON-TILED   |  960,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 101 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 24 fps (2457 frames)
 [m3vpss ]  Output Actual  FPS   : 24 fps (2457 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 41 ms
 [m3vpss ]  Scaling Internal min : 2 ms
 [m3vpss ]  Scaling Internal max : 194 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     24      2    0    0   21          0        0 (  0/255)         0          0      0 255 / 523302
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 30
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |  1920 x   1080 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  523422: DISPLAY: HDDAC(BP0) : 59 fps, Latency (Min / Max) = ( 11 / 206 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ]  523422: DISPLAY: UNDERFLOW COUNT: HDMI(BP0) 3586, HDDAC(BP0) 3290, DVO2(BP1) 3290, SDDAC(SEC1) 5834
 [m3vpss ]  523422: SYSTEM  : FREE SPACE : System Heap      = 5792 B, Mbx = 10233 msgs)
 [m3vpss ]  523422: SYSTEM  : FREE SPACE : SR0 Heap         = 11003648 B (10 MB)
 [m3vpss ]  523423: SYSTEM  : FREE SPACE : Frame Buffer     = 2493312 B (2 MB)
 [m3vpss ]  523423: SYSTEM  : FREE SPACE : Bitstream Buffer = 168337280 B (160 MB)
 [m3vpss ]  523424: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
 [m3vpss ]  523425: DISPLAY: DVO2(BP1)  : 59 fps, Latency (Min / Max) = ( 3 / 195 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3video]  527471: HDVICP-ID:0
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :49 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :49 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :49 %
 [m3video]    totalAcq2acqDelay :50 %
 [m3video]    totalElapsedTime in msec :  515055
 [m3video]    numAccessCnt:  264192
 [m3video]   IVA-FPS :     512
 [m3video]   Average time spent per frame in microsec:     955
 [m3video]  527472: HDVICP-ID:1
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :32 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :32 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :32 %
 [m3video]    totalAcq2acqDelay :67 %
 [m3video]    totalElapsedTime in msec :  514325
 [m3video]    numAccessCnt:  132576
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1241
 [m3video]  527473: HDVICP-ID:2
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :28 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :28 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :28 %
 [m3video]    totalAcq2acqDelay :71 %
 [m3video]    totalElapsedTime in msec :  514191
 [m3video]    numAccessCnt:  132516
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1086
 [m3video] 
 [m3video]  *** DECODE Statistics ***
 [m3video] 
 [m3video]  Elasped Time           : 101 secs
 [m3video] 
 [m3video] 
 [m3video]  CH  | In Recv In User  Out
 [m3video]  Num | FPS     Skip FPS FPS
 [m3video]  -----------------------------------
 [m3video]    0 |      21        0  21
 [m3video]    1 |      21        0  21
 [m3video]    2 |      21        0  21
 [m3video]    3 |      21        0  21
 [m3video] 
 [m3video] Multi Channel Decode Average Submit Batch Size
 [m3video] Max Submit Batch Size : 24
 [m3video] IVAHD_0 Average Batch Size : 1
 [m3video] IVAHD_0 Max achieved Batch Size : 1
 [m3video] IVAHD_1 Average Batch Size : 1
 [m3video] IVAHD_1 Max achieved Batch Size : 1
 [m3video] IVAHD_2 Average Batch Size : 1
 [m3video] IVAHD_2 Max achieved Batch Size : 1
 [m3video] 
 [m3video] Multi Channel Decode Batch break Stats
 [m3video] Total Number of Batches created: 4342
 [m3video] All numbers re based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 2184
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 2187
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] 
 [m3vpss ] 
 [m3vpss ]  *** [MP_SCLR0 ] Statistics ***
 [m3vpss ] 
 [m3vpss ]  Total Frames Received  : 44274
 [m3vpss ]  Total Frames Forwarded : 44274
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  CH  | In Recv In Reject Processed  Latency(DRV) Processed  Rejected
 [m3vpss ]  Num | FPS     FPS       FPS        Min / Max    Frames     Frames 
 [m3vpss ]  -------------------------------------------------------------------
 [m3vpss ] 
 [m3vpss ]  529479: LOAD: CPU: 55.5% HWI: 3.2%, SWI:1.4%
 [m3vpss ] 
 [m3vpss ]  529479: LOAD: TSK: IPC_IN_M30          : 0.5%
 [m3vpss ]  529479: LOAD: TSK: DISPLAY0            : 0.3%
 [m3vpss ]  529479: LOAD: TSK: DISPLAY1            : 0.3%
 [m3vpss ]  529479: LOAD: TSK: DUP0                : 0.3%
 [m3vpss ]  529479: LOAD: TSK: SWMS0               : 1.1%
 [m3vpss ]  529479: LOAD: TSK: SWMS1               : 0.9%
 [m3vpss ]  529479: LOAD: TSK: MP_SCLR_FWD_Q0      : 0.3%
 [m3vpss ]  529480: LOAD: TSK: MISC                : 47.2%
 [m3vpss ] 
 [m3video] 
 [m3video]  530035: LOAD: CPU: 7.9% HWI: 1.2%, SWI:1.0%
 [m3video] 
 [m3video]  530035: LOAD: TSK: IPC_OUT_M30         : 0.8%
 [m3video]  530036: LOAD: TSK: IPC_BITS_IN0        : 0.6%
 [m3video]  530036: LOAD: TSK: DEC0                : 1.9%
 [m3video]  530036: LOAD: TSK: DEC_PROCESS_TSK_0   : 0.9%
 [m3video]  530036: LOAD: TSK: DEC_PROCESS_TSK_1   : 0.5%
 [m3video]  530036: LOAD: TSK: DEC_PROCESS_TSK_2   : 0.6%
 [m3video]  530036: LOAD: TSK: MISC                : 0.4%
 [m3video] 
 [c6xdsp ] 
 [c6xdsp ]  528198: LOAD: CPU: 0.2% HWI: 0.0%, SWI:0.0%
 [c6xdsp ] 
 [c6xdsp ]  528198: LOAD: TSK: MISC                : 0.2%
 [c6xdsp ] 

 IPCBITSOUTLINK:Buffer Statistics

 Num Alloc Pools:4

 PoolId | TotalBufCnt | FreeBufCnt | BufSize

       0|            6|          0| 2073600

       1|            6|          2| 2073600

       2|            6|          4| 2073600

       3|            6|          0| 2073600

 VDEC:Buffer Statistics

 ChId | InBufCnt | OutBufCnt

     0|         6|        10

     1|         4|        10

     2|         2|        10

     3|         6|        10
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 531195: SWMS: Rcvd from prev = 0, Returned to prev = 44395
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 107, rdPtr 103
 [m3vpss ] Full Q -> count 1, wrPtr 103, rdPtr 102
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 531196: SWMS: Rcvd from prev = 0, Returned to prev = 44404
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 340, rdPtr 336
 [m3vpss ] Full Q -> count 1, wrPtr 336, rdPtr 335
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 531197: DISPLAY: Rcvd from prev = 11238, Returned to prev = 11236, BufsInDriver = 4
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 531197: DISPLAY: Rcvd from prev = 12623, Returned to prev = 12621, BufsInDriver = 4

i
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 252 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 21 fps (5483 frames)
 [m3vpss ]  Output Actual  FPS   : 21 fps (5483 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 46 ms
 [m3vpss ]  Scaling Internal min : 7 ms
 [m3vpss ]  Scaling Internal max : 218 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 775740
 [m3vpss ]    1 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 775740
 [m3vpss ]    2 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 775740
 [m3vpss ]    3 |     21      0    0    0   21          0        0 (  0/255)         0          0      0 255 / 775740
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0]Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 29
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    1 |   1 |    0,    0 |  1920 x    812 |  2048 /  2048 | NON-TILED   |  960,    0 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ]    2 |   2 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ]    3 |   3 |    0,    0 |  1920 x   1036 |  2048 /  2048 | NON-TILED   |  960,  540 |   960 x    540 |  3840 /      0 | NON-TILED   |      OFF |    1 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 
 [m3vpss ]  Elasped Time: 252 secs
 [m3vpss ] 
 [m3vpss ]  Output Request FPS   : 24 fps (6177 frames)
 [m3vpss ]  Output Actual  FPS   : 24 fps (6177 frames)
 [m3vpss ]  Output Drop    FPS   : 0 fps (0 frames)
 [m3vpss ]  Output Reject  FPS   : 0 fps (0 frames)
 [m3vpss ]  Scaling Internal     : 40 ms
 [m3vpss ]  Scaling Internal min : 2 ms
 [m3vpss ]  Scaling Internal max : 207 ms
 [m3vpss ] 
 [m3vpss ]  Win | Window Repeat Drop Recv Que  FID Invlid Acc Event          Invalid   Que Reject Reject Latency 
 [m3vpss ]  Num | FPS    FPS    FPS  FPS  FPS  FPS        Count (Max/Min)    CH Frames Frames     Frames Min / Max
 [m3vpss ]  ------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |     24      3    0    0   21          0        0 (  0/255)         0          0      0 255 / 775768
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Parameters ***
 [m3vpss ] 
 [m3vpss ]  Output FPS: 30
 [m3vpss ] 
 [m3vpss ]  Win | Ch  | Input      | Input          | Input         | Input       | Output     |  Output         | Output        | Output      | Low Cost | SWMS | Data  | Blank |
 [m3vpss ]  Num | Num | Start X, Y | Width x Height | Pitch Y / C   | Memory Type | Start X, Y |  Width x Height | Pitch Y / C   | Memory Type | ON / OFF | Inst | Format| Frame |
 [m3vpss ]  ----------------------------------------------------------------------------------------------------------------------------------------------------------------------
 [m3vpss ]    0 |   0 |    0,    0 |  1920 x    800 |  2048 /  2048 | NON-TILED   |    0,    0 |  1920 x   1080 |  3840 /      0 | NON-TILED   |      OFF |    0 |  420SP |   OFF |
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  775872: DISPLAY: HDDAC(BP0) : 59 fps, Latency (Min / Max) = ( 7 / 192 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3vpss ]  775872: DISPLAY: UNDERFLOW COUNT: HDMI(BP0) 8995, HDDAC(BP0) 8328, DVO2(BP1) 8330, SDDAC(SEC1) 14615
 [m3vpss ]  775872: SYSTEM  : FREE SPACE : System Heap      = 5792 B, Mbx = 10232 msgs)
 [m3vpss ]  775872: SYSTEM  : FREE SPACE : SR0 Heap         = 11003648 B (10 MB)
 [m3vpss ]  775873: SYSTEM  : FREE SPACE : Frame Buffer     = 2493312 B (2 MB)
 [m3vpss ]  775873: SYSTEM  : FREE SPACE : Bitstream Buffer = 168337280 B (160 MB)
 [m3vpss ]  775874: SYSTEM  : FREE SPACE : Tiler Buffer     = 256 B (0 MB)  - TILER OFF
 [m3vpss ]  775875: DISPLAY: DVO2(BP1)  : 59 fps, Latency (Min / Max) = ( 2 / 181 ), Callback Interval (Min / Max) = ( 16 / 17 ) !!!
 [m3video]  779977: HDVICP-ID:0
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :49 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :49 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :49 %
 [m3video]    totalAcq2acqDelay :50 %
 [m3video]    totalElapsedTime in msec :  767592
 [m3video]    numAccessCnt:  393960
 [m3video]   IVA-FPS :     513
 [m3video]   Average time spent per frame in microsec:     954
 [m3video]  779978: HDVICP-ID:1
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :32 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :32 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :32 %
 [m3video]    totalAcq2acqDelay :67 %
 [m3video]    totalElapsedTime in msec :  766861
 [m3video]    numAccessCnt:  197580
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1241
 [m3video]  779979: HDVICP-ID:2
 [m3video] All percentage figures are based off totalElapsedTime
 [m3video]    totalAcquire2wait :0 %
 [m3video]    totalWait2Isr :28 %
 [m3video]    totalIsr2Done :0 %
 [m3video]    totalWait2Done :28 %
 [m3video]    totalDone2Release :0 %
 [m3video]    totalAcquire2Release :28 %
 [m3video]    totalAcq2acqDelay :71 %
 [m3video]    totalElapsedTime in msec :  766727
 [m3video]    numAccessCnt:  197148
 [m3video]   IVA-FPS :     257
 [m3video]   Average time spent per frame in microsec:    1088
 [m3video] 
 [m3video]  *** DECODE Statistics ***
 [m3video] 
 [m3video]  Elasped Time           : 252 secs
 [m3video] 
 [m3video] 
 [m3video]  CH  | In Recv In User  Out
 [m3video]  Num | FPS     Skip FPS FPS
 [m3video]  -----------------------------------
 [m3video]    0 |      21        0  21
 [m3video]    1 |      21        0  21
 [m3video]    2 |      21        0  21
 [m3video]    3 |      21        0  21
 [m3video] 
 [m3video] Multi Channel Decode Average Submit Batch Size
 [m3video] Max Submit Batch Size : 24
 [m3video] IVAHD_0 Average Batch Size : 1
 [m3video] IVAHD_0 Max achieved Batch Size : 1
 [m3video] IVAHD_1 Average Batch Size : 1
 [m3video] IVAHD_1 Max achieved Batch Size : 1
 [m3video] IVAHD_2 Average Batch Size : 1
 [m3video] IVAHD_2 Max achieved Batch Size : 1
 [m3video] 
 [m3video] Multi Channel Decode Batch break Stats
 [m3video] Total Number of Batches created: 10814
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of Batches created: 5418
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] Total Number of atches created: 5387
 [m3video] All numbers are based off total number of Batches created
 [m3video]   Batch breaks due to batch sizeexceeding limit: 100 %
 [m3video]   Batch breaks due to ReqObj Que being empty: 0 %
 [m3video]   Batch breaks due to changed resolution class: 0 %
 [m3video]   Batch breaks due to interlace and progressivecontent mix: 0 %
 [m3video]   Batch breaks due to channel repeat: 0 %
 [m3video]   Batch breaks due to different codec: 0 %
 [m3video] 
 [m3vpss ] 
 [m3vpss ]  *** [MP_SCLR0 ] Statistics ***
 [m3vpss ] 
 [m3vpss ]  Total Frames Received  : 65885
 [m3vpss ]  Total Frames Forwarded : 65885
 [m3vpss ] 
 [m3vpss ] 
 [m3vpss ]  CH  | In Recv In Reject Processed  Latency(DRV) Processed  Rejected
 [m3vpss ]  Num | FPS     FPS       FPS        Min / Max    Frames     Frames 
 [m3vpss ]  -------------------------------------------------------------------
 [m3vpss ] 
 [m3vpss ]  782062: LOAD: CPU: 55.2% HWI: 3.2%, SWI:1.4%
 [m3vpss ] 
 [m3vpss ]  782062: LOAD: TSK: IPC_IN_M30          : 0.5%
 [m3vpss ]  782062: LOAD: TSK: DISPLAY0            : 0.3%
 [m3vpss ]  782062: LOAD: TSK: DISPLAY1            : 0.3%
 [m3vpss ]  782062: LOAD: TSK: DUP0                : 0.3%
 [m3vpss ]  782062: LOAD: TSK: SWMS0               : 1.1%
 [m3vpss ]  782063: LOAD: TSK: SWMS1               : 0.9%
 [m3vpss ]  782063: LOAD: TSK: MP_SCLR_FWD_Q0      : 0.3%
 [m3vpss ]  782063: LOAD: TSK: MISC                : 46.9%
 [m3vpss ] 
 [m3video] 
 [m3video]  782614: LOAD: CPU: 7.9% HWI: 1.2%, SWI:1.0%
 [m3video] 
 [m3video]  782614: LOAD: TSK: IPC_OUT_M30         : 0.8%
 [m3video]  782614: LOAD: TSK: IPC_BITS_IN0        : 0.6%
 [m3video]  782614: LOAD: TSK: DEC0                : 1.9%
 [m3video]  782615: LOAD: TSK: DEC_PROCESS_TSK_0   : 0.9%
 [m3video]  782615: LOAD: TSK: DEC_PROCESS_TSK_1   : 0.5%
 [m3video]  782615: LOAD: TSK: DEC_PROCESS_TSK_2   : 0.6%
 [m3video]  782615: LOAD: TSK: MISC                : 0.4%
 [m3video] 
 [c6xdsp ] 
 [c6xdsp ]  780754: LOAD: CPU: 0.2% HWI: 0.0%, SWI:0.0%
 [c6xdsp ] 
 [c6xdsp ]  780754: LOAD: TSK: MISC                : 0.2%
 [c6xdsp ] 

 IPCBITSOUTLINK:Buffer Statistics

 Num Alloc Pools:4

 PoolId | TotalBufCnt | FreeBufCnt | BufSize

       0|            6|          6| 2073600

       1|            6|          3| 2073600

       2|            6|          0| 2073600

       3|            6|          3| 2073600

 VDEC:Buffer Statistics

 ChId | InBufCnt | OutBufCnt

     0|         0|         7

     1|         4|        10

     2|         6|        10

     3|         4|        10
 [m3vpss ] 
 [m3vpss ]  *** [SWMS0] Mosaic Statistics ***
 [m3vpss ] 783720: SWMS: Rcvd from prev = 0, Returned to prev = 66023
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 215, rdPtr 211
 [m3vpss ] Full Q -> count 1, wrPtr 211, rdPtr 210
 [m3vpss ] 
 [m3vpss ]  *** [SWMS1] Mosaic Statistics ***
 [m3vpss ] 783720: SWMS: Rcvd from prev = 0, Returned to prev = 66033
 [m3vpss ] SWMS Out  Buf Q Status
 [m3vpss ] Empty Q -> count 4, wrPtr 6, rdPtr 2
 [m3vpss ] Full Q -> count 0, wrPtr 2, rdPtr 2
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 783721: DISPLAY: Rcvd from prev = 16722, Returned to prev = 16720, BufsInDriver = 4
 [m3vpss ] 
 [m3vpss ]  *** Display Statistics ***
 [m3vpss ] 783721: DISPLAY: Rcvd from prev = 18818, Returned to prev = 18815, BufsInDriver = 5

I see a couple of issues:

The SwMs output request fps is only 22.

The load for miscellaneous task on VPSS M3 is very high:

[m3vpss ]  782063: LOAD: TSK: MISC                : 46.9%

How you added any links on M3 vpss or have modified any code ? In running decode_display mcfw demo I see load of only 15%. Also are you running on your own board or on udworksDVR ?

my code have four statements but vdec_vdis demo didn't use :
 swMsPrm[0].layoutPrm.winInfo[0].bypass = TRUE;
 swMsPrm[0].layoutPrm.winInfo[1].bypass = TRUE; 
 swMsPrm[0].layoutPrm.winInfo[2].bypass = TRUE;
 swMsPrm[0].layoutPrm.winInfo[3].bypass = TRUE;

no other differents between my code and vdec_vdis demo.   I don't know why the output request fps become 22.      its value always change.   I check the log file, find the output request fps equal 30, 21, 22, 24.             The link ID and link number is same as vdec_vdis demo.