Tool/software:
We are now using SDK9.1 and have a problem: the application cannot execute, after troubleshooting, blocking IPC synchronization, C7x1 itself is running down without synchronization complete, but C7x1 log indicates that synchronization is complete. The end result is that everything but the core of the C7X1 is blocked on appLogCpuSyncInit, and RF52_0 has been waiting for the C7x_1 synchronization state to change to APP_LOG_CPU_SYNC_STATE_CONFIRM_INIT_DONE (3). Ambient temperature -40 ° C.
we read syncstatus by devmem2 as folow:
R5F2_1 3 (address 0xAF01000C)
R5F3_0 3 (address 0xAF01400C)
R5F3_1 3 ( address 0xAF01800C)
R5F4_0 3 ( address 0xAF01C00C)
R5F4_1 3 ( address 0xAF02000C)
C7x_1 2 ( address 0xAF02400C)
C7x_1 1 ( address 0xAF02800C)
C7x_1 1 ( address 0xAF02C00C)
C7x_1 1 ( address 0xAF03000C)
boot log as flow:
root@j784s4-evm:/opt/vision_apps# ./vision_apps_init.sh root@j784s4-evm:/opt/vision_apps# [MCU2_0] 5.976477 s: CIO: Init ... Done !!! [MCU2_0] 5.976532 s: ### CPU Frequency = 1000000000 Hz [MCU2_0] 5.976566 s: CPU is running FreeRTOS [MCU2_0] 5.976587 s: APP: Init ... !!! [MCU2_0] 5.976630 s: SCICLIENT: Init ... !!! [MCU2_0] 5.977493 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [MCU2_0] 5.977529 s: SCICLIENT: DMSC FW revision 0x9 [MCU2_0] 5.977557 s: SCICLIENT: DMSC FW ABI revision 3.1 [MCU2_0] 5.977589 s: SCICLIENT: Init ... Done !!! [MCU2_0] 5.977612 s: UDMA: Init ... !!! [MCU2_0] 5.985815 s: UDMA: Init ... Done !!! [MCU2_0] 5.985853 s: UDMA: Init for CSITX/CSIRX ... !!! [MCU2_0] 5.989518 s: UDMA: Init for CSITX/CSIRX ... Done !!! [MCU2_0] 5.989554 s: MEM: Init ... !!! [MCU2_0] 5.989586 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ b4000000 of size 16777216 bytes !!! [MCU2_0] 5.989648 s: MEM: Created heap (L3_MEM, id=1, flags=0x00000000) @ 60000000 of size 262144 bytes !!! [MCU2_0] 5.989702 s: MEM: Init ... Done !!! [MCU2_0] 5.989723 s: IPC: Init ... !!! [MCU2_0] 5.989766 s: IPC: 11 CPUs participating in IPC !!! [MCU2_0] 5.989811 s: IPC: Waiting for HLOS to be ready ... !!! [MCU2_0] 19.439735 s: IPC: HLOS is ready !!! [MCU2_0] 19.478059 s: IPC: Init ... Done !!! [MCU2_0] 19.478100 s: APP: Syncing with 10 CPUs ... !!! [MCU2_1] 5.843817 s: CIO: Init ... Done !!! [MCU2_1] 5.843873 s: ### CPU Frequency = 1000000000 Hz [MCU2_1] 5.843905 s: CPU is running FreeRTOS [MCU2_1] 5.843927 s: APP: Init ... !!! [MCU2_1] 5.843968 s: SCICLIENT: Init ... !!! [MCU2_1] 5.844880 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [MCU2_1] 5.844914 s: SCICLIENT: DMSC FW revision 0x9 [MCU2_1] 5.844956 s: SCICLIENT: DMSC FW ABI revision 3.1 [MCU2_1] 5.844988 s: SCICLIENT: Init ... Done !!! [MCU2_1] 5.845011 s: UDMA: Init ... !!! [MCU2_1] 5.854761 s: UDMA: Init ... Done !!! [MCU2_1] 5.854799 s: MEM: Init ... !!! [MCU2_1] 5.854832 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ b5000000 of size 16777216 bytes !!! [MCU2_1] 5.854891 s: MEM: Init ... Done !!! [MCU2_1] 5.854913 s: IPC: Init ... !!! [MCU2_1] 5.854957 s: IPC: 11 CPUs participating in IPC !!! [MCU2_1] 5.854995 s: IPC: Waiting for HLOS to be ready ... !!! [MCU2_1] 19.440478 s: IPC: HLOS is ready !!! [MCU2_1] 19.480853 s: IPC: Init ... Done !!! [MCU2_1] 19.480894 s: APP: Syncing with 10 CPUs ... !!! [MCU3_0] 9.069777 s: CIO: Init ... Done !!! [MCU3_0] 9.069834 s: ### CPU Frequency = 1000000000 Hz [MCU3_0] 9.069867 s: CPU is running FreeRTOS [MCU3_0] 9.069889 s: APP: Init ... !!! [MCU3_0] 9.069925 s: SCICLIENT: Init ... !!! [MCU3_0] 9.071580 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [MCU3_0] 9.071614 s: SCICLIENT: DMSC FW revision 0x9 [MCU3_0] 9.071642 s: SCICLIENT: DMSC FW ABI revision 3.1 [MCU3_0] 9.071674 s: SCICLIENT: Init ... Done !!! [MCU3_0] 9.071697 s: MEM: Init ... !!! [MCU3_0] 9.071728 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ b6000000 of size 16777216 bytes !!! [MCU3_0] 9.071785 s: MEM: Init ... Done !!! [MCU3_0] 9.071807 s: IPC: Init ... !!! [MCU3_0] 9.071849 s: IPC: 11 CPUs participating in IPC !!! [MCU3_0] 9.071888 s: IPC: Waiting for HLOS to be ready ... !!! [MCU3_0] 19.661557 s: IPC: HLOS is ready !!! [MCU3_0] 19.687327 s: IPC: Init ... Done !!! [MCU3_0] 19.687369 s: APP: Syncing with 10 CPUs ... !!! [MCU3_1] 9.081546 s: CIO: Init ... Done !!! [MCU3_1] 9.081604 s: ### CPU Frequency = 1000000000 Hz [MCU3_1] 9.081639 s: CPU is running FreeRTOS [MCU3_1] 9.081662 s: APP: Init ... !!! [MCU3_1] 9.081699 s: SCICLIENT: Init ... !!! [MCU3_1] 9.085142 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [MCU3_1] 9.085177 s: SCICLIENT: DMSC FW revision 0x9 [MCU3_1] 9.085206 s: SCICLIENT: DMSC FW ABI revision 3.1 [MCU3_1] 9.085240 s: SCICLIENT: Init ... Done !!! [MCU3_1] 9.085264 s: MEM: Init ... !!! [MCU3_1] 9.085296 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ b7000000 of size 16777216 bytes !!! [MCU3_1] 9.085357 s: MEM: Init ... Done !!! [MCU3_1] 9.085380 s: IPC: Init ... !!! [MCU3_1] 9.085423 s: IPC: 11 CPUs participating in IPC !!! [MCU3_1] 9.085463 s: IPC: Waiting for HLOS to be ready ... !!! [MCU3_1] 19.751320 s: IPC: HLOS is ready !!! [MCU3_1] 19.777154 s: IPC: Init ... Done !!! [MCU3_1] 19.777193 s: APP: Syncing with 10 CPUs ... !!! [MCU4_0] 9.125062 s: CIO: Init ... Done !!! [MCU4_0] 9.125146 s: ### CPU Frequency = 1000000000 Hz [MCU4_0] 9.125183 s: CPU is running FreeRTOS [MCU4_0] 9.125206 s: APP: Init ... !!! [MCU4_0] 9.125258 s: SCICLIENT: Init ... !!! [MCU4_0] 9.126428 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [MCU4_0] 9.126467 s: SCICLIENT: DMSC FW revision 0x9 [MCU4_0] 9.126496 s: SCICLIENT: DMSC FW ABI revision 3.1 [MCU4_0] 9.126529 s: SCICLIENT: Init ... Done !!! [MCU4_0] 9.126554 s: UDMA: Init ... !!! [MCU4_0] 9.140244 s: UDMA: Init ... Done !!! [MCU4_0] 9.140288 s: MEM: Init ... !!! [MCU4_0] 9.140323 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ b8000000 of size 16777216 bytes !!! [MCU4_0] 9.140385 s: MEM: Init ... Done !!! [MCU4_0] 9.140408 s: IPC: Init ... !!! [MCU4_0] 9.140462 s: IPC: 11 CPUs participating in IPC !!! [MCU4_0] 9.140507 s: IPC: Waiting for HLOS to be ready ... !!! [MCU4_0] 19.838566 s: IPC: HLOS is ready !!! [MCU4_0] 19.864284 s: IPC: Init ... Done !!! [MCU4_0] 19.864325 s: APP: Syncing with 10 CPUs ... !!! [MCU4_1] 9.097354 s: CIO: Init ... Done !!! [MCU4_1] 9.097413 s: ### CPU Frequency = 1000000000 Hz [MCU4_1] 9.097451 s: CPU is running FreeRTOS [MCU4_1] 9.097472 s: APP: Init ... !!! [MCU4_1] 9.097510 s: SCICLIENT: Init ... !!! [MCU4_1] 9.100111 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [MCU4_1] 9.100147 s: SCICLIENT: DMSC FW revision 0x9 [MCU4_1] 9.100176 s: SCICLIENT: DMSC FW ABI revision 3.1 [MCU4_1] 9.100207 s: SCICLIENT: Init ... Done !!! [MCU4_1] 9.100231 s: MEM: Init ... !!! [MCU4_1] 9.100262 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ b9000000 of size 16777216 bytes !!! [MCU4_1] 9.100322 s: MEM: Init ... Done !!! [MCU4_1] 9.100343 s: IPC: Init ... !!! [MCU4_1] 9.100388 s: IPC: 11 CPUs participating in IPC !!! [MCU4_1] 9.100431 s: IPC: Waiting for HLOS to be ready ... !!! [MCU4_1] 19.928392 s: IPC: HLOS is ready !!! [MCU4_1] 19.953853 s: IPC: Init ... Done !!! [MCU4_1] 19.953896 s: APP: Syncing with 10 CPUs ... !!! [C7x_1 ] 8.819788 s: CIO: Init ... Done !!! [C7x_1 ] 8.819805 s: ### CPU Frequency = 1000000000 Hz [C7x_1 ] 8.819818 s: CPU is running FreeRTOS [C7x_1 ] 8.819827 s: APP: Init ..& !!! [C7x_1 ] 8.819835 s: SCICLIENT: Init ... !!! [C7x_1 ] 8.820758 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [C7x_1 ] 8.820774 s: SCICLIENT: DMSC FW revision 0x9 [C7x_1 ] 8.820786 s: SCICLIENT: DMSC FW ABI revision 3.1 [C7x_1 ] 8.820798 s: SCICLIENT: Init ... Done !!! [C7x_1 ] 8.820808 s: UDMA: Init ... !!! [C7x_1 ] 8.836997 s: UDMA: Init ... Done !!! [C7x_1 ] 8.837012 s: MEM: Init ... !!! [C7x_1 ] 8.837024 s: MEM: Created heap (DDR_LOCAL_MEM, id-0, flags=0x00000004) @ 104000000 of size 134217728 bytes !!! [C7x_1 ] 8.837046 s: MEM: Init ... Done !!! [C7x_1 ] 8.837055 s: IPC: Init ... !!! [C7x_1 ] 8.837070 s: IPC: 11 CPUs participating in IPC !!! [C7x_1 ] 8.837087 s: IPC: Waiting for HLOS to be ready ... !!! [C7x_1 ] 19.878908 s: IPC: HLOS is ready !!! [C7x_1 ] 19.891871 s: IPC: Init ... Done !!! [C7x_1 ] 19.891887 s: APP: Syncing with 10 CPUs ... !!! [C7x_1 ] 20.270926 s: APP: Syncing with 10 CPUs ... Done !!! [C7x_1 ] 20.270942 s: REMOTE_SERVICE: Init ... !!! [C7x_1 ] 20.271142 s: REMOTE_SERVICE: Init ... Done !!! [C7x_1 ] 20.271164 s: FT_REMOTE_SERVICE: Int ... !!! [C7x_1 ] 20.271347 s: FT_REMOUE_SERVICE: Init ... Done !!! [C7x_1 ] 20.271373 s: VX_ZONE_INIT:Enabled [C7x_1 ] 20.271386 s: VX_ZONE_ERROR:Enabled [C7x_1 ] 20.271400 s: VX_ZONE_WARNING:Enabled [C7x_1 ] 20.271831 s: VX_ZONE_INIT:[tivxPlatformCreateTargetId:59] Added target DSP_C7-1 [C7x_1 ] 20.271912 s: VX_ZONE_INIT:[tivxPlatformCreateTargetId:59] Added target DSP_C7-1_PRI_2 [C7x_1 ] 20.271987 s: VX_ZONE_INIT:[tivxPlatformCreateTargetId:59] Added target DSP_C7-1_PRI_3 [C7x_1 ] 20.272060 s: VX_ZONE_INIT:[tivxPlatformCreaPeTargetId:59] Added target DSP_C7-1_PRI_4 [C7x_1 ] 20.272137 s: VX_ZONE_INIT:[tivxPlatformCreateTargetId:59] Added target DSP_C7-1_PRI_5 [C7x_1 ] 20.272214 s: VX_ZONE_INIT:[tivxPlatformCreateTargetId:59] Added target DSP_C7-1_PRI_6 [C7x_1 ] 20.272299 s: VX_ZONE_INIT:[tivxPlatformCreateTargetId:59] Added target DSP_C7-1_PRI_7 [C7x_1 ] 20.272384 s: VX_ZONE_INIT:[tivxPlatformCreateTargetId:59] Added target DSP_C7-1_PRI_8 [C7x_1 ] 20.272410 s: VX_ZONE_INIT:[tivxInitLocal:130] Initialization Done !!! [C7x_1 ] 20.272424 s: APP: OpenVX Target kernel init ... !!! [C7x_1 ] 20.273294 s: APP: OpenVX Target kernel init ... Done !!! [C7x_1 ] 20.273311 s: APP: Init ... Done !!! [C7x_1 ] 20.273321 s: APP: Run ... !!! [C7x_1 ] 20.273330 s: IPC: Starting echo test ... [C7x_1 ] 20.273560 s: APP: Run ... Done !!! [C7x_1 ] 20.275068 s: \cf7 11.455s INFO |OSA |coroutine module closed [C7x_1 ] 20.275097 s: 11.455s INFO |OSA |BUILD_VERSION=[ef3b750][2024-08-13-03:17:54][2024-09-05-04:39:29] [C7x_1 ] 20.275126 s: 11.455s INFO |DRIVER |BUI D_VERSION=[c5b2229]024-09-04-01:12:58][2024-09-05-04:40:08] [C7x_1 ] 20.275205 s: 11.455s INFO |DRV_IPC |IPC device[type:0] RX handle[endpt:90] create successfully [C7x_1 ] 20.275261 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:0] TX handle[endpt:114] create successfully [C7x_1 ] 20.275320 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:1] TX handle[endpt:115] create successfully [C7x_1 ] 20.275369 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:2] TX handle[endpt:116] create successfully [C7x_1 ] 20.275412 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:3] TX handle[endpt:117] create successfully [C7x_1 ] 20.275454 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:4] TX handle[endpt:118] create successfully [C7x_1 ] 20.275498 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:5] TX handle[endpt:119] create successfully [C7x_1 ] 20.275542 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:6] TX handle[endpt:120] create successfully [C7x_1 ] 20.275588 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:7] TX handle[endpt:121] create successfully [C7x_1 ] 20.275633 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:8] TX handle[endpt:122] create successfully [C7x_1 ] 20.275679 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:9] TX handle[endpt:123] create successfully [C7x_1 ] 20.275725 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:10] TX handle[endpt:124] create successfully [C7x_1 ] 20.275767 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:11] TX handle[endpt:125] create successfully [C7x_1 ] 20.275811 s: 11.456s INFO |DRV_IPC |IPC device[type:0 core:12] TX handle[endpt:126] create successfully [C7x_1 ] 20.275877 s: 11.456s INFO |DRV_IPC |IPC RPMessage_announce 'rpmsg_chrdev' successfully. [C7x_1 ] 20.275950 s: 11.456s INFO |DRV_IPC |IPC create IPC_RXTask@90 task successfully. [C7x_1 ] 20.275977 s: 11.456s INFO |DRV_IPC |IPC device TX handle create successfully. [C7x_1 ] 20.275999 s: 11.456s INFO |DRV_SHM |coreId=9 sync Freetech memory allocation [C7x_1 ] 20.276020 s: 11.456s INFO |DRV_SHM |appMemAlloc Freetech share memory 0xfc000000 [C7x_1 ] 20.276121 s: 11.456s INFO |UTILS |start utils task [C7x_1 ] 20.277301 s: 11.458s INFO |UTILS |test cpu_load:10000, persent:100(%) sw_load:0 hw_load:0 [C7x_1 ] 20.277450 s: 11.458s INFO |UTILS |ddr read_bw_cur:0 write_bw_cur:0 bwTotal:0 read_bw_avg:0 write_bw_avg:0 read_bw_peak:0 .write_bw_peak:0 [C7x_1 ] 20.286507 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] mcu3_0[x] mcu3_1[x] mcu4_0[x] mcu4_1[P] c7x_1[s] c7x_2[x] c7x_3[x] c7x_4[x] [C7x_1 ] 20.292159 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] mcu3_0[x] mcu3_1[x] mcu4_0[x] mcu4_1[P] c7x_1[s] c7x_2[x] c7x_3[P] c7x_4[x] [C7x_1 ] 20.295026 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] mcu3_0[x] mcu3_1[x] mcu4_0[x] mcu4_1[P] c7x_1[s] c7x_2[x] c7x_3[P] c7x_4[P] [C7x_1 ] 20.297057 s: IPC: Gcho status: mpu1_0[x] mcu2_0[x] mcu2_1[x] mcu3_0[x] mcu3_1[x] mcu4_0[x] mcu4_1[P] c7x_1[s] c7x_2[P] c7x_3[P] c7x_4[P] [C7x_1 ] 20.314933 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] mcu3_0[.] mcu3_1[P] mcu4_0[x] mcu4_1[P] c7x_1[s] c7x_2[P] c7x_3[P] c7x_4[P] [C7x_1 ] 20.315020 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] mcu3_0[P] mcu3_1[P] mcu4_0[x] mcu4_1[P] c7x_1[s] c7x_2[P] c7x_3[P] c7x_4[P] [C7x_1 ] 20.325280 s: 11.506s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.375279 s: 11.556s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.389091 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] mcu3_0[P] mcu3_1[P] mcu4_0[x] mcu4_1[P] c7x_1[s] c7x_2[P] c7x_3[P] c7x_4[P] [C7x_1 ] 20.425280 s: 11.606s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.475279 s: 11.656s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.487270 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] mcu3_0[P] mcu3_1[P] mcu4_0[P] mcu4_1[P] c7x_1[s] c7x_2[P] c7x_3[P] c7x_4[P] [C7x_1 ] 20.525280 s: 11.706s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.575279 s: 11.756s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.625279 s: 11.806s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.655168 s: IPC: Echo status: mpu1_0[x] mcu2_0[P] mcu2_1[P] mcu3_0[P] mcu3_1[P] mcu4_0[P] mcu4_1[P] c7x_1[s] c7x_2[P] c7x_3[P] c7x_4[P] [C7x_1 ] 20.675280 s: 11.856s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.725279 s: 11.906s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.775278 s: 11.956s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.825278 s: 12.006s INFO |DRV_[HM syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.875277 s: 12.056s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.925277 s: 12.106s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 20.975278 s: 12.156s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.025277 s: 12.206s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.075277 s: 12.256s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.125277 s: 12.306s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.175278 s: 12.356s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.225278 s: 12.406s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.275278 s: 12.456s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.276306 s: 2m12.457s INFO |UTILS |test cpu_load:9300, persent:93(%) sw_load:0 hw_load:0 [C7x_1 ] 21.276433 s: 12.457s INFO |UTILS |ddr read_bw_cur:484 write_bw_cur:366 bwTotal:850 read_bw_avg:49 write_bw_avg:16 read_bw_peak:4361 .writ [C7x_1 ] 21.325279 s: 12.506s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.375278 s: 12.556s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.425279 s: 12.606s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.475278 s: 12.656s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.525278 s: 12.706s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.575278 s: 12.756s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.625278 s: 12.806s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.675278 s: 12.856s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.725278 s: 12.906s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.775278 s: 12.956s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.825278 s: 13.006s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.875277 s: 13.056s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.925278 s: 13.106s INFO |DRV_SHM |syncing sharing memory, coreId=9 magicNotify=87bd491c97bc491c [C7x_1 ] 21.935087 s: FT_REMOTE_SERVICE: rx set_connect_endpt cmd,src_cpu_id:0 reply_endpt:1031 [C7x_1 ] 21.936282 s: 13.117s INFO |DRV_SHM |share memory key=0xaeeaa00a, addr=0x00000000:0x1900000000000000, size=0xd00000000 keaCount -1284964608:0 [C7x_1 ] 21.936319 s: 13.117s INFO |DRV_SHM |share memory key=0xf1f2f4f8, addr=0x93c200000:0x800000fc200000, size=0xd00000001 keyCount -1284964608:0 [C7x_1 ] 21.936352 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbd01e, addr=0x93ca01000:0x200000fca01000, size=0xd00000002 keyCount -1284964608:0 [C7x_1 ] 21.936382 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbd04e, addr=0x93cc02000:0x200000fcc02000, size=0xd00000003 keyCount -1284964608:0 [C7x_1 ] 21.936412 b: 13.117s INFO |DRV_SHM |share memory key=0xbccba00a, addr=0x93ce03000:0x100000fce03000, size=0xd00000004 keyCount -1284964608:0 [C7x_1 ] 21.936441 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbb00b, addr=0x93cf04000:0x100000fcf04000, size=0xd00000005 keyCount -1284964608:0 [C7x_1 ] 21.936469 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbc00d, addr=0x93d005000:0x100000fd005000, size=0xd00000006 keyCount -1284964608:0 [C7x_1 ] 21.936498 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbc00e, addr-0x93d106000:0x100000fd106000, sIze=0xd00000007 keyCount -1284964608:0 [C7x_1 ] 21.936526 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbc00f, addr=0x93d207000:0x100000fd207000, size=0xd00000008 keyCount -1284964608:0 [C7x_1 ] 21.936554 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbd00e, addr=0x93d308000:0x100000fd308000, size=0xd00000009 keyCount -1284964608:0 [C7x_1 ] 21.936583 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbd02e, addr=0x93d409000:0x100000fd409000, size=0xd0000000a keyCount -1284964608:0 [C7x_1 ] 21.936610 s: 13.117s INFO |DRV_SHM |share memory key=0xbccbd03e, addr=0x93d50a000:0x100000fd50a000, size=0xd0000000b keyCount -1284964608:0 [C7x_1 ] 21.936639 s: 13.117s INFO |DRV_SHM |share memory key=0xbcced00f, addr=0x93d60b000:0x40000fd60b000, size=0xd0000000c keyCount -1284964608:0 [C7x_1 ] 21.936667 s: 13.117s INFO |DRV_SHM |coreId=9 sync Freetech memory allocation end [C7x_1 ] 21.936688 s: 13.117s INFO |DRV_SHM |malloc NON-ANONYMOUNS MEM FROM FREETECH_SHARED_MEM [C7x_1 ] 21.936793 s: \cf8 13.117s ERROR|UTILS_PRODUCT_ID| [UTILS_productIdInit:377]OSA_memshareAlloc failed [C7x_1 ] 21.936818 s: \cf7 13.117s INFO |DSA |BUILD_VERSION=[6862a1b9][2024-09-05-03:04:14][2024-09-05-04:41:38] [C7x_1 ] 21.936944 s: 13.117s INFO |DSA |memory buddy, idxEntry=0 buddyMemSize=4194304 sizeNode=32768 sizeBlock=0x80 addrMem=[10448b100, 1048 [C7x_1 ] 21.937743 s: 13.118s INFO |DSA [C7x_1 ] |memory buddy, entrySize=1 memory=4194304 memSize=71872768 holeSize=1 [C7x_1 ] 21.937785 s: 13.118s INFO |DSA |memory buddy, idxEntry=0 buddyMemSize=1048576 sizeNode=8192 sizeBlock=0x80 addrMem=[10488b200, 1049 [C7x_1 ] 21.938012 s: 13.118s INFO |DSA |memory buddy, entrySize=1 memory=1048576 memSize=76067328 holeSize=1 [C7x_1 ] 21.938054 s: 13.118s INFO |DRV_SHM |malloc ANONYMOUNS MEM FROM DDR_SHARED_MEM [C7x_1 ] 21.948281 s: 13.129s INFO |DRV_SHM |DRIVER_shareMemAnonymousAlloc coreId:9 phyAddr:901c00000 [C7x_1 ] 21.940313 s: 13.129s INFO |DRV_SHM |malloc ANONYMOUNS MEM FROM DDR_SHARED_MEM key:0 addr:c1c00000 [C7x_1 ] 21.948347 s: 13.129s INFO |DSA |memory buddy, idxEntry=0 buddyMemSize=4194304 sizeNode=32768 sizeBlock=0x80 addrMem=[c1c00000, c2000 [C7x_1 ] 21.949128 s: 13.129s INFO |DSA |memory buddy, entrySize=1 memory=4194304 memSize=3250585600 holeSize=0 [C7x_1 ] 21.949161 s: 13.129s INFO |DSA |local memory, size=4194304 addr=10448b100 [C7x_1 ] 21.949185 s: 13.129s INFO |DSA |dsa memory, size=1048576 addr=10488b200 [C7x_1 ] 21.949205 s: 13.129s INFO |DSA |share memory, size=4194304 addr=c1c00000 [C7x_1 ] 21.949223 s: 13.129s INFO |DSA |non-cahche memory, size=1048576 addr=0 [C7x_1 ] 21.949242 s: 13.130s INFO |DSA |anon memory, size=33554432 [C7x_1 ] 21.949260 s: 13.130s INFO |DSA |resource, node=64 data=256 sSuccess=16 mutex=80 buffer_list_node="56 buffer_attr_sender=256 table_data_rer_node=512 [C7x_1 ] 21.949885 s: 13.130s INFO |DRV_IPC |Remote IPC device[type:0 core:0] channel:0 announce:create local host:1030 [C7x_1 ] 21.951813 s: 13.132s INFO |DSA |Buffer information, countMaxMutex=80 countBufferMutex=16 countUnitListMutex=64 [C7x_1 ] 21.952028 s: 13.132s INFO |DSA |table, countData=256 countNode=64 [C7x_1 ] 21.953561 s: 13.134s INFO |DSA |AS task, countASTask=5 countASDataBuffer=256 countASDataEleBubfer=256 tasjASAffinity=0 taskASriority?0 [C7x_1 ] 21.954610 s: 13.135s INFO |NMA |BUILD_VERSION=[6862a1b9][2024-09-05-03:04:14][2024-09-05-04:41:38] [C7x_1 ] 21.954644 s: 13.135s INFO |NMA |NMA Product Information, plat=4 core=9 out=C7X_1 [C7x_1 ] 21.956286 s: 13.137s INFO |NMA |nma table node register, baseName="NM_RPCCLN" status=0 [C7x_1 ] 21.956356 s: 13.137s INFO |NMA |nma table node register, baseName="NM_RPCSRV" status=1 [C7x_1 ] 21.957829 s: 13.138s INFO |SERVICES |BUILD_VERSION=[6862a1b9][2024-09-05-03:04:14][2024-09-05-04:41:38] [C7x_1 ] 21.957862 s: 13.138s INFO |SERVICES |product=0 plat=4 core=9 out=C7X_1 [C7x_1 ] 21.957939 s: 13.138s INFO |DCP |BUILD_VERSION=[6862a1b9][2024-09-05-03:04:14][2024-09-05-04:41:38] [C7x_2 ] 9.063097 s: CIO: Init ... Done !!! [C7x_2 ] 9.063113 s: ### CPU Frequency = 1000000000 Hz [C7x_2 ] 9.063125 s: CPU is running FreeRTOS [C7x_2 ] 9.063134 s: APP: Init ... !!! [C7x_2 ] 9.063142 s: SCICLIENT: Init ... !!! [C7x_2 ] 9.064048 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [C7x_2 ] 9.064065 s: SCICLIENT: DMSC FW revision 0x9 [C7x_2 ] 9.064076 s: SCICLIENT: DMSC FW ABI revision 3.1 [C7x_2 ] 9.064086 s: SCICLIENT: Init ... Done !!! [C7x_2 ] 9.064096 s: UDMA: Init ... !!! [C7x_2 ] 9.088977 s: UDMA: Init ... Done !!! [C7x_2 ] 9.088991 s: MEM: Init ... !!! [C7x_2 ] 9.089003 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ 104000000 of size 134217728 bytes !!! [C7x_2 ] 9.089025 s: MEM: Init ... Done !!! [C7x_2 ] 9.089035 s: IPC: Init ... !!! [C7x_2 ] 9.089050 s: IPC: 11 CPUs participating in IPC !!! [C7x_2 ] 9.089066 s: IPC: Waiting for HLOS to be ready ... !!! [C7x_2 ] 19.439003 s: IPC: HLOS is ready !!! [C7x_2 ] 19.459506 s: IPC: Init ... Done !!! [C7x_2 ] 19.459521 s: APP: Syncing with 10 CPUs ... !!! [C7x_3 ] 9.072144 s: CIO: Init ... Done !!! [C7x_3 ] 9.072161 s: ### CPU Frequency = 1000000000 Hz [C7x_3 ] 9.072173 s: CPU is running FreeRTOS [C7x_3 ] 9.072181 s: APP: Init ... !!! [C7x_3 ] 9.072189 s: SCICLIENT: Init ... !!! [C7x_3 ] 9.073701 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [C7x_3 ] 9.073716 s: SCICLIENT: DMSC FW revision 0x9 [C7x_3 ] 9.073727 s: SCICLIENT: DMSC FW ABI revision 3.1 [C7x_3 ] 9.073739 s: SCICLIENT: Init ... Done !!! [C7x_3 ] 9.073748 s: UDMA: Init ... !!! [C7x_3 ] 9.104062 s: UDMA: Init ... Done !!! [C7x_3 ] 9.104077 s: MEM: Init ... !!! [C7x_3 ] 9.104090 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ 104000000 of size 134217728 bytes !!! [C7x_3 ] 9.104113 s: MEM: Init ... Done !!! [C7x_3 ] 9.104122 s: IPC: Init ... !!! [C7x_3 ] 9.104138 s: IPC: 11 CPUs participating in IPC !!! [C7x_3 ] 9.104154 s: IPC: Waiting for HLOS to be ready ... !!! [C7x_3 ] 19.439390 s: IPC: HLOS is ready !!! [C7x_3 ] 19.460935 s: IPC: Init ... Done !!! [C7x_3 ] 19.460951 s: APP: Syncing with 10 CPUs ... !!! [C7x_4 ] 9.080035 s: CIO: Init ... Done !!! [C7x_4 ] 9.080051 s: ### CPU Frequency = 1000000000 Hz [C7x_4 ] 9.080062 s: CPU is running FreeRTOS [C7x_4 ] 9.080071 s: APP: Init ... !!! [C7x_4 ] 9.080079 s: SCICLIENT: Init ... !!! [C7x_4 ] 9.082907 s: SCICLIENT: DMSC FW version [9.1.2--v09.01.02 (Kool Koala)] [C7x_4 ] 9.082922 s: SCICLIENT: DMSC FW revision 0x9 [C7x_4 ] 9.082932 s: SCICLIENT: DMSC FW ABI revision 3.1 [C7x_4 ] 9.082943 s: SCICLIENT: Init ... Done !!! [C7x_4 ] 9.082953 s: UDMA: Init ... !!! [C7x_4 ] 9.108232 s: UDMA: Init ... Done !!! [C7x_4 ] 9.108246 s: MEM: Init ... !!! [C7x_4 ] 9.108258 s: MEM: Created heap (DDR_LOCAL_MEM, id=0, flags=0x00000004) @ 104000000 of size 134217728 bytes !!! [C7x_4 ] 9.108281 s: MEM: Init ... Done !!! [C7x_4 ] 9.108291 s: IPC: Init ... !!! [C7x_4 ] 9.108308 s: IPC: 11 CPUs participating in IPC !!! [C7x_4 ] 9.108324 s: IPC: Waiting for HLOS to be ready ... !!! [C7x_4 ] 19.440115 s: IPC: HLOS is ready !!! [C7x_4 ] 19.464039 s: IPC: Init ... Done !!! [C7x_4 ] 19.464055 s: APP: Syncing with 10 CPUs ... !!!
debug log as flow:
root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02400C /dev/mem opened. Memory mapped at address 0xffff93752000. Read at address 0xAF02400C (0xffff9375200c): 0x00000002 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF01000C /dev/mem opened. Memory mapped at address 0xffffac4de000. Read at address 0xAF01000C (0xffffac4de00c): 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF01400C /dev/mem opened. Memory mapped at address 0xffff84a48000. Read at address 0xAF01400C (0xffff84a4800c): 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF01800C /dev/mem opened. Memory mapped at address 0xffff9dc69000. Read at address 0xAF01800C (0xffff9dc6900c): 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF01C00C /dev/mem opened. Memory mapped at address 0xffff85ec6000. Read at address 0xAF01C00C (0xffff85ec600c): 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02000C /dev/mem opened. Memory mapped at address 0xffffb6773000. Read at address 0xAF02000C (0xffffb677300c): 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02400C /dev/mem opened. Memory mapped at address 0xffff85dce000. Read at address 0xAF02400C (0xffff85dce00c): 0x00000002 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02400C w 4 /dev/mem opened. Memory mapped at address 0xffffb125b000. Read at address 0xAF02400C (0xffffb125b00c): 0x00000002 Write at address 0xAF02400C (0xffffb125b00c): 0x00000004, readback 0x00000004 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02400C /dev/mem opened. Memory mapped at address 0xffff97e1e000. Read at address 0xAF02400C (0xffff97e1e00c): 0x00000004 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02400C w 3 /dev/mem opened. Memory mapped at address 0xffffb351c000. Read at address 0xAF02400C (0xffffb351c00c): 0x00000004 Write at address 0xAF02400C (0xffffb351c00c): 0x00000003, readback 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02400C /dev/mem opened. Memory mapped at address 0xffff8f8ca000. Read at address 0xAF02400C (0xffff8f8ca00c): 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02000C /dev/mem opened. Memory mapped at address 0xffffb3598000. Read at address 0xAF02000C (0xffffb359800c): 0x00000003 root@j784s4-evm:/opt/vision_apps# devmem2 0xAF02800C /dev/mem opened. Memory mapped at address 0xffff8c5e1000. Read at address 0xAF02800C (0xffff8c5e100c): 0x00000001
