This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

TDA4VM: MCU2_0 sometimes stuck at VISS init

Part Number: TDA4VM

Hi TI,

I found sometimes mcu2_0 gets stuck at Vhwa_m2mVissInit, which causes the other inits, such as appIssInit after the viss is not initialized properly. Currently, I have no idea what caused this issue, wish TI could offer some help here. Attach the log below. BTW, After optimizing the kernel by modifying loglevel to 0 in linux SDK, this problem occurs more frequently, does it related to timing? how should I do? we are using A72(linux)+R5F(rtos), SDK 8.0, thanks !

#1. Where the MCU2_0 get stucked:

#2. The full log of R5F cores, stuck at Line 31640

2021-08-04_22:20:51.31588 [MCU2_0]    217.182324 s: CIO: Init ... Done !!!
2021-08-04_22:20:51.31594 [MCU2_0]    217.182537 s: ### CPU Frequency = 1000000000 Hz
2021-08-04_22:20:51.31594 [MCU2_0]    217.182592 s: APP: Init ... !!!
2021-08-04_22:20:51.31595 [MCU2_0]    217.182636 s: SCICLIENT: Init ... !!!
2021-08-04_22:20:51.31595 [MCU2_0]    217.183030 s: SCICLIENT: DMSC FW version [21.5.0--v2021.05 (Terrific Llam]
2021-08-04_22:20:51.31595 [MCU2_0]    217.183098 s: SCICLIENT: DMSC FW revision 0x15
2021-08-04_22:20:51.31595 [MCU2_0]    217.183139 s: SCICLIENT: DMSC FW ABI revision 3.1
2021-08-04_22:20:51.31596 [MCU2_0]    217.183169 s: SCICLIENT: Init ... Done !!!
2021-08-04_22:20:51.31596 [MCU2_0]    217.183201 s: UDMA: Init ... !!!
2021-08-04_22:20:51.31596 [MCU2_0]    217.186041 s: UDMA: Init ... Done !!!
2021-08-04_22:20:51.31596 [MCU2_0]    217.186147 s: MEM: Init ... !!!
2021-08-04_22:20:51.31597 [MCU2_0]    217.186271 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ d3800000 of size 16777216 bytes !!!
2021-08-04_22:20:51.31597 [MCU2_0]    217.186357 s: MEM: Created heap (L3_MEM, id=1, flags=0x00000000) @ 3600000 of size 262144 bytes !!!
2021-08-04_22:20:51.31597 [MCU2_0]    217.186435 s: MEM: Created heap (DDR_NON_CACHE_ME, id=5, flags=0x00000000) @ cb000000 of size 100663296 bytes !!!
2021-08-04_22:20:51.31610 [MCU2_0]    217.186498 s: MEM: Init ... Done !!!
2021-08-04_22:20:51.31610 [MCU2_0]    217.186539 s: IPC: Init ... !!!
2021-08-04_22:20:51.31610 [MCU2_0]    217.186680 s: IPC: 6 CPUs participating in IPC !!!
2021-08-04_22:20:51.31610 [MCU2_0]    217.186788 s: IPC: Waiting for HLOS to be ready ... !!!
2021-08-04_22:20:51.31611 [MCU2_0]    222.225979 s: IPC: HLOS is ready !!!
2021-08-04_22:20:51.31611 [MCU2_0]    222.231704 s: IPC: Init ... Done !!!
2021-08-04_22:20:51.31611 [MCU2_0]    222.231760 s: APP: Syncing with 5 CPUs ... !!!
2021-08-04_22:20:51.31611 [MCU2_0]    222.242925 s: APP: Syncing with 5 CPUs ... Done !!!
2021-08-04_22:20:51.31611 [MCU2_0]    222.242967 s: REMOTE_SERVICE: Init ... !!!
2021-08-04_22:20:51.31612 [MCU2_0]    222.244732 s: REMOTE_SERVICE: Init ... Done !!!
2021-08-04_22:20:51.31612 [MCU2_0]    222.244790 s: ETHFW: Init ... !!!
2021-08-04_22:20:51.31612 [MCU2_0]    222.245451 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [0/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31612 [MCU2_0]    222.245544 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [1/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31612 [MCU2_0]    222.245611 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [2/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31615 [MCU2_0]    222.245671 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [3/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31615 [MCU2_0]    222.245729 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [4/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31615 [MCU2_0]    222.245787 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [5/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31616 [MCU2_0]    222.245845 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [6/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31616 [MCU2_0]    222.245902 s: [Gibbs] Board_cpsw9gEthConfig() set portNum = [7/7] as RGMII 2 return status 0
2021-08-04_22:20:51.31616 [MCU2_0]    222.263933 s: CPSW_9G Test on MAIN NAVSS
2021-08-04_22:20:51.31616 [MCU2_0]    222.276655 s: ##########EnetPhy_open:310 speed:3 duplexity:2 hPhy->reqLinkCaps:16
2021-08-04_22:20:51.31616 [MCU2_0]    222.276721 s: ##########EnetPhy_open:335 alive:0
2021-08-04_22:20:51.31617 [MCU2_0]    222.276831 s: ##########EnetPhy_open:310 speed:3 duplexity:2 hPhy->reqLinkCaps:16
2021-08-04_22:20:51.31617 [MCU2_0]    222.276881 s: ##########EnetPhy_open:335 alive:0
2021-08-04_22:20:51.31617 [MCU2_0]    222.276978 s: ##########EnetPhy_open:310 speed:3 duplexity:2 hPhy->reqLinkCaps:16
2021-08-04_22:20:51.31619 [MCU2_0]    222.277024 s: ##########EnetPhy_open:335 alive:0
2021-08-04_22:20:51.31620 [MCU2_0]    222.277116 s: ##########EnetPhy_open:310 speed:3 duplexity:2 hPhy->reqLinkCaps:16
2021-08-04_22:20:51.31620 [MCU2_0]    222.277163 s: ##########EnetPhy_open:335 alive:0
2021-08-04_22:20:51.31620 [MCU2_0]    222.277267 s: ##########EnetPhy_open:310 speed:3 duplexity:2 hPhy->reqLinkCaps:16
2021-08-04_22:20:51.31620 [MCU2_0]    222.277316 s: ##########EnetPhy_open:335 alive:1
2021-08-04_22:20:51.31620 [MCU2_0]    222.277814 s: ##########EnetPhy_getId:610 PHY.out:0x00000ac2, PHY.model:0x00000032, PHY.revision:0x00000001, id1:0x002b, id2:0x0b21
2021-08-04_22:20:51.31621 [MCU2_0]    222.277876 s: ##########EnetPhy_bindDriver:1935 match:1
2021-08-04_22:20:51.31621 [MCU2_0]    222.277912 s: EnetPhy_bindDriver: PHY 1: OUI:000ac2 Model:32 Ver:01 <-> 'mv88q1110' : OK
2021-08-04_22:20:51.31621 [MCU2_0]    222.277968 s: PHY 1 is alive
2021-08-04_22:20:51.31621 [MCU2_0]    222.279658 s: ETHFW: Version   : 0.01.01
2021-08-04_22:20:51.31621 [MCU2_0]    222.279707 s: ETHFW: Build Date: Feb 11, 2022
2021-08-04_22:20:51.31622 [MCU2_0]    222.279733 s: ETHFW: Build Time: 09:56:28
2021-08-04_22:20:51.31622 [MCU2_0]    222.279754 s: ETHFW: Commit SHA:
2021-08-04_22:20:51.31627 [MCU2_0]    222.279807 s: ETHFW: Init ... DONE !!!
2021-08-04_22:20:51.31627 [MCU2_0]    222.279832 s: ETHFW: Remove server Init ... !!!
2021-08-04_22:20:51.31628 [MCU2_0]    222.280754 s: Remote demo device (core : mcu2_0) .....
2021-08-04_22:20:51.31628 [MCU2_0]    222.280809 s: ETHFW: Remove server Init ... DONE !!!
2021-08-04_22:20:51.31628 [MCU2_0]    222.281962 s: Starting lwIP, local interface IP is 192.168.4.39
2021-08-04_22:20:51.31628 [MCU2_0]    222.282681 s: Function:CpswProxyServer_attachExtHandlerCb,HostId:0,CpswType:6
2021-08-04_22:20:51.31628 [MCU2_0]    222.330234 s: FVID2: Init ... !!!
2021-08-04_22:20:51.31629 [MCU2_0]    222.330316 s: FVID2: Init ... Done !!!
2021-08-04_22:20:51.31629 [MCU2_0]    222.330370 s: DSS: Init ... !!!
2021-08-04_22:20:51.31629 [MCU2_0]    222.330398 s: DSS: Display type is eDP !!!
2021-08-04_22:20:51.31629 [MCU2_0]    222.330420 s: DSS: M2M Path is enabled !!!
2021-08-04_22:20:51.31629 [MCU2_0]    222.330442 s: DSS: SoC init ... !!!
2021-08-04_22:20:51.31630 [MCU2_0]    222.330461 s: SCICLIENT: Sciclient_pmSetModuleState module=152 state=2
2021-08-04_22:20:51.31630 [MCU2_0]    222.330644 s: SCICLIENT: Sciclient_pmSetModuleState success
2021-08-04_22:20:51.31630 [MCU2_0]    222.330677 s: SCICLIENT: Sciclient_pmSetModuleState module=297 state=2
2021-08-04_22:20:51.31632 [MCU2_0]    222.330873 s: SCICLIENT: Sciclient_pmSetModuleState success
2021-08-04_22:20:51.31633 [MCU2_0]    222.330905 s: SCICLIENT: Sciclient_pmSetModuleState module=151 state=2
2021-08-04_22:20:51.31633 [MCU2_0]    222.331029 s: SCICLIENT: Sciclient_pmSetModuleState success
2021-08-04_22:20:51.31633 [MCU2_0]    222.331056 s: SCICLIENT: Sciclient_pmSetModuleClkParent module=152 clk=9 parent=11
2021-08-04_22:20:51.31633 [MCU2_0]    222.331137 s: SCICLIENT: Sciclient_pmSetModuleClkParent success
2021-08-04_22:20:51.31634 [MCU2_0]    222.331165 s: SCICLIENT: Sciclient_pmSetModuleClkParent module=152 clk=13 parent=18
2021-08-04_22:20:51.31634 [MCU2_0]    222.331252 s: SCICLIENT: Sciclient_pmSetModuleClkParent success
2021-08-04_22:20:51.31634 [MCU2_0]    222.331292 s: SCICLIENT: Sciclient_pmSetModuleClkParent module=152 clk=1 parent=2
2021-08-04_22:20:51.31634 [MCU2_0]    222.331371 s: SCICLIENT: Sciclient_pmSetModuleClkParent success
2021-08-04_22:20:51.31634 [MCU2_0]    222.331404 s: SCICLIENT: Sciclient_pmSetModuleClkFreq module=152 clk=1 freq=148500000
2021-08-04_22:20:51.31635 [MCU2_0]    222.332466 s: SCICLIENT: Sciclient_pmSetModuleClkFreq success
2021-08-04_22:20:51.31637 [MCU2_0]    222.332498 s: SCICLIENT: Sciclient_pmModuleClkRequest module=152 clk=1 state=2 flag=0
2021-08-04_22:20:51.31637 [MCU2_0]    222.332666 s: SCICLIENT: Sciclient_pmModuleClkRequest success
2021-08-04_22:20:51.31637 [MCU2_0]    222.332694 s: DSS: SoC init ... Done !!!
2021-08-04_22:20:51.31637 [MCU2_0]    222.332715 s: DSS: Board init ... !!!
2021-08-04_22:20:51.31638 [MCU2_0]    222.332735 s: DSS: Board init ... Done !!!
2021-08-04_22:20:51.31638 [MCU2_0]    222.350991 s: DSS: Init ... Done !!!
2021-08-04_22:20:51.31638 [MCU2_0]    222.351054 s: VHWA: VPAC Init ... !!!
2021-08-04_22:20:51.31638 [MCU2_0]    222.351080 s: SCICLIENT: Sciclient_pmSetModuleState module=290 state=2
2021-08-04_22:20:51.31638 [MCU2_0]    222.351272 s: SCICLIENT: Sciclient_pmSetModuleState success
2021-08-04_22:20:51.31639 [MCU2_0]    222.351311 s: VHWA: LDC Init ... !!!
2021-08-04_22:20:51.31639 [MCU2_0]    222.354486 s: VHWA: LDC Init ... Done !!!
2021-08-04_22:20:51.31639 [MCU2_0]    222.354535 s: VHWA: MSC Init ... !!!
2021-08-04_22:20:51.31639 [MCU2_0]    222.363893 s: VHWA: MSC Init ... Done !!!
2021-08-04_22:20:51.31639 [MCU2_0]    222.363941 s: VHWA: NF Init ... !!!
2021-08-04_22:20:51.31640 [MCU2_0]    222.365530 s: VHWA: NF Init ... Done !!!
2021-08-04_22:20:51.31640 [MCU2_0]    222.365574 s: VHWA: VISS Init ... !!!
2021-08-04_22:20:51.31643 [MCU2_0]    222.365598 s: VHWA: Vhwa_m2mVissInitParamsInit !!!
2021-08-04_22:20:51.31643 [MCU2_0]    222.365621 s: VHWA: appUdmaGetObj !!!
2021-08-04_22:20:51.31643 [MCU2_1]    217.115658 s: CIO: Init ... Done !!!
2021-08-04_22:20:51.31643 [MCU2_1]    217.115717 s: ### CPU Frequency = 1000000000 Hz
2021-08-04_22:20:51.31644 [MCU2_1]    217.115746 s: APP: Init ... !!!
2021-08-04_22:20:51.31644 [MCU2_1]    217.115764 s: SCICLIENT: Init ... !!!
2021-08-04_22:20:51.31644 [MCU2_1]    217.115971 s: SCICLIENT: DMSC FW version [21.5.0--v2021.05 (Terrific Llam]
2021-08-04_22:20:51.31644 [MCU2_1]    217.116008 s: SCICLIENT: DMSC FW revision 0x15
2021-08-04_22:20:51.31644 [MCU2_1]    217.116032 s: SCICLIENT: DMSC FW ABI revision 3.1
2021-08-04_22:20:51.31645 [MCU2_1]    217.116056 s: SCICLIENT: Init ... Done !!!
2021-08-04_22:20:51.31645 [MCU2_1]    217.116077 s: UDMA: Init ... !!!
2021-08-04_22:20:51.31645 [MCU2_1]    217.117236 s: UDMA: Init ... Done !!!
2021-08-04_22:20:51.31645 [MCU2_1]    217.117290 s: MEM: Init ... !!!
2021-08-04_22:20:51.31645 [MCU2_1]    217.117326 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ d4800000 of size 16777216 bytes !!!
2021-08-04_22:20:51.31646 [MCU2_1]    217.117379 s: MEM: Created heap (L3_MEM, id=1, flags=0x00000001) @ 3640000 of size 262144 bytes !!!
2021-08-04_22:20:51.31648 [MCU2_1]    217.117425 s: MEM: Created heap (DDR_NON_CACHE_ME, id=5, flags=0x00000000) @ d1000000 of size 33554432 bytes !!!
2021-08-04_22:20:51.31648 [MCU2_1]    217.117470 s: MEM: Init ... Done !!!
2021-08-04_22:20:51.31648 [MCU2_1]    217.117490 s: IPC: Init ... !!!
2021-08-04_22:20:51.31648 [MCU2_1]    217.117537 s: IPC: 6 CPUs participating in IPC !!!
2021-08-04_22:20:51.31649 [MCU2_1]    217.117575 s: IPC: Waiting for HLOS to be ready ... !!!
2021-08-04_22:20:51.31649 [MCU2_1]    222.237563 s: IPC: HLOS is ready !!!
2021-08-04_22:20:51.31649 [MCU2_1]    222.242828 s: IPC: Init ... Done !!!
2021-08-04_22:20:51.31649 [MCU2_1]    222.242883 s: APP: Syncing with 5 CPUs ... !!!
2021-08-04_22:20:51.31771 [MCU2_1]    222.242924 s: APP: Syncing with 5 CPUs ... Done !!!
2021-08-04_22:20:51.31772 [MCU2_1]    222.242952 s: REMOTE_SERVICE: Init ... !!!
2021-08-04_22:20:51.31772 [MCU2_1]    222.244725 s: REMOTE_SERVICE: Init ... Done !!!
2021-08-04_22:20:51.31772 [MCU2_1]    222.244778 s: FVID2: Init ... !!!
2021-08-04_22:20:51.31772 [MCU2_1]    222.244847 s: FVID2: Init ... Done !!!
2021-08-04_22:20:51.31773 [MCU2_1]    222.244876 s: VHWA: DMPAC: Init ... !!!
2021-08-04_22:20:51.31773 [MCU2_1]    222.244898 s: SCICLIENT: Sciclient_pmSetModuleState module=48 state=2
2021-08-04_22:20:51.31773 [MCU2_1]    222.245071 s: SCICLIENT: Sciclient_pmSetModuleState success
2021-08-04_22:20:51.31773 [MCU2_1]    222.245102 s: SCICLIENT: Sciclient_pmSetModuleState module=305 state=2
2021-08-04_22:20:51.31773 [MCU2_1]    222.245242 s: SCICLIENT: Sciclient_pmSetModuleState success
2021-08-04_22:20:51.31774 [MCU2_1]    222.245271 s: VHWA: DOF Init ... !!!
2021-08-04_22:20:51.31774 [MCU2_1]    222.253424 s: VHWA: DOF Init ... Done !!!
2021-08-04_22:20:51.31774 [MCU2_1]    222.253475 s: VHWA: SDE Init ... !!!
2021-08-04_22:20:51.31774 [MCU2_1]    222.255764 s: VHWA: SDE Init ... Done !!!
2021-08-04_22:20:51.31775 [MCU2_1]    222.255812 s: VHWA: DMPAC: Init ... Done !!!
2021-08-04_22:20:51.31775 [MCU2_1]    222.255850 s:  VX_ZONE_INIT:Enabled
2021-08-04_22:20:51.31778 [MCU2_1]    222.255875 s:  VX_ZONE_ERROR:Enabled
2021-08-04_22:20:51.31779 [MCU2_1]    222.255896 s:  VX_ZONE_WARNING:Enabled
2021-08-04_22:20:51.31779 [MCU2_1]    222.256618 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:55] Added target DMPAC_SDE
2021-08-04_22:20:51.31779 [MCU2_1]    222.256840 s:  VX_ZONE_INIT:[tivxPlatformCreateTargetId:55] Added target DMPAC_DOF
2021-08-04_22:20:51.31779 [MCU2_1]    222.256899 s:  VX_ZONE_INIT:[tivxInit:71] Initialization Done !!!
2021-08-04_22:20:51.31780 [MCU2_1]    222.256928 s: APP: OpenVX Target kernel init ... !!!
2021-08-04_22:20:51.31780 [MCU2_1]    222.257199 s: APP: OpenVX Target kernel init ... Done !!!
2021-08-04_22:20:51.31780 [MCU2_1]    222.257251 s: UDMA Copy: Init ... !!!
2021-08-04_22:20:51.31780 [MCU2_1]    222.258881 s: UDMA Copy: Init ... Done !!!
2021-08-04_22:20:51.31780 [MCU2_1]    222.258936 s: APP: Init ... Done !!!
2021-08-04_22:20:51.31781 [MCU2_1]    222.258963 s: APP: Run ... !!!
2021-08-04_22:20:51.31781 [MCU2_1]    222.258985 s: IPC: Starting echo test ...
2021-08-04_22:20:51.31781 [MCU2_1]    222.261238 s: APP: Run ... Done !!!
2021-08-04_22:20:51.31781 [MCU2_1]    222.262260 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[s] C66X_1[P] C66X_2[.] C7X_1[.]
2021-08-04_22:20:51.31783 [MCU2_1]    222.262414 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[s] C66X_1[P] C66X_2[P] C7X_1[.]
2021-08-04_22:20:51.31784 [MCU2_1]    222.262492 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[s] C66X_1[P] C66X_2[P] C7X_1[P]
2021-08-04_22:20:51.31784 [C6x_1 ]    217.148580 s: CIO: Init ... Done !!!
2021-08-04_22:20:51.31784 [C6x_1 ]    217.148609 s: ### CPU Frequency = 1350000000 Hz
2021-08-04_22:20:51.31784 [C6x_1 ]    217.148619 s: APP: Init ... !!!
2021-08-04_22:20:51.31784 [C6x_1 ]    217.148626 s: SCICLIENT: Init ... !!!
2021-08-04_22:20:51.31785 [C6x_1 ]    217.148820 s: SCICLIENT: DMSC FW version [21.5.0--v2021.05 (Terrific Llam]
2021-08-04_22:20:51.31785 [C6x_1 ]    217.148833 s: SCICLIENT: DMSC FW revision 0x15
2021-08-04_22:20:51.31785 [C6x_1 ]    217.148843 s: SCICLIENT: DMSC FW ABI revision 3.1
2021-08-04_22:20:51.31785 [C6x_1 ]    217.148853 s: SCICLIENT: Init ... Done !!!
2021-08-04_22:20:51.31785 [C6x_1 ]    217.148862 s: UDMA: Init ... !!!
2021-08-04_22:20:51.31786 [C6x_1 ]    217.150089 s: UDMA: Init ... Done !!!
2021-08-04_22:20:51.31786 [C6x_1 ]    217.150111 s: MEM: Init ... !!!
2021-08-04_22:20:51.31786 [C6x_1 ]    217.150125 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ d5800000 of size 16777216 bytes !!!
2021-08-04_22:20:51.31788 [C6x_1 ]    217.150143 s: MEM: Created heap (L2_MEM, id=2, flags=0x00000001) @ 800000 of size 229376 bytes !!!
2021-08-04_22:20:51.31788 [C6x_1 ]    217.150158 s: MEM: Created heap (DDR_SCRATCH_MEM, id=4, flags=0x00000001) @ d6800000 of size 33554432 bytes !!!
2021-08-04_22:20:51.31789 [C6x_1 ]    217.150174 s: MEM: Init ... Done !!!
2021-08-04_22:20:51.31789 [C6x_1 ]    217.150182 s: IPC: Init ... !!!
2021-08-04_22:20:51.31789 [C6x_1 ]    217.150204 s: IPC: 6 CPUs participating in IPC !!!
2021-08-04_22:20:51.31789 [C6x_1 ]    217.150218 s: IPC: Waiting for HLOS to be ready ... !!!
2021-08-04_22:20:51.31790 [C6x_1 ]    221.118798 s: IPC: HLOS is ready !!!
2021-08-04_22:20:51.31790 [C6x_1 ]    221.122761 s: IPC: Init ... Done !!!
2021-08-04_22:20:51.31790 [C6x_1 ]    221.122803 s: APP: Syncing with 5 CPUs ... !!!
2021-08-04_22:20:51.31790 [C6x_1 ]    222.242922 s: APP: Syncing with 5 CPUs ... Done !!!
2021-08-04_22:20:51.31790 [C6x_1 ]    222.242936 s: REMOTE_SERVICE: Init ... !!!
2021-08-04_22:20:51.31791 [C6x_1 ]    222.243786 s: REMOTE_SERVICE: Init ... Done !!!
2021-08-04_22:20:51.31791 [C6x_1 ]    222.243834 s:  VX_ZONE_INIT:Enabled
2021-08-04_22:20:51.31791 [C6x_1 ]    222.243846 s:  VX_ZONE_ERROR:Enabled
2021-08-04_22:20:51.31791 [C6x_1 ]    222.243858 s:  VX_ZONE_WARNING:Enabled
2021-08-04_22:20:51.31794 [C6x_1 ]    222.244907 s:  VX_ZONE_INIT:[tivxInit:71] Initialization Done !!!
2021-08-04_22:20:51.31794 [C6x_1 ]    222.244928 s: APP: OpenVX Target kernel init ... !!!
2021-08-04_22:20:51.31794 [C6x_1 ]    222.244958 s: APP: XCB Obs Register Done !!!
2021-08-04_22:20:51.31794 [C6x_1 ]    222.245274 s: APP: OpenVX Target kernel init ... Done !!!
2021-08-04_22:20:51.31795 [C6x_1 ]    222.245301 s: UDMA Copy: Init ... !!!
2021-08-04_22:20:51.31795 [C6x_1 ]    222.248554 s: UDMA Copy: Init ... Done !!!
2021-08-04_22:20:51.31795 [C6x_1 ]    222.248575 s: APP: Init ... Done !!!
2021-08-04_22:20:51.31795 [C6x_1 ]    222.249270 s: APP: Run ... !!!
2021-08-04_22:20:51.31795 [C6x_1 ]    222.249281 s: IPC: Starting echo test ...
2021-08-04_22:20:51.31796 [C6x_1 ]    222.250565 s: APP: Run ... Done !!!
2021-08-04_22:20:51.31796 [C6x_1 ]    222.250943 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[s] C66X_2[x] C7X_1[P]
2021-08-04_22:20:51.31796 [C6x_1 ]    222.251204 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[s] C66X_2[P] C7X_1[P]
2021-08-04_22:20:51.31796 [C6x_1 ]    222.262078 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] C66X_1[s] C66X_2[P] C7X_1[P]
2021-08-04_22:20:51.31796 [C6x_2 ]    217.195468 s: CIO: Init ... Done !!!
2021-08-04_22:20:51.31798 [C6x_2 ]    217.195495 s: ### CPU Frequency = 1350000000 Hz
2021-08-04_22:20:51.31799 [C6x_2 ]    217.195506 s: APP: Init ... !!!
2021-08-04_22:20:51.31799 [C6x_2 ]    217.195515 s: SCICLIENT: Init ... !!!
2021-08-04_22:20:51.31799 [C6x_2 ]    217.195708 s: SCICLIENT: DMSC FW version [21.5.0--v2021.05 (Terrific Llam]
2021-08-04_22:20:51.31799 [C6x_2 ]    217.195723 s: SCICLIENT: DMSC FW revision 0x15
2021-08-04_22:20:51.31800 [C6x_2 ]    217.195733 s: SCICLIENT: DMSC FW ABI revision 3.1
2021-08-04_22:20:51.31800 [C6x_2 ]    217.195743 s: SCICLIENT: Init ... Done !!!
2021-08-04_22:20:51.31800 [C6x_2 ]    217.195752 s: UDMA: Init ... !!!
2021-08-04_22:20:51.31800 [C6x_2 ]    217.197003 s: UDMA: Init ... Done !!!
2021-08-04_22:20:51.31800 [C6x_2 ]    217.197027 s: MEM: Init ... !!!
2021-08-04_22:20:51.31801 [C6x_2 ]    217.197041 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ d8800000 of size 16777216 bytes !!!
2021-08-04_22:20:51.31801 [C6x_2 ]    217.197059 s: MEM: Created heap (L2_MEM, id=2, flags=0x00000001) @ 800000 of size 229376 bytes !!!
2021-08-04_22:20:51.31801 [C6x_2 ]    217.197075 s: MEM: Created heap (DDR_SCRATCH_MEM, id=4, flags=0x00000001) @ d9800000 of size 33554432 bytes !!!
2021-08-04_22:20:51.31801 [C6x_2 ]    217.197092 s: MEM: Init ... Done !!!
2021-08-04_22:20:51.31803 [C6x_2 ]    217.197101 s: IPC: Init ... !!!
2021-08-04_22:20:51.31804 [C6x_2 ]    217.197122 s: IPC: 6 CPUs participating in IPC !!!
2021-08-04_22:20:51.31804 [C6x_2 ]    217.197135 s: IPC: Waiting for HLOS to be ready ... !!!
2021-08-04_22:20:51.31804 [C6x_2 ]    221.124974 s: IPC: HLOS is ready !!!
2021-08-04_22:20:51.31804 [C6x_2 ]    221.128715 s: IPC: Init ... Done !!!
2021-08-04_22:20:51.31804 [C6x_2 ]    221.128751 s: APP: Syncing with 5 CPUs ... !!!
2021-08-04_22:20:51.31805 [C6x_2 ]    222.242923 s: APP: Syncing with 5 CPUs ... Done !!!
2021-08-04_22:20:51.31805 [C6x_2 ]    222.242935 s: REMOTE_SERVICE: Init ... !!!
2021-08-04_22:20:51.31805 [C6x_2 ]    222.243811 s: REMOTE_SERVICE: Init ... Done !!!
2021-08-04_22:20:51.31805 [C6x_2 ]    222.243862 s:  VX_ZONE_INIT:Enabled
2021-08-04_22:20:51.31805 [C6x_2 ]    222.243875 s:  VX_ZONE_ERROR:Enabled
2021-08-04_22:20:51.31806 [C6x_2 ]    222.243886 s:  VX_ZONE_WARNING:Enabled
2021-08-04_22:20:51.31806 [C6x_2 ]    222.244949 s:  VX_ZONE_INIT:[tivxInit:71] Initialization Done !!!
2021-08-04_22:20:51.31806 [C6x_2 ]    222.244971 s: APP: OpenVX Target kernel init ... !!!
2021-08-04_22:20:51.31806 [C6x_2 ]    222.245000 s: APP: XCB Slots Register Done !!!
2021-08-04_22:20:51.31806 [C6x_2 ]    222.245336 s: APP: OpenVX Target kernel init ... Done !!!
2021-08-04_22:20:51.31807 [C6x_2 ]    222.245364 s: UDMA Copy: Init ... !!!
2021-08-04_22:20:51.31809 [C6x_2 ]    222.248670 s: UDMA Copy: Init ... Done !!!
2021-08-04_22:20:51.31810 [C6x_2 ]    222.248688 s: APP: Init ... Done !!!
2021-08-04_22:20:51.31810 [C6x_2 ]    222.249377 s: APP: Run ... !!!
2021-08-04_22:20:51.31810 [C6x_2 ]    222.249388 s: IPC: Starting echo test ...
2021-08-04_22:20:51.31810 [C6x_2 ]    222.250813 s: APP: Run ... Done !!!
2021-08-04_22:20:51.31810 [C6x_2 ]    222.251208 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[.]
2021-08-04_22:20:51.31811 [C6x_2 ]    222.251243 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[P]
2021-08-04_22:20:51.31811 [C6x_2 ]    222.262084 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] C66X_1[P] C66X_2[s] C7X_1[P]
2021-08-04_22:20:51.31811 [C7x_1 ]    217.291223 s: CIO: Init ... Done !!!
2021-08-04_22:20:51.31811 [C7x_1 ]    217.291240 s: ### CPU Frequency = 1000000000 Hz
2021-08-04_22:20:51.31811 [C7x_1 ]    217.291252 s: APP: Init ... !!!
2021-08-04_22:20:51.31812 [C7x_1 ]    217.291260 s: SCICLIENT: Init ... !!!
2021-08-04_22:20:51.31812 [C7x_1 ]    217.291438 s: SCICLIENT: DMSC FW version [21.5.0--v2021.05 (Terrific Llam]
2021-08-04_22:20:51.31812 [C7x_1 ]    217.291453 s: SCICLIENT: DMSC FW revision 0x15
2021-08-04_22:20:51.31812 [C7x_1 ]    217.291464 s: SCICLIENT: DMSC FW ABI revision 3.1
2021-08-04_22:20:51.31814 [C7x_1 ]    217.291475 s: SCICLIENT: Init ... Done !!!
2021-08-04_22:20:51.31815 [C7x_1 ]    217.291484 s: UDMA: Init ... !!!
2021-08-04_22:20:51.31815 [C7x_1 ]    217.292373 s: UDMA: Init ... Done !!!
2021-08-04_22:20:51.31815 [C7x_1 ]    217.292385 s: MEM: Init ... !!!
2021-08-04_22:20:51.31815 [C7x_1 ]    217.292398 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ e6800000 of size 184549376 bytes !!!
2021-08-04_22:20:51.31815 [C7x_1 ]    217.292419 s: MEM: Created heap (L3_MEM, id=1, flags=0x00000001) @ 70020000 of size 8159232 bytes !!!
2021-08-04_22:21:16.48238 [C7x_1 ]    217.292437 s: MEM: Created heap (L2_MEM, id=2, flags=0x00000001) @ 64800000 of size 491520 bytes !!!
2021-08-04_22:21:16.48240 [C7x_1 ]    217.292455 s: MEM: Created heap (L1_MEM, id=3, flags=0x00000001) @ 64e00000 of size 16384 bytes !!!
2021-08-04_22:21:16.48240 [C7x_1 ]    217.292472 s: MEM: Created heap (DDR_SCRATCH_MEM, id=4, flags=0x00000001) @ db800000 of size 184549376 bytes !!!
2021-08-04_22:21:16.48240 [C7x_1 ]    217.292490 s: MEM: Init ... Done !!!
2021-08-04_22:21:16.48240 [C7x_1 ]    217.292498 s: IPC: Init ... !!!
2021-08-04_22:21:16.48241 [C7x_1 ]    217.292513 s: IPC: 6 CPUs participating in IPC !!!
2021-08-04_22:21:16.48241 [C7x_1 ]    217.292528 s: IPC: Waiting for HLOS to be ready ... !!!
2021-08-04_22:21:16.48241 [C7x_1 ]    221.132839 s: IPC: HLOS is ready !!!
2021-08-04_22:21:16.48241 [C7x_1 ]    221.135051 s: IPC: Init ... Done !!!
2021-08-04_22:21:16.48241 [C7x_1 ]    221.135068 s: APP: Syncing with 5 CPUs ... !!!
2021-08-04_22:21:16.48242 [C7x_1 ]    222.242925 s: APP: Syncing with 5 CPUs ... Done !!!
2021-08-04_22:21:16.48242 [C7x_1 ]    222.242949 s: REMOTE_SERVICE: Init ... !!!
2021-08-04_22:21:16.48242 [C7x_1 ]    222.243341 s: REMOTE_SERVICE: Init ... Done !!!
2021-08-04_22:21:16.48242 [C7x_1 ]    222.243369 s:  VX_ZONE_INIT:Enabled
2021-08-04_22:21:16.48249 [C7x_1 ]    222.243382 s:  VX_ZONE_ERROR:Enabled
2021-08-04_22:21:16.48250 [C7x_1 ]    222.243392 s:  VX_ZONE_WARNING:Enabled
2021-08-04_22:21:16.48250 [C7x_1 ]    222.243714 s:  VX_ZONE_INIT:[tivxInit:71] Initialization Done !!!
2021-08-04_22:21:16.48250 [C7x_1 ]    222.243730 s: APP: OpenVX Target kernel init ... !!!
2021-08-04_22:21:16.48250 [C7x_1 ]    222.243827 s: APP: OpenVX Target kernel init ... Done !!!
2021-08-04_22:21:16.48251 [C7x_1 ]    222.243846 s: APP: Init ... Done !!!
2021-08-04_22:21:16.48251 [C7x_1 ]    222.243859 s: APP: Run ... !!!
2021-08-04_22:21:16.48251 [C7x_1 ]    222.243868 s: IPC: Starting echo test ...
2021-08-04_22:21:16.48251 [C7x_1 ]    222.244425 s: APP: Run ... Done !!!
2021-08-04_22:21:16.48251 [C7x_1 ]    222.250947 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[x] C7X_1[s]
2021-08-04_22:21:16.48252 [C7x_1 ]    222.251223 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[x] C66X_1[P] C66X_2[P] C7X_1[s]
2021-08-04_22:21:16.48252 [C7x_1 ]    222.262229 s: IPC: Echo status: mpu1_0[x] mcu2_0[x] mcu2_1[P] C66X_1[P] C66X_2[P] C7X_1[s]
2021-08-04_22:21:16.48252 [MCU2_0]    223.877248 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48256 [MCU2_0]    224.177240 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48256 [MCU2_0]    224.477237 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48256 [MCU2_0]    224.777237 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48256 [MCU2_0]    225.077231 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48257 [MCU2_0]    225.377234 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48257 [MCU2_0]    225.677236 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48257 [MCU2_0]    225.977232 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48257 [MCU2_0]    226.277234 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48257 [MCU2_0]    226.577237 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48260 [MCU2_0]    226.877233 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48260 [MCU2_0]    227.177233 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48260 [MCU2_0]    227.477234 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48260 [MCU2_0]    227.777235 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48261 [MCU2_0]    228.077239 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]
2021-08-04_22:21:16.48261 [MCU2_0]    228.377234 s: REMOTE_SERVICE: ERROR: Unable to find handler for service [com.ti.image_sensor]

#3. The log of app in A72 linux, which can't Enumerating sensor successfully since the appIssInit at MCU2_0 is not initilized properly, MCU2_0 gets stucked at previous Vhwa_m2mVissInit

[    6.176117] launch.sh[766]:  APP: Init ... !!!
[    6.188114] launch.sh[766]: MEM: Init ... !!!
[    6.200185] launch.sh[766]: MEM: Initialized DMA HEAP (fd=5) !!!
[    6.216127] launch.sh[766]: MEM: Init ... Done !!!
[    6.228115] launch.sh[766]: IPC: Init ... !!!
[    6.240119] launch.sh[766]: IPC: Init ... Done !!!
[    6.252112] launch.sh[766]: REMOTE_SERVICE: Init ... !!!
[    6.264113] launch.sh[766]: REMOTE_SERVICE: Init ... Done !!!
[    6.280110] launch.sh[766]:    223.853090 s: GTC Frequency = 200 MHz
[    6.296110] launch.sh[766]: APP: Init ... Done !!!
[    6.308110] launch.sh[766]:    223.855208 s:  VX_ZONE_INIT:Enabled
[    6.324108] launch.sh[766]:    223.855235 s:  VX_ZONE_ERROR:Enabled
[    6.340147] launch.sh[766]:    223.855243 s:  VX_ZONE_WARNING:Enabled
[    6.356114] launch.sh[766]:    223.856487 s:  VX_ZONE_INIT:[tivxInit:71] Initialization Done !!!
[    6.372112] launch.sh[766]:    223.856712 s:  VX_ZONE_INIT:[tivxHostInit:48] Initialization Done for HOST !!!
[    6.388110] launch.sh[766]:    223.859407 s: ISS: Enumerating sensors ... !!!
[    6.404152] launch.sh[766]:    223.877388 s: ISS: ERROR: Enumerating sensors failed !!!
[    6.420117] launch.sh[766]: E/CAM-SRV    [2021-08-04 22:20:51] (hal/camera-service.cpp Init:98)failed to enumerate image sensor!
[    6.440217] launch.sh[766]:    224.077538 s: ISS: Enumerating sensors ... !!!
[    6.456117] launch.sh[766]:    224.177354 s: ISS: ERROR: Enumerating sensors failed !!!
[    6.472112] launch.sh[766]: E/CAM-SRV    [2021-08-04 22:20:51] (hal/camera-service.cpp Init:98)failed to enumerate image sensor!
[    6.530467] launch.sh[766]:     224.377455 s: ISS: Enumerating sensors ... !!!
[    6.630376] launch.sh[766]:    224.477351 s: ISS: ERROR: Enumerating sensors failed !!!
[    6.648198] launch.sh[766]: E/CAM-SRV    [2021-08-04 22:20:51] (hal/camera-service.cpp Init:98)failed to enumerate image sensor!
[    6.830929] launch.sh[766]:     224.677872 s: ISS: Enumerating sensors ... !!!
[    6.927109] launch.sh[752]: W/[08-04 22:20:52 pid:0752] (main:395)cmd_str: ps -ef |grep -E 'app_apa|eth_ipc_file_trans.out'
[    6.948406] launch.sh[752]:
[    6.960356] launch.sh[766]:
[    6.972350] launch.sh[766]:   224.777409 s: ISS: ERROR: Enumerating sensors failed !!!
[    6.988284] launch.sh[766]: E/CAM-SRV    [2021-08-04 22:20:52] (hal/camera-service.cpp Init:98)failed to enumerate image sensor!
[    7.130670] launch.sh[766]:    224.977561 s: ISS: Enumerating sensors ... !!!
[    7.230939] launch.sh[766]:    225.077348 s: ISS: ERROR: Enumerating sensors failed !!!
[    7.248226] launch.sh[766]: E/CAM-SRV    [2021-08-04 22:20:52] (hal/camera-service.cpp Init:98)failed to enumerate image sensor!
[    7.430553] launch.sh[766]:     225.277472 s: ISS: Enumerating sensors ... !!!
[    7.530364] launch.sh[766]:    225.377340 s: ISS: ERROR: Enumerating sensors failed !!!
[    7.530821] launch.sh[766]: E/CAM-SRV    [2021-08-04 22:20:52] (hal/camera-service.cpp Init:98)failed to enumerate image sensor!
[    7.730525] launch.sh[766]:     225.577459 s: ISS: Enumerating sensors ... !!!
[    7.830366] launch.sh[766]:    225.677345 s: ISS: ERROR: Enumerating sensors failed !!!
[    7.830769] launch.sh[766]: E/CAM-SRV    [2021-08-04 22:20:53] (hal/camera-service.cpp Init:98)failed to enumerate image sensor!

#4. The kernel log

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd080]
[    0.000000] Linux version 5.10.41-g4c2eade9f7 (qywu@op01) (aarch64-none-linux-gnu-gcc (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 9.2.1 20191025, GNU ld (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 2.33.1.20191209) #2 SMP PREEMPT Tue Mar 1 09:45:42 CST 2022
[    0.000000] Machine model: Texas Instruments K3 J721E SoC
[    0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002800000 (options '')
[    0.000000] printk: bootconsole [ns16550a0] enabled
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a0000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@a0000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a0100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a0100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a1000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@a1000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a1100000, size 31 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@a1100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a3000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@a3000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a3100000, size 31 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@a3100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a5000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-c66-dma-memory@a5000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a5100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-c66-memory@a5100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a6000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-c66-dma-memory@a6000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a6100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-c66-memory@a6100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a7000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-c71-dma-memory@a7000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a7100000, size 47 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-c71-memory@a7100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000ad000000, size 96 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-dma-memory@ad000000, compatible id shared-dma-pool
[    0.000000] OF: reserved mem: initialized node vision_apps_shared-memories, compatible id dma-heap-carveout
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000cb000000, size 440 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-core-heap-memory-lo@cb000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000e6800000, size 176 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-core-heap-memory-hi@e6800000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x0000000880000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@880000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x0000000880100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@880100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x0000000881000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@881000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x0000000881100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@881100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x0000000882000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@882000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x0000000882100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@882100000, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000080000000-0x00000000ffffffff]
[    0.000000]   DMA32    empty
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000080000000-0x000000009e7fffff]
[    0.000000]   node   0: [mem 0x000000009e800000-0x00000000a9ffffff]
[    0.000000]   node   0: [mem 0x00000000aa000000-0x00000000aaffffff]
[    0.000000]   node   0: [mem 0x00000000ab000000-0x00000000b2ffffff]
[    0.000000]   node   0: [mem 0x00000000b3000000-0x00000000caffffff]
[    0.000000]   node   0: [mem 0x00000000cb000000-0x00000000f17fffff]
[    0.000000]   node   0: [mem 0x00000000f1800000-0x00000000ffffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000000ffffffff]
[    0.000000] On node 0 totalpages: 32768
[    0.000000]   DMA zone: 32 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 32768 pages, LIFO batch:3
[    0.000000] cma: Failed to reserve 512 MiB
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: Trusted OS migration not required
[    0.000000] psci: SMC Calling Convention v1.2
[    0.000000] percpu: Embedded 2 pages/cpu s49880 r8192 d73000 u131072
[    0.000000] pcpu-alloc: s49880 r8192 d73000 u131072 alloc=2*65536
[    0.000000] pcpu-alloc: [0] 0 [0] 1
[    0.000000] Detected PIPT I-cache on CPU0
[    0.000000] CPU features: detected: GIC system register CPU interface
[    0.000000] CPU features: detected: EL2 vector hardening
[    0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
[    0.000000] Built 1 zonelists, mobility grouping off.  Total pages: 32736
[    0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 mtdparts=47040000.spi.0:512k(ospi.tiboot3),2m(ospi.tispl),4m(ospi.u-boot),256k(ospi.env),1m(ospi.sysfw),256k(ospi.env.backup),57344k@8m(ospi.rootfs),256k(ospi.phypattern);47034000.hyperbus:512k(hbmc.tiboot3),2m(hbmc.tispl),4m(hbmc.u-boot),256k(hbmc.env),1m(hbmc.sysfw),-@8m(hbmc.rootfs) root=/dev/mmcblk0p1 rootfstype=ext4 rootwait loglevel=0 blkdevparts=mmcblk0:300M(rootfs.ext4),100M(rfu0),100M(tiny.ext4),200M(vendor.ext4),100M(rfu1),1M(private),1M(b_private),32M(license),32M(config),512M(update),512M(logs),3324M(user),2M(dtc),-(cache)
[    0.000000] Dentry cache hash table entries: 262144 (order: 5, 2097152 bytes, linear)
[    0.000000] Inode-cache hash table entries: 131072 (order: 4, 1048576 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 728192K/2097152K available (10624K kernel code, 1278K rwdata, 4224K rodata, 1792K init, 703K bss, 1368960K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU event tracing is enabled.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=2.
[    0.000000]  Trampoline variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: 960 SPIs implemented
[    0.000000] GICv3: 0 Extended SPIs implemented
[    0.000000] GICv3: Distributor has no Range Selector support
[    0.000000] GICv3: 16 PPIs implemented
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001900000
[    0.000000] ITS [mem 0x01820000-0x0182ffff]
[    0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS
[    0.000000] ITS@0x0000000001820000: allocated 1048576 Devices @83800000 (flat, esz 8, psz 64K, shr 0)
[    0.000000] ITS: using cache flushing for cmd queue
[    0.000000] GICv3: using LPI property table @0x000000008feb0000
[    0.000000] GIC: using cache flushing for LPI property table
[    0.000000] GICv3: CPU0: using allocated LPI pending table @0x000000008fe00000
[    0.000000] random: get_random_bytes called from start_kernel+0x32c/0x4d4 with crng_init=0
[    0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns
[    0.000003] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
[    0.000298] Console: colour dummy device 80x25
[    0.000335] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
[    0.000345] pid_max: default: 32768 minimum: 301
[    0.000398] LSM: Security Framework initializing
[    0.000450] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear)
[    0.000470] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear)
[    0.001877] rcu: Hierarchical SRCU implementation.
[    0.002097] Platform MSI: msi-controller@1820000 domain created
[    0.002367] PCI/MSI: /bus@100000/interrupt-controller@1800000/msi-controller@1820000 domain created
[    0.002455] EFI services will not be available.
[    0.002648] smp: Bringing up secondary CPUs ...
[    0.003352] Detected PIPT I-cache on CPU1
[    0.003383] GICv3: CPU1: found redistributor 1 region 0:0x0000000001920000
[    0.003396] GICv3: CPU1: using allocated LPI pending table @0x000000008fe10000
[    0.003441] CPU1: Booted secondary processor 0x0000000001 [0x411fd080]
[    0.003529] smp: Brought up 1 node, 2 CPUs
[    0.003535] SMP: Total of 2 processors activated.
[    0.003541] CPU features: detected: 32-bit EL0 Support
[    0.003546] CPU features: detected: CRC32 instructions
[    0.015533] CPU: All CPU(s) started at EL2
[    0.015556] alternatives: patching kernel code
[    0.016232] devtmpfs: initialized
[    0.024010] KASLR disabled due to lack of seed
[    0.024182] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.024194] futex hash table entries: 512 (order: -1, 32768 bytes, linear)
[    0.024366] pinctrl core: initialized pinctrl subsystem
[    0.024687] DMI not present or invalid.
[    0.025112] NET: Registered protocol family 16
[    0.025445] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
[    0.025493] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.025539] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.025824] thermal_sys: Registered thermal governor 'step_wise'
[    0.025828] thermal_sys: Registered thermal governor 'power_allocator'
[    0.026285] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.026327] ASID allocator initialised with 65536 entries
[    0.046734] HugeTLB registered 16.0 GiB page size, pre-allocated 0 pages
[    0.046742] HugeTLB registered 512 MiB page size, pre-allocated 0 pages
[    0.046747] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.048050] cryptd: max_cpu_qlen set to 1000
[    0.050329] k3-chipinfo 43000014.chipid: Family:J721E rev:SR2.0 JTAGID[0x1bb6402f] Detected
[    0.050742] vsys_3v3: supplied by evm_12v0
[    0.050935] vsys_5v0: supplied by evm_12v0
[    0.051632] iommu: Default domain type: Translated
[    0.051857] SCSI subsystem initialized
[    0.052251] mc: Linux media interface: v0.10
[    0.052268] videodev: Linux video capture interface: v2.00
[    0.052308] pps_core: LinuxPPS API ver. 1 registered
[    0.052312] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.052320] PTP clock support registered
[    0.052345] EDAC MC: Ver: 3.0.0
[    0.053180] FPGA manager framework
[    0.053764] clocksource: Switched to clocksource arch_sys_counter
[    0.054047] VFS: Disk quotas dquot_6.6.0
[    0.054112] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes)
[    0.055635] Carveout Heap: Exported 384 MiB at 0x00000000b3000000
[    0.055717] NET: Registered protocol family 2
[    0.055844] IP idents hash table entries: 32768 (order: 2, 262144 bytes, linear)
[    0.056864] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear)
[    0.056936] TCP established hash table entries: 16384 (order: 1, 131072 bytes, linear)
[    0.057024] TCP bind hash table entries: 16384 (order: 2, 262144 bytes, linear)
[    0.057214] TCP: Hash tables configured (established 16384 bind 16384)
[    0.057277] UDP hash table entries: 2048 (order: 0, 65536 bytes, linear)
[    0.057347] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes, linear)
[    0.057489] NET: Registered protocol family 1
[    0.057849] RPC: Registered named UNIX socket transport module.
[    0.057853] RPC: Registered udp transport module.
[    0.057856] RPC: Registered tcp transport module.
[    0.057859] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.057870] PCI: CLS 0 bytes, default 64
[    0.058351] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[    0.061182] Initialise system trusted keyrings
[    0.061287] workingset: timestamp_bits=46 max_order=14 bucket_order=0
[    0.064000] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.064368] NFS: Registering the id_resolver key type
[    0.064386] Key type id_resolver registered
[    0.064390] Key type id_legacy registered
[    0.064432] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.064436] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    0.064561] 9p: Installing v9fs 9p2000 file system support
[    0.096922] Key type asymmetric registered
[    0.096928] Asymmetric key parser 'x509' registered
[    0.096963] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
[    0.096969] io scheduler mq-deadline registered
[    0.096973] io scheduler kyber registered
[    0.098571] pinctrl-single 4301c000.pinctrl: 94 pins, size 376
[    0.098866] pinctrl-single 11c000.pinctrl: 173 pins, size 692
[    0.102438] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
[    0.102486] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
[    0.104827] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
[    0.107278] arm-smmu-v3 36600000.iommu: ias 48-bit, oas 48-bit (features 0x00001faf)
[    0.109054] arm-smmu-v3 36600000.iommu: allocated 524288 entries for cmdq
[    0.112538] arm-smmu-v3 36600000.iommu: allocated 524288 entries for evtq
[    0.113819] arm-smmu-v3 36600000.iommu: msi_domain absent - falling back to wired irqs
[    0.121506] brd: module loaded
[    0.125641] loop: module loaded
[    0.126318] megasas: 07.714.04.00-rc1
[    0.128048] libphy: Fixed MDIO Bus: probed
[    0.128757] tun: Universal TUN/TAP device driver, 1.6
[    0.129117] igbvf: Intel(R) Gigabit Virtual Function Network Driver
[    0.129121] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    0.129156] sky2: driver version 1.30
[    0.129913] VFIO - User Level meta-driver version: 0.3
[    0.130506] i2c /dev entries driver
[    0.131401] sdhci: Secure Digital Host Controller Interface driver
[    0.131405] sdhci: Copyright(c) Pierre Ossman
[    0.131761] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.132523] ledtrig-cpu: registered to indicate activity on CPUs
[    0.132766] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
[    0.133567] optee: probing for conduit method.
[    0.133589] optee: revision 3.12 (3d47a131)
[    0.133989] optee: initialized driver
[    0.135119] NET: Registered protocol family 17
[    0.135226] 9pnet: Installing 9P2000 support
[    0.135269] Key type dns_resolver registered
[    0.135426] Loading compiled-in X.509 certificates
[    0.140862] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
[    0.141029] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
[    0.144061] ti-sci 44083000.dmsc: ABI: 3.1 (firmware rev 0x0015 '21.5.0--v2021.05 (Terrific Llam')
[    0.165052] random: fast init done
[    0.182226] omap_i2c 40b00000.i2c: bus 0 rev0.12 at 100 kHz
[    0.182734] omap_i2c 40b10000.i2c: bus 1 rev0.12 at 100 kHz
[    0.183205] omap_i2c 42120000.i2c: bus 2 rev0.12 at 100 kHz
[    0.183661] omap_i2c 2020000.i2c: bus 3 rev0.12 at 100 kHz
[    0.184121] omap_i2c 2030000.i2c: bus 4 rev0.12 at 100 kHz
[    0.184574] omap_i2c 2040000.i2c: bus 5 rev0.12 at 100 kHz
[    0.185048] omap_i2c 2050000.i2c: bus 6 rev0.12 at 100 kHz
[    0.186257] ti-sci-intr bus@100000:bus@28380000:interrupt-controller2: Interrupt Router 137 domain created
[    0.186377] ti-sci-intr bus@100000:interrupt-controller0: Interrupt Router 131 domain created
[    0.186491] ti-sci-intr bus@100000:main-navss:interrupt-controller1: Interrupt Router 213 domain created
[    0.186675] ti-sci-inta 33d00000.interrupt-controller: Interrupt Aggregator domain 209 created
[    0.187662] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,20] sci-dev-id:235
[    0.187668] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled
[    0.187673] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66346100, num_proxies:64
[    0.189980] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:1024, gp-rings[440,150] sci-dev-id:211
[    0.189987] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled
[    0.189993] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66346100, num_proxies:64
[    0.190604] 40a00000.serial: ttyS1 at MMIO 0x40a00000 (irq = 15, base_baud = 6000000) is a 8250
[    0.191263] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 29, base_baud = 3000000) is a 8250
[    0.191299] printk: console [ttyS2] enabled
[    0.191303] printk: bootconsole [ns16550a0] disabled
[    0.191928] 2810000.serial: ttyS3 at MMIO 0x2810000 (irq = 30, base_baud = 3000000) is a 8250
[    0.192529] 2840000.serial: ttyS6 at MMIO 0x2840000 (irq = 31, base_baud = 3000000) is a 8250
[    0.233776] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
[    0.233786] libphy: 46000f00.mdio: probed
[    0.234221] mdio_bus 46000f00.mdio: MDIO device at address 0 is missing.
[    0.234286] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2 quirks:00000000
[    0.235593] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010a, freq:200000000, add_val:4 pps:0
[    0.235949] k3_bandgap_probe and count is 5
[    0.235955] WORKAROUND NEEDED
[    0.235960] slope m1::-8 and const c1::-147
[    0.235965] slope m2::-68 and const c2::-3146
[    0.235976] slope m3::3 and const c3::901
[    0.236128] Value of CTRLMMR_WKUP_RESET_SRC_STAT Register is 0x1
[    0.236133] high_max is 762 and low_max is 658 and regval is 0x29202fa
[    0.336149] Value of WKUP_VTM_MISC_CTRL2 is 0x29202fa
[    0.336152] Value of WKUP_VTM_MISC_CTRL is 0x1
[    0.337002] mmc0: CQHCI version 5.10
[    0.337709] mmc1: CQHCI version 5.10
[    0.345380] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fc7100
[    0.345748] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fc7100
[    0.346180] omap-mailbox 31f82000.mailbox: omap mailbox rev 0x66fc7100
[    0.346565] omap-mailbox 31f83000.mailbox: omap mailbox rev 0x66fc7100
[    0.346900] omap-mailbox 31f84000.mailbox: omap mailbox rev 0x66fc7100
[    0.347658] ti-udma 285c0000.dma-controller: Channels: 26 (tchan: 13, rchan: 13, gp-rflow: 8)
[    0.350013] ti-udma 31150000.dma-controller: Channels: 84 (tchan: 42, rchan: 42, gp-rflow: 16)
[    0.355191] spi-nor spi1.0: unrecognized JEDEC id bytes: c8 68 19 ff c8 68
[    0.355206] spi-nor: probe of spi1.0 failed with error -2
[    0.374370] mmc0: SDHCI controller on 4f80000.mmc [4f80000.mmc] using ADMA 64-bit
[    0.393773] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
[    0.393780] libphy: 46000f00.mdio: probed
[    0.394223] mdio_bus 46000f00.mdio: MDIO device at address 0 is missing.
[    0.394290] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2 quirks:00000000
[    0.395229] am65-cpsw-nuss 46000000.ethernet: set new flow-id-base 48
[    0.395796] am65-cpsw-nuss 46000000.ethernet: initialized cpsw ale version 1.4
[    0.395801] am65-cpsw-nuss 46000000.ethernet: ALE Table size 64
[    0.396299] am65-cpsw-nuss 46000000.ethernet: CPTS ver 0x4e8a010a, freq:500000000, add_val:1 pps:0
[    0.399541] debugfs: Directory 'pd:184' with parent 'pm_genpd' already present!
[    0.400248] debugfs: Directory 'pd:242' with parent 'pm_genpd' already present!
[    0.400271] debugfs: Directory 'pd:241' with parent 'pm_genpd' already present!
[    0.400294] debugfs: Directory 'pd:240' with parent 'pm_genpd' already present!
[    0.400316] debugfs: Directory 'pd:239' with parent 'pm_genpd' already present!
[    0.401442] input: gpio-keys as /devices/platform/gpio-keys/input/input0
[    0.401939] adayp_gpios_init
[    0.401943] driver register
[    0.402070] adayo_peripheral_pwr_drv_probe!
[    0.444829] mmc0: Command Queue Engine enabled
[    0.444839] mmc0: new HS200 MMC card at address 0001
[    0.445228] mmcblk0: mmc0:0001 8GUF4R 7.28 GiB
[    0.445340] mmcblk0boot0: mmc0:0001 8GUF4R partition 1 31.9 MiB
[    0.445443] mmcblk0boot1: mmc0:0001 8GUF4R partition 2 31.9 MiB
[    0.445557] mmcblk0rpmb: mmc0:0001 8GUF4R partition 3 4.00 MiB, chardev (236:0)
[    0.445987]  mmcblk0: p1(rootfs.ext4) p2(rfu0) p3(tiny.ext4) p4(vendor.ext4) p5(rfu1) p6(private) p7(b_private) p8(license) p9(config) p10(update) p11(logs) p12(user) p13(dtc) p14(cache)
[    0.553886] sdhci-am654 4fb0000.mmc: Power on failed
[    0.584494] mmc1: SDHCI controller on 4fb0000.mmc [4fb0000.mmc] using ADMA 64-bit
[    0.586368] EXT4-fs (mmcblk0p1): INFO: recovery required on readonly filesystem
[    0.586376] EXT4-fs (mmcblk0p1): write access will be enabled during recovery
[    0.592370] EXT4-fs (mmcblk0p1): recovery complete
[    0.593583] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
[    0.593638] VFS: Mounted root (ext4 filesystem) readonly on device 179:1.
[    0.594470] devtmpfs: mounted
[    0.594964] Freeing unused kernel memory: 1792K
[    0.605799] Run /sbin/init as init process
[    0.605803]   with arguments:
[    0.605806]     /sbin/init
[    0.605810]   with environment:
[    0.605812]     HOME=/
[    0.605815]     TERM=linux
[    0.656453] systemd[1]: System time before build time, advancing clock.
[    0.679022] NET: Registered protocol family 10
[    0.679700] Segment Routing with IPv6
[    0.686751] systemd[1]: systemd 244.5+ running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR -SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN -PCRE2 default-hierarchy=hybrid)
[    0.687032] systemd[1]: Detected architecture arm64.
[    0.714086] systemd[1]: Set hostname to <j7-evm>.
[    0.867991] systemd[1]: /lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock \xe2\x86\x92 /run/docker.sock; please update the unit file accordingly.
[    0.914365] random: systemd: uninitialized urandom read (16 bytes read)
[    0.914494] systemd[1]: system-getty.slice: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling.
[    0.914503] systemd[1]: (This warning is only shown for the first unit using IP firewalling.)
[    0.916585] systemd[1]: Created slice system-getty.slice.
[    0.933947] random: systemd: uninitialized urandom read (16 bytes read)
[    0.934893] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    0.949888] random: systemd: uninitialized urandom read (16 bytes read)
[    0.950050] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    0.965931] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    0.981900] systemd[1]: Reached target Host and Network Name Lookups.
[    0.997836] systemd[1]: Reached target Paths.
[    1.013854] systemd[1]: Reached target Remote File Systems.
[    1.029841] systemd[1]: Reached target Slices.
[    1.045842] systemd[1]: Reached target Swap.
[    1.062529] systemd[1]: Listening on RPCbind Server Activation Socket.
[    1.077884] systemd[1]: Reached target RPC Port Mapper.
[    1.096490] systemd[1]: Listening on Process Core Dump Socket.
[    1.114032] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    1.134443] systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
[    1.134921] systemd[1]: Listening on Journal Socket (/dev/log).
[    1.150163] systemd[1]: Listening on Journal Socket.
[    1.166254] systemd[1]: Listening on Network Service Netlink Socket.
[    1.182093] systemd[1]: Listening on udev Control Socket.
[    1.198071] systemd[1]: Listening on udev Kernel Socket.
[    1.217534] systemd[1]: Mounting Huge Pages File System...
[    1.238285] systemd[1]: Mounting POSIX Message Queue File System...
[    1.258050] systemd[1]: Mounting Kernel Debug File System...
[    1.277633] systemd[1]: Mounting Temporary Directory (/tmp)...
[    1.301749] systemd[1]: Starting Create list of static device nodes for the current kernel...
[    1.326585] systemd[1]: Started Hardware RNG Entropy Gatherer Daemon.
[    1.346090] systemd[1]: Starting RPC Bind...
[    1.369406] systemd[1]: Starting File System Check on Root Device...
[    1.394820] systemd[1]: Starting Journal Service...
[    1.403596] systemd[1]: Starting Load Kernel Modules...
[    1.408558] systemd[1]: Starting udev Coldplug all Devices...
[    1.413735] systemd[1]: Started RPC Bind.
[    1.416758] systemd[1]: Mounted Huge Pages File System.
[    1.417300] systemd[1]: Mounted POSIX Message Queue File System.
[    1.419485] systemd[1]: Mounted Kernel Debug File System.
[    1.420219] systemd[1]: Mounted Temporary Directory (/tmp).
[    1.423537] cryptodev: loading out-of-tree module taints kernel.
[    1.425879] systemd[1]: Started Create list of static device nodes for the current kernel.
[    1.426424] cryptodev: driver 1.10 loaded.
[    1.426623] systemd[1]: rngd.service: Main process exited, code=exited, status=127/n/a
[    1.426992] systemd[1]: rngd.service: Failed with result 'exit-code'.
[    1.451588] systemd[1]: Started Load Kernel Modules.
[    1.452385] systemd[1]: Condition check resulted in FUSE Control File System being skipped.
[    1.456328] systemd[1]: Mounting Kernel Configuration File System...
[    1.465061] systemd[1]: Starting Apply Kernel Variables...
[    1.499621] systemd[1]: Started Journal Service.
[    1.611905] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
[    1.611926] ext4 filesystem being remounted at / supports timestamps until 2038 (0x7fffffff)
[    1.629023] mmc1: new SDHC card at address 5048
[    1.629607] mmcblk1: mmc1:5048 SD16G 14.4 GiB
[    1.637087]  mmcblk1: p1 p2
[    1.651056] systemd-journald[151]: Received client request to flush runtime journal.
[    2.474616] PVR_K:  236: Read BVNC 22.104.208.318 from HW device registers
[    2.474632] PVR_K:  236: RGX Device registered with BVNC 22.104.208.318
[    2.476103] [drm] Initialized pvr 1.13.5776728 20170530 for 4e20000000.gpu on minor 0
[    3.272495] k3-dsp-rproc 4d80800000.dsp: assigned reserved memory node vision-apps-c66-dma-memory@a6000000
[    3.272839] k3-dsp-rproc 4d80800000.dsp: configured DSP for IPC-only mode
[    3.272918] remoteproc remoteproc0: 4d80800000.dsp is available
[    3.272972] remoteproc remoteproc0: attaching to 4d80800000.dsp
[    3.273110] k3-dsp-rproc 4d80800000.dsp: DSP initialized in IPC-only mode
[    3.273120]  remoteproc0#vdev0buffer: assigned reserved memory node vision-apps-c66-dma-memory@a6000000
[    3.273489] virtio_rpmsg_bus virtio0: rpmsg host is online
[    3.277234] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xd
[    3.277871]  remoteproc0#vdev0buffer: registered virtio0 (type 7)
[    3.277882] remoteproc remoteproc0: remote processor 4d80800000.dsp is now attached
[    3.278641] k3-dsp-rproc 4d81800000.dsp: assigned reserved memory node vision-apps-c66-dma-memory@a5000000
[    3.279073] k3-dsp-rproc 4d81800000.dsp: configured DSP for IPC-only mode
[    3.279141] remoteproc remoteproc1: 4d81800000.dsp is available
[    3.279192] remoteproc remoteproc1: attaching to 4d81800000.dsp
[    3.279297] k3-dsp-rproc 4d81800000.dsp: DSP initialized in IPC-only mode
[    3.279306]  remoteproc1#vdev0buffer: assigned reserved memory node vision-apps-c66-dma-memory@a5000000
[    3.279663] virtio_rpmsg_bus virtio1: rpmsg host is online
[    3.280518]  remoteproc1#vdev0buffer: registered virtio1 (type 7)
[    3.280524] remoteproc remoteproc1: remote processor 4d81800000.dsp is now attached
[    3.283225] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0xd
[    3.286353] k3-dsp-rproc 64800000.dsp: assigned reserved memory node vision-apps-c71-dma-memory@a7000000
[    3.286865] k3-dsp-rproc 64800000.dsp: configured DSP for IPC-only mode
[    3.286939] remoteproc remoteproc2: 64800000.dsp is available
[    3.286983] remoteproc remoteproc2: attaching to 64800000.dsp
[    3.287054] remoteproc remoteproc2: unsupported resource 65538
[    3.287153] k3-dsp-rproc 64800000.dsp: DSP initialized in IPC-only mode
[    3.287163]  remoteproc2#vdev0buffer: assigned reserved memory node vision-apps-c71-dma-memory@a7000000
[    3.287526] virtio_rpmsg_bus virtio2: rpmsg host is online
[    3.288818]  remoteproc2#vdev0buffer: registered virtio2 (type 7)
[    3.288826] remoteproc remoteproc2: remote processor 64800000.dsp is now attached
[    3.289673] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0xd
[    3.517061] CAN device driver interface
[    3.575170] m_can_platform 40528000.can: m_can device registered (irq=22, version=32)
[    3.594817] m_can_platform 40568000.can: m_can device registered (irq=24, version=32)
[    4.301826] random: crng init done
[    4.301838] random: 7 urandom warning(s) missed due to ratelimiting
[    4.360272] platform 41000000.r5f: R5F core may have been powered on by a different host, programmed state (0) != actual state (1)
[    4.360472] platform 41000000.r5f: configured R5F for IPC-only mode
[    4.360655] platform 41000000.r5f: assigned reserved memory node vision-apps-r5f-dma-memory@a0000000
[    4.360818] remoteproc remoteproc3: 41000000.r5f is available
[    4.360870] remoteproc remoteproc3: attaching to 41000000.r5f
[    4.361018] platform 41000000.r5f: R5F core initialized in IPC-only mode
[    4.361028]  remoteproc3#vdev0buffer: assigned reserved memory node vision-apps-r5f-dma-memory@a0000000
[    4.361384] virtio_rpmsg_bus virtio3: rpmsg host is online
[    4.365635]  remoteproc3#vdev0buffer: registered virtio3 (type 7)
[    4.365645] remoteproc remoteproc3: remote processor 41000000.r5f is now attached
[    4.378077] virtio_rpmsg_bus virtio3: creating channel ti.ipc4.ping-pong addr 0xd
[    4.378227] virtio_rpmsg_bus virtio3: creating channel rpmsg_chrdev addr 0xe
[    4.379742] platform 5c00000.r5f: configured R5F for IPC-only mode
[    4.379909] platform 5c00000.r5f: assigned reserved memory node vision-apps-r5f-dma-memory@a1000000
[    4.380072] remoteproc remoteproc4: 5c00000.r5f is available
[    4.380147] remoteproc remoteproc4: attaching to 5c00000.r5f
[    4.380293] platform 5c00000.r5f: R5F core initialized in IPC-only mode
[    4.380302]  remoteproc4#vdev0buffer: assigned reserved memory node vision-apps-r5f-dma-memory@a1000000
[    4.380670] virtio_rpmsg_bus virtio4: rpmsg host is online
[    4.381666]  remoteproc4#vdev0buffer: registered virtio4 (type 7)
[    4.381674] remoteproc remoteproc4: remote processor 5c00000.r5f is now attached
[    4.385946] virtio_rpmsg_bus virtio4: creating channel rpmsg_chrdev addr 0xd
[    4.391374] platform 5d00000.r5f: configured R5F for IPC-only mode
[    4.391549] platform 5d00000.r5f: assigned reserved memory node vision-apps-r5f-dma-memory@a3000000
[    4.391721] remoteproc remoteproc5: 5d00000.r5f is available
[    4.391769] remoteproc remoteproc5: attaching to 5d00000.r5f
[    4.391878] platform 5d00000.r5f: R5F core initialized in IPC-only mode
[    4.391886]  remoteproc5#vdev0buffer: assigned reserved memory node vision-apps-r5f-dma-memory@a3000000
[    4.392256] virtio_rpmsg_bus virtio5: rpmsg host is online
[    4.397113] virtio_rpmsg_bus virtio5: creating channel rpmsg_chrdev addr 0xd
[    4.398447] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0x15
[    4.398714] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0x15
[    4.398876] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0x15
[    4.398989] virtio_rpmsg_bus virtio4: creating channel rpmsg_chrdev addr 0x15
[    4.399340] virtio_rpmsg_bus virtio5: creating channel rpmsg_chrdev addr 0x15
[    4.399495] virtio_rpmsg_bus virtio2: creating channel ti.ipc4.ping-pong addr 0xe
[    4.405414] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xe
[    4.405611] virtio_rpmsg_bus virtio1: creating channel ti.ipc4.ping-pong addr 0xe
[    4.413891]  remoteproc5#vdev0buffer: registered virtio5 (type 7)
[    4.413904] remoteproc remoteproc5: remote processor 5d00000.r5f is now attached
[    4.416198] virtio_rpmsg_bus virtio5: creating channel ti.ipc4.ping-pong addr 0xe
[    4.435352] virtio_rpmsg_bus virtio4: creating channel ti.ethfw.notifyservice addr 0x1e
[    4.435642] virtio_rpmsg_bus virtio4: creating channel rpmsg-kdrv addr 0x1a
[    4.436841] rpmsg-kdrv-eth-switch rpmsg-kdrv-2-mpu_1_0_ethswitch-device-0: Device info: permissions: 07FFFFFF uart_id: 2
[    4.436851] rpmsg-kdrv-eth-switch rpmsg-kdrv-2-mpu_1_0_ethswitch-device-0: FW ver 0.1 (rev 1) 11/Feb/2022 SHA:
[    4.584645] am65-cpsw-nuss 46000000.ethernet: phy /bus@100000/bus@28380000/ethernet@46000000/mdio@f00/ethernet-phy@0 not found on slave 1
[    4.837451] usbcore: registered new interface driver usbfs
[    4.837490] usbcore: registered new interface driver hub
[    4.837525] usbcore: registered new device driver usb
[    4.850018] omap_rng 4e10000.rng: Random Number Generator ver. 241b34c

  • Hi,

    Could you please clarify my below queries regarding this issue,

    1. Are you observing the hang at the same place i.e.Vhwa_m2mVissInit everytime?

    2. Could you try setting the variable "initPrms.configThroughUdmaFlag" to false and check if the issue can be reproduced?

    3. Have you tried going deeper into the function Vhwa_m2mVissInit() to know the exact point of hang?

    Regards,
    Nikhil

  • Hi Nikhil,

    1. Are you observing the hang at the same place i.e.Vhwa_m2mVissInit everytime?

    1.yes, everytime hangs at he same place.

    you try setting the variable "initPrms.configThroughUdmaFlag" to false and check if the issue can be reproduced?

    2.What is the purpose of this flag? If I change it to false, will it have any potential unpredictable impact to vision app? Actually, this problem no longer occurs after moving ETHFW_Init to the end of app_init, but I have no idea why, just assuming it may related to some timing. This uncertainty makes me wonder whether this problem will appear again at some time.

    3. Have you tried going deeper into the function Vhwa_m2mVissInit() to know the exact point of hang?

    3.Not yet, like I mentioned above, this issue seems disappear after changing the sequence of the init, I'm very confused about it. I could do a further investigation if necessary, but it not always occurs. 

    thanks

  • Hi,

    Ethernet firmware has no dependency on VISS, so I doubt if that was the issue.

    The purpose of setting the flag to false and testing was to check if the issue is with the Configuration of VISS through UDMA. It would be great if you could test this scenario.

    Also could you do a clean build once as shown below in order to ensure that this is not a build issue?

    cd vision_apps

    make sdk_scrub

    make sdk -jN    .......... with "N" being the number of parallel threads

    Also are there any changes in the SDK?   


    Regards,
    Nikhil