TDA3XEVM: Understanding System Statistic (The p Option)

Khai Trinh

Part Number: TDA3XEVM

Hi Stanley/Piyali,

I am trying to make some sense of the statistics dump using the P Option. I have the data below. Questions are the lines in RED

[IPU1-0] 307.420575 s: [ IPC_IN_0 ] Link Statistics,
[IPU1-0] 307.420636 s: ******************************
[IPU1-0] 307.420728 s:
[IPU1-0] 307.420758 s: Elapsed time = 216102 msec
[IPU1-0] 307.420850 s:
[IPU1-0] 307.420880 s: Get Full Buf Cb = 80.36 fps
[IPU1-0] 307.420972 s: Put Empty Buf Cb = 80.36 fps
[IPU1-0] 307.421063 s: Driver/Notify Cb = 80.36 fps
[IPU1-0] 307.421368 s:
[IPU1-0] 307.421429 s: Input Statistics,
[IPU1-0] 307.421460 s:
[IPU1-0] 307.421521 s: CH | In Recv | In Drop | In User Drop | In Process
[IPU1-0] 307.421582 s: | FPS | FPS | FPS | FPS
[IPU1-0] 307.421673 s: --------------------------------------------------
[IPU1-0] 307.421765 s: 0 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.421917 s:
[IPU1-0] 307.421978 s: Output Statistics,
[IPU1-0] 307.422039 s:
[IPU1-0] 307.422070 s: CH | Out | Out | Out Drop | Out User Drop
[IPU1-0] 307.422192 s: | ID | FPS | FPS | FPS
[IPU1-0] 307.422283 s: ---------------------------------------------
[IPU1-0] 307.422344 s: 0 | 0 80.36 0. 0 0. 0
[IPU1-0] 307.422497 s:
[IPU1-0] 307.422527 s: [ IPC_IN_0 ] LATENCY,
[IPU1-0] 307.422588 s: ********************
[IPU1-0] 307.422649 s: Local Link Latency : Avg = 8 us, Min = 0 us, Max = 31 us,
[IPU1-0] 307.422771 s: Source to Link Latency : Avg = 310 us, Min = 274 us, Max = 549 us,
[IPU1-0] 307.422924 s:
[IPU1-0] 307.422985 s: CPU [ DSP1], LinkID [ 26], Link Statistics not available !
[IPU1-0] 307.423168 s:
[IPU1-0] 307.423229 s: ### CPU [ DSP1], LinkID [ 49],
[IPU1-0] 307.423290 s:
[IPU1-0] 307.423351 s: [ ti.radar.fft ] Link Statistics,
[IPU1-0] 307.423412 s: ******************************
[IPU1-0] 307.423473 s:
[IPU1-0] 307.423534 s: Elapsed time = 216105 msec
[IPU1-0] 307.423595 s:
[IPU1-0] 307.423656 s: New data Recv = 80.36 fps
[IPU1-0] 307.423717 s:
[IPU1-0] 307.423747 s: Input Statistics,
[IPU1-0] 307.423808 s:
[IPU1-0] 307.423839 s: CH | In Recv | In Drop | In User Drop | In Process
[IPU1-0] 307.423930 s: | FPS | FPS | FPS | FPS
[IPU1-0] 307.423991 s: --------------------------------------------------
[IPU1-0] 307.424083 s: 0 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.424266 s:
[IPU1-0] 307.424327 s: Output Statistics,
[IPU1-0] 307.424357 s:
[IPU1-0] 307.424418 s: CH | Out | Out | Out Drop | Out User Drop
[IPU1-0] 307.424479 s: | ID | FPS | FPS | FPS
[IPU1-0] 307.424571 s: ---------------------------------------------
[IPU1-0] 307.424632 s: 0 | 0 80.36 0. 0 0. 0
[IPU1-0] 307.424784 s:
[IPU1-0] 307.424815 s: [ ti.radar.fft ] LATENCY,
[IPU1-0] 307.424876 s: ********************
[IPU1-0] 307.424937 s: Local Link Latency : Avg = 2292 us, Min = 2257 us, Max = 2380 us,
[IPU1-0] 307.425059 s: Source to Link Latency : Avg = 2700 us, Min = 2623 us, Max = 2989 us,
[IPU1-0] 307.425211 s:
[IPU1-0] 307.425272 s: CPU [ DSP1], LinkID [ 25], Link Statistics not available !
[IPU1-0] 307.425425 s:
[IPU1-0] 307.425486 s: ### CPU [ DSP1], LinkID [ 50],
[IPU1-0] 307.425547 s:
[IPU1-0] 307.425608 s: [ ti.radar.pkDetect ] Link Statistics,
[IPU1-0] 307.425669 s: ******************************
[IPU1-0] 307.425730 s:
[IPU1-0] 307.425791 s: Elapsed time = 216104 msec
[IPU1-0] 307.425852 s:
[IPU1-0] 307.425913 s: New data Recv = 80.36 fps
[IPU1-0] 307.425974 s:
[IPU1-0] 307.426005 s: Input Statistics,
[IPU1-0] 307.426066 s:
[IPU1-0] 307.426127 s: CH | In Recv | In Drop | In User Drop | In Process
[IPU1-0] 307.426401 s: | FPS | FPS | FPS | FPS
[IPU1-0] 307.426493 s: --------------------------------------------------
[IPU1-0] 307.426584 s: 0 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.426737 s:
[IPU1-0] 307.426767 s: Output Statistics,
[IPU1-0] 307.426859 s:
[IPU1-0] 307.426889 s: CH | Out | Out | Out Drop | Out User Drop
[IPU1-0] 307.426981 s: | ID | FPS | FPS | FPS
[IPU1-0] 307.427072 s: ---------------------------------------------
[IPU1-0] 307.427194 s: 0 | 0 80.36 0. 0 0. 0
[IPU1-0] 307.427347 s:
[IPU1-0] 307.427377 s: [ ti.radar.pkDetect ] LATENCY,
[IPU1-0] 307.427469 s: ********************
[IPU1-0] 307.427530 s: Local Link Latency : Avg = 914 us, Min = 884 us, Max = 1037 us,
[IPU1-0] 307.427652 s: Source to Link Latency : Avg = 3738 us, Min = 3660 us, Max = 4027 us,
[IPU1-0] 307.427804 s:
[IPU1-0] 307.427865 s: CPU [ DSP1], LinkID [ 38], Link Statistics not available !
[IPU1-0] 307.428018 s:
[IPU1-0] 307.428079 s: ### CPU [ DSP1], LinkID [ 34],
[IPU1-0] 307.428201 s:
[IPU1-0] 307.428262 s: [ SYNC_0 ] Link Statistics,
[IPU1-0] 307.428323 s: ******************************
[IPU1-0] 307.428384 s:
[IPU1-0] 307.428445 s: Elapsed time = 216110 msec
[IPU1-0] 307.428506 s:
[IPU1-0] 307.428536 s: New data Recv = 271.15 fps
[IPU1-0] 307.428628 s: Get Full Buf Cb = 80.36 fps
[IPU1-0] 307.428719 s: Put Empty Buf Cb = 80.35 fps
[IPU1-0] 307.428811 s: Driver/Notify Cb = 30.30 fps
[IPU1-0] 307.429085 s:
[IPU1-0] 307.429207 s: Input Statistics,
[IPU1-0] 307.429268 s:
[IPU1-0] 307.429299 s: CH | In Recv | In Drop | In User Drop | In Process
[IPU1-0] 307.429390 s: | FPS | FPS | FPS | FPS
[IPU1-0] 307.429482 s: --------------------------------------------------
[IPU1-0] 307.429573 s: 0 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.429695 s: 1 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.429848 s: 2 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.430000 s:
[IPU1-0] 307.430031 s: Output Statistics,
[IPU1-0] 307.430092 s:
[IPU1-0] 307.430153 s: CH | Out | Out | Out Drop | Out User Drop
[IPU1-0] 307.430244 s: | ID | FPS | FPS | FPS
[IPU1-0] 307.430336 s: ---------------------------------------------
[IPU1-0] 307.430397 s: 0 | 0 80.36 0. 0 0. 0
[IPU1-0] 307.430549 s:
[IPU1-0] 307.431068 s: [ SYNC_0 ] LATENCY,
[IPU1-0] 307.431342 s: ********************
[IPU1-0] 307.431434 s: Local Link Latency : Avg = 1504 us, Min = 0 us, Max = 3630 us,
[IPU1-0] 307.431556 s: Source to Link Latency : Avg = 3846 us, Min = 3751 us, Max = 4148 us,
[IPU1-0] 307.431708 s:
[IPU1-0] 307.431861 s:
[IPU1-0] 307.431922 s: ### CPU [ DSP1], LinkID [ 0],
[IPU1-0] 307.432013 s:
[IPU1-0] 307.432044 s: [ IPC_OUT_0 ] Link Statistics,
[IPU1-0] 307.432166 s: ******************************
[IPU1-0] 307.432227 s:
[IPU1-0] 307.432288 s: Elapsed time = 216109 msec
[IPU1-0] 307.432349 s:
[IPU1-0] 307.432410 s: New data Recv = 80.36 fps
[IPU1-0] 307.432501 s: Release data Recv = 80.43 fps
[IPU1-0] 307.432562 s: Driver/Notify Cb = 180.35 fps
[IPU1-0] 307.432654 s:
[IPU1-0] 307.432715 s: Input Statistics,
[IPU1-0] 307.432745 s:
[IPU1-0] 307.432806 s: CH | In Recv | In Drop | In User Drop | In Process
[IPU1-0] 307.432898 s: | FPS | FPS | FPS | FPS
[IPU1-0] 307.432989 s: --------------------------------------------------
[IPU1-0] 307.433081 s: 0 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.433264 s:
[IPU1-0] 307.433325 s: Output Statistics,
[IPU1-0] 307.433386 s:
[IPU1-0] 307.433416 s: CH | Out | Out | Out Drop | Out User Drop
[IPU1-0] 307.433508 s: | ID | FPS | FPS | FPS
[IPU1-0] 307.433569 s: ---------------------------------------------
[IPU1-0] 307.433660 s: 0 | 0 80.36 0. 0 0. 0
[IPU1-0] 307.433782 s:
[IPU1-0] 307.433813 s: [ IPC_OUT_0 ] LATENCY,
[IPU1-0] 307.433904 s: ********************
[IPU1-0] 307.433965 s: Local Link Latency : Avg = 4 us, Min = 0 us, Max = 31 us,
[IPU1-0] 307.434118 s: Source to Link Latency : Avg = 3880 us, Min = 3782 us, Max = 4179 us,
[IPU1-0] 307.434270 s:
[IPU1-0] 307.934392 s:
[IPU1-0] 307.934484 s: ### CPU [IPU1-1], LinkID [ 10],
[IPU1-0] 307.934575 s:
[IPU1-0] 307.935185 s: [ IPC_IN_0 ] Link Statistics,
[IPU1-0] 307.935277 s: ******************************
[IPU1-0] 307.935368 s:
[IPU1-0] 307.935399 s: Elapsed time = 216108 msec
[IPU1-0] 307.935460 s:
[IPU1-0] 307.935521 s: Get Full Buf Cb = 28.23 fps
[IPU1-0] 307.935582 s: Put Empty Buf Cb = 80.36 fps
[IPU1-0] 307.935673 s: Driver/Notify Cb = 80.35 fps
[IPU1-0] 307.935765 s:
[IPU1-0] 307.935795 s: Input Statistics,
[IPU1-0] 307.935856 s:
[IPU1-0] 307.935917 s: CH | In Recv | In Drop | In User Drop | In Process
[IPU1-0] 307.936009 s: | FPS | FPS | FPS | FPS
[IPU1-0] 307.936070 s: --------------------------------------------------
[IPU1-0] 307.936405 s: 0 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.936558 s:
[IPU1-0] 307.936619 s: Output Statistics,
[IPU1-0] 307.936649 s:
[IPU1-0] 307.936710 s: CH | Out | Out | Out Drop | Out User Drop
[IPU1-0] 307.936802 s: | ID | FPS | FPS | FPS
[IPU1-0] 307.936893 s: ---------------------------------------------
[IPU1-0] 307.936985 s: 0 | 0 80.36 0. 0 0. 0
[IPU1-0] 307.937290 s:
[IPU1-0] 307.937351 s: [ IPC_IN_0 ] LATENCY,
[IPU1-0] 307.937442 s: ********************
[IPU1-0] 307.937503 s: Local Link Latency : Avg = 56 us, Min = 30 us, Max = 153 us,
[IPU1-0] 307.937625 s: Source to Link Latency : Avg = 4103 us, Min = 3995 us, Max = 4393 us,
[IPU1-0] 307.937747 s:
[IPU1-0] 307.937839 s:
[IPU1-0] 307.937900 s: ### CPU [IPU1-1], LinkID [ 63],
[IPU1-0] 307.937961 s:
[IPU1-0] 307.938022 s: [ NETWORK TX ] Link Statistics,
[IPU1-0] 307.938113 s: ******************************
[IPU1-0] 307.938235 s:
[IPU1-0] 307.938296 s: Elapsed time = 216085 msec
[IPU1-0] 307.938388 s:
[IPU1-0] 307.938418 s: New data Recv = 28.23 fps
[IPU1-0] 307.938510 s:
[IPU1-0] 307.938540 s: Input Statistics,
[IPU1-0] 307.938601 s:
[IPU1-0] 307.938632 s: CH | In Recv | In Drop | In User Drop | In Process
[IPU1-0] 307.938723 s: | FPS | FPS | FPS | FPS
[IPU1-0] 307.938784 s: --------------------------------------------------
[IPU1-0] 307.938876 s: 0 | 80.36 0. 0 0. 0 80.36
[IPU1-0] 307.939028 s:
[IPU1-0] 307.939089 s: Output Statistics,
[IPU1-0] 307.939181 s:
[IPU1-0] 307.939211 s: CH | Out | Out | Out Drop | Out User Drop
[IPU1-0] 307.939303 s: | ID | FPS | FPS | FPS
[IPU1-0] 307.939364 s: ---------------------------------------------
[IPU1-0] 307.939455 s:
[IPU1-0] 307.939516 s: [ NETWORK TX ] LATENCY,
[IPU1-0] 307.939577 s: ********************
[IPU1-0] 307.939638 s: Local Link Latency : Avg = 27667 us, Min = 18697 us, Max = 594705 us,
[IPU1-0] 307.939760 s: Source to Link Latency : Avg = 31717 us, Min = 22784 us, Max = 598701 us,

1. Can you explain what Get Full Buf Cb vs. Put Empty Bug CB vs. Driver/Notify CB?

2. What does it mean when Get Full Buf CB is much slower than the other 2?

3. The line New Data Recv = 28.23 fps. What does that mean?

Thanks,

--Khai

over 6 years ago

0 Anuj Gupta over 6 years ago

TI__Genius 15985 points

Hi,

If you check the link_init function of any link then you will find each link has some callback function like get full buffers, put empty buffer and get link information.

So all this stats measure how many times this function are hit.

New data recv measure how many times it got new frame buffer.

Regards,

Anuj

0 Khai Trinh over 6 years ago in reply to Anuj Gupta

Genius 4140 points

Hi Anjui,

Thanks for the info and brief explanation. If I understand the meanings correctly, the Network_TX link received New Data at 28.23 fps. This happened when I started betqork_rx.out streaming from an external Host. If I don't have network_rx.out running, this will recover back to 83.33 fps which is the frame rate I set in the chirp profile. My question is

Does this mean I only received 28.23 fps on external Host rather than at 83.33 fps ? But doing a time measurement on the Host indicates the fps is in fact 80 fpa rather than 28.23 fps.

This is very critical to us to know. Does that mean the system is lagging at the pre-defined framePeriod set in Chirp Profile and thus frame dropped internally?

Regards,

--Khai

0 Anuj Gupta over 6 years ago in reply to Khai Trinh

TI__Genius 15985 points

Hi,

As you can see in your log

So the new data recv shows how many times it got new buffer or actually new data cmd from previous link. it does not mean how many new proper buffer it got.

In Recv FPS tell how many new buffer it got which can be processed. Actually when a link get a new data command then it fetches data from previous link in a frameholder and inside frameholder there can be multiple frames.

There is something called out FPS which is the actual count how many frames it is sending over ethernet or to the next link.

Regards,

Anuj

0 Anuj Gupta over 6 years ago in reply to Anuj Gupta

TI__Genius 15985 points

Hi,

Its been long since any update on this thread.

I hope the issue is resolved.

If not then please reply below or create a new thread for a different query.

Regards,

Anuj

0 Khai Trinh over 6 years ago in reply to Anuj Gupta

Genius 4140 points

Resolved. Thx

Processors

Processors forum

TDA3XEVM: Understanding System Statistic (The p Option)