Hi experts,
I have 2 problem with this err 'ti-sci 44083000.dmsc: Mbox timedout in resp '.
1. i meet this issue sometimes on my board when i do reset test.
we use 8.04 linux sdk.
This is full logs on soc print.
Is it emmc problem? How to debug this type issue?
2. it will show this err when power on my board sometimes. and then the board is hang up.
But it is hard to reproduce.
This is full logs on soc print.
NOTICE: BL31: v2.6(release):SBL鍚姩-鎴戜滑鏉垮瓙涓婅繍琛?83-g486255076e
NOTICE: BL31: Built : 18:50:29, Apr 23 2023
I/TC:
I/TC: OP-TEE version: 486255076e (gcc version 9.2.1 20191025 (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10))) #1 Sun Apr 23 10:50:33 UTC 2023 aarch64
I/TC: Primary CPU initializing
I/TC: Primary CPU switching to normal world boot
U-Boot SPL 2021.01 (Apr 23 2023 - 18:42:42 +0800)
Model: Texas Instruments K3 J721E SoC
EEPROM not available at 0x50, trying to read at 0x51
Reading on-board EEPROM at 0x51 failed 1
Board: J721EX-PM1-SOM rev E2
SYSFW ABI: 3.1 (firmware rev 0x0008 '8.4.1--v08.04.01 (Jolly Jellyfi')
EEPROM not available at 0x50, trying to read at 0x51
Reading on-board EEPROM at 0x51 failed 1
[__get_primary_bootmedia :683] xjc: bootmode:3, force to set to BOOT_DEVICE_MMC1
2023-3-22 infor: (boot_device=17)
Trying to boot from MMC1
U-Boot 2021.01 (Apr 23 2023 - 18:42:42 +0800)
SoC: J721E SR1.1 GP
Model: Texas Instruments K3 J721E SoC
EEPROM not available at 0x50, trying to read at 0x51
Reading on-board EEPROM at 0x51 failed 1
Board: J721EX-PM1-SOM rev E2
DRAM: 4 GiB
Flash: 0 Bytes
MMC: sdhci@4f80000: 0, sdhci@4fb0000: 1
Loading Environment from FAT... MMC: no card present
mmc_init: -123, time 2002
In: serial@2800000
Out: serial@2800000
Err: serial@2800000
am65_cpsw_nuss ethernet@46000000: K3 CPSW: nuss_ver: 0x6BA00101 cpsw_ver: 0x6BA80100 ale_ver: 0x00293904 Ports:1 mdio_freq:1000000
EEPROM not available at 0x50, trying to read at 0x51
Reading on-board EEPROM at 0x51 failed 1
Net: Could not get PHY for ethernet@46000000port@1: addr 0
am65_cpsw_nuss_port ethernet@46000000port@1: phy_connect() failed
No ethernet found.
Hit any key to stop autoboot: 0
0 - boot from emmc.
83968, 128
00 00 00 00 5f 76 00 00 07 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 6e 6f 2d 76 65 72 73 69 6f 6e 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 6e 6f 2d 76 65 72 73 69 6f 6e 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 6e 6f 2d 76 65 72 73 69 6f 6e 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00load_device_info_part success
######update_flag:0x7, boot_flag:0x0
save_device_info_part success
backup flag init successed in uboot
start_flag :0
switch to partitions #0, OK
mmc0(part 0) is current device
SD/MMC found on device 0
Failed to load 'boot.scr'
483 bytes read in 7 ms (67.4 KiB/s) ->uEnv.txt
Loaded env from uEnv.txt
Importing environment from mmc0 ...
Running uenvcmd ...
1 bytes read in 7 ms (0 Bytes/s) ->.psdk_setup
Already setup.
GPIO: 'gpio@22_17' not found
Command 'gpio' failed: Error -22
GPIO: 'gpio@22_16' not found
Command 'gpio' failed: Error -22
k3_r5f_rproc r5f@41000000: Core 1 is already in use. No rproc commands work
k3_r5f_rproc r5f@41400000: Core 2 is already in use. No rproc commands work
1392052 bytes read in 16 ms (83 MiB/s) ->/lib/firmware/j7-main-r5f0_0-fw
Load Remote Processor 2 with data@addr=0x82000000 1392052 bytes: Success!
302028 bytes read in 10 ms (28.8 MiB/s) ->/lib/firmware/j7-main-r5f0_1-fw
Load Remote Processor 3 with data@addr=0x82000000 302028 bytes: Success!
Failed to load '/lib/firmware/j7-main-r5f1_0-fw'
Failed to load '/lib/firmware/j7-main-r5f1_1-fw'
1469172 bytes read in 16 ms (87.6 MiB/s) ->/lib/firmware/j7-c66_0-fw
Load Remote Processor 6 with data@addr=0x82000000 1469172 bytes: Success!
1469172 bytes read in 16 ms (87.6 MiB/s) ->/lib/firmware/j7-c66_1-fw
Load Remote Processor 7 with data@addr=0x82000000 1469172 bytes: Success!
12865600 bytes read in 77 ms (159.3 MiB/s) ->/lib/firmware/j7-c71_0-fw
Load Remote Processor 8 with data@addr=0x82000000 12865600 bytes: Success!
18455040 bytes read in 107 ms (164.5 MiB/s) ->/boot/Image
107968 bytes read in 8 ms (12.9 MiB/s) ->/boot/k3-j721e-common-proc-board.dtb
12129 bytes read in 8 ms (1.4 MiB/s) ->/boot/k3-j721e-vision-apps.dtbo
## Flattened Device Tree blob at 88000000
Booting using the fdt blob at 0x88000000
Loading Device Tree to 000000008fee2000, end 000000008fffffff ... OK
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd080]
[ 0.000000] Linux version 5.10.120 (xiejiancheng@motovis) (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) #1 SMP PREEMPT Sun Apr 23 18:42:48 CST 2023
[ 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 15 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 0x00000000a2000000, size 1 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@a2000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a2100000, size 31 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@a2100000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a4000000, size 1 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-r5f-dma-memory@a4000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a4100000, size 31 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@a4100000, 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-r5f-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-r5f-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-r5f-dma-memory@a7000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a7100000, size 15 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-r5f-memory@a7100000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a8000000, size 1 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-c66-dma-memory@a8000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a8100000, size 15 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-c66-memory@a8100000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a9000000, size 1 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-c66-dma-memory@a9000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a9100000, size 15 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-c66-memory@a9100000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000aa000000, size 1 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-c71-dma-memory@aa000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000aa100000, size 79 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-c71-memory@aa100000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000b2000000, size 96 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-dma-memory@b2000000, 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 0x00000000cc000000, size 32 MiB
[ 0.000000] OF: reserved mem: initialized node vision_apps_ipc_shared-memories, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000d8000000, size 192 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-core-heap-memory-lo@d8000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000e4000000, size 8 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-r5f-virtual-eth-queues@e4000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x00000000e4800000, size 24 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-r5f-virtual-eth-buffers@e4800000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x0000000880000000, size 624 MiB
[ 0.000000] OF: reserved mem: initialized node vision-apps-core-heap-memory-hi@880000000, compatible id shared-dma-pool
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000080000000-0x00000000ffffffff]
[ 0.000000] DMA32 empty
[ 0.000000] Normal [mem 0x0000000100000000-0x00000008ffffffff]
[ 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-0x00000000aeffffff]
[ 0.000000] node 0: [mem 0x00000000af000000-0x00000000afffffff]
[ 0.000000] node 0: [mem 0x00000000b0000000-0x00000000b7ffffff]
[ 0.000000] node 0: [mem 0x00000000b8000000-0x00000000d7ffffff]
[ 0.000000] node 0: [mem 0x00000000d8000000-0x00000000e5ffffff]
[ 0.000000] node 0: [mem 0x00000000e6000000-0x00000000ffffffff]
[ 0.000000] node 0: [mem 0x0000000880000000-0x00000008a6ffffff]
[ 0.000000] node 0: [mem 0x00000008a7000000-0x00000008ffffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000008ffffffff]
[ 0.000000] cma: Reserved 400 MiB at 0x00000000e7000000
[ 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 22 pages/cpu s50008 r8192 d31912 u90112
[ 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] CPU features: detected: Spectre-BHB
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1032192
[ 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),57088k@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=PARTUUID=2065c07a-03 rw rootfstype=ext4 rootwait
[ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] software IO TLB: mapped [mem 0x00000000d4000000-0x00000000d8000000] (64MB)
[ 0.000000] Memory: 1991908K/4194304K available (10816K kernel code, 1126K rwdata, 4188K rodata, 1792K init, 431K bss, 1792796K reserved, 409600K 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: Devices Table too large, reduce ids 20->19
[ 0.000000] ITS@0x0000000001820000: allocated 524288 Devices @8a7800000 (flat, esz 8, psz 64K, shr 0)
[ 0.000000] ITS: using cache flushing for cmd queue
[ 0.000000] GICv3: using LPI property table @0x00000008a7030000
[ 0.000000] GIC: using cache flushing for LPI property table
[ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000008a7040000
[ 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.000002] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
[ 0.008435] Console: colour dummy device 80x25
[ 0.013007] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
[ 0.023677] pid_max: default: 32768 minimum: 301
[ 0.028442] LSM: Security Framework initializing
[ 0.033210] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.040792] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.049713] rcu: Hierarchical SRCU implementation.
[ 0.054796] Platform MSI: msi-controller@1820000 domain created
[ 0.061106] PCI/MSI: /bus@100000/interrupt-controller@1800000/msi-controller@1820000 domain created
[ 0.070418] EFI services will not be available.
[ 0.075156] smp: Bringing up secondary CPUs ...
I/TC: Secondary CPU 1 initializing
I/TC: Secondary CPU 1 switching to normal world boot
[ 0.088490] Detected PIPT I-cache on CPU1
[ 0.088513] GICv3: CPU1: found redistributor 1 region 0:0x0000000001920000
[ 0.088524] GICv3: CPU1: using allocated LPI pending table @0x00000008a7050000
[ 0.088565] CPU1: Booted secondary processor 0x0000000001 [0x411fd080]
[ 0.088622] smp: Brought up 1 node, 2 CPUs
[ 0.117968] SMP: Total of 2 processors activated.
[ 0.122772] CPU features: detected: 32-bit EL0 Support
[ 0.128027] CPU features: detected: CRC32 instructions
[ 0.142128] CPU: All CPU(s) started at EL2
[ 0.146329] alternatives: patching kernel code
[ 0.151412] devtmpfs: initialized
[ 0.160975] KASLR disabled due to lack of seed
[ 0.165637] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.175601] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[ 0.189002] pinctrl core: initialized pinctrl subsystem
[ 0.194688] DMI not present or invalid.
[ 0.198951] NET: Registered protocol family 16
[ 0.204216] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
[ 0.211529] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[ 0.219580] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[ 0.227911] thermal_sys: Registered thermal governor 'step_wise'
[ 0.227913] thermal_sys: Registered thermal governor 'power_allocator'
[ 0.234558] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[ 0.248199] ASID allocator initialised with 65536 entries
[ 0.268623] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[ 0.275480] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
[ 0.282326] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[ 0.289172] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
[ 0.296703] cryptd: max_cpu_qlen set to 1000
[ 0.302930] k3-chipinfo 43000014.chipid: Family:J721E rev:SR2.0 JTAGID[0x1bb6402f] Detected
[ 0.311729] vsys_3v3: supplied by evm_12v0
[ 0.316106] vsys_5v0: supplied by evm_12v0
[ 0.320422] vdd_mmc1: supplied by vsys_3v3
[ 0.325151] iommu: Default domain type: Translated
[ 0.330299] SCSI subsystem initialized
[ 0.334471] mc: Linux media interface: v0.10
[ 0.338847] videodev: Linux video capture interface: v2.00
[ 0.344481] pps_core: LinuxPPS API ver. 1 registered
[ 0.349551] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[ 0.358891] PTP clock support registered
[ 0.362908] EDAC MC: Ver: 3.0.0
[ 0.366715] FPGA manager framework
[ 0.370230] Advanced Linux Sound Architecture Driver Initialized.
[ 0.376855] clocksource: Switched to clocksource arch_sys_counter
[ 0.383202] VFS: Disk quotas dquot_6.6.0
[ 0.387236] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 0.396938] Carveout Heap: Exported 320 MiB at 0x00000000b8000000
[ 0.403235] NET: Registered protocol family 2
[ 0.408050] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
[ 0.416674] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[ 0.425428] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[ 0.433632] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[ 0.441506] TCP: Hash tables configured (established 32768 bind 32768)
[ 0.448331] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[ 0.455227] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[ 0.462650] NET: Registered protocol family 1
[ 0.467459] RPC: Registered named UNIX socket transport module.
[ 0.473514] RPC: Registered udp transport module.
[ 0.478318] RPC: Registered tcp transport module.
[ 0.483123] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.489709] PCI: CLS 0 bytes, default 64
[ 0.494110] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[ 0.504579] Initialise system trusted keyrings
[ 0.509250] workingset: timestamp_bits=46 max_order=20 bucket_order=0
[ 0.517522] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.523760] NFS: Registering the id_resolver key type
[ 0.528956] Key type id_resolver registered
[ 0.533228] Key type id_legacy registered
[ 0.537349] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[ 0.544197] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[ 0.551860] 9p: Installing v9fs 9p2000 file system support
[ 0.577246] Key type asymmetric registered
[ 0.581432] Asymmetric key parser 'x509' registered
[ 0.586433] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243)
[ 0.593993] io scheduler mq-deadline registered
[ 0.598618] io scheduler kyber registered
[ 0.604149] pinctrl-single 4301c000.pinctrl: 94 pins, size 376
[ 0.610342] pinctrl-single 11c000.pinctrl: 173 pins, size 692
[ 0.618907] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
[ 0.625185] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
[ 0.633068] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
[ 0.641217] arm-smmu-v3 36600000.iommu: ias 48-bit, oas 48-bit (features 0x00001faf)
[ 0.649490] arm-smmu-v3 36600000.iommu: allocated 65536 entries for cmdq
[ 0.656593] arm-smmu-v3 36600000.iommu: allocated 32768 entries for evtq
[ 0.665568] arm-smmu-v3 36600000.iommu: msi_domain absent - falling back to wired irqs
[ 0.678540] brd: module loaded
[ 0.685516] loop: module loaded
[ 0.689108] sysfs: cannot create duplicate filename '/devices/platform/dma_buf_phys'
[ 0.697034] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.10.120 #1
[ 0.703256] Hardware name: Texas Instruments K3 J721E SoC (DT)
[ 0.709212] Call trace:
[ 0.711717] dump_backtrace+0x0/0x1a0
[ 0.715452] show_stack+0x18/0x68
[ 0.718838] dump_stack+0xd0/0x12c
[ 0.722309] sysfs_warn_dup+0x60/0x80
[ 0.726043] sysfs_create_dir_ns+0xe0/0xf8
[ 0.730225] kobject_add_internal+0x98/0x288
[ 0.734582] kobject_add+0x94/0x100
[ 0.738141] device_add+0xe0/0x740
[ 0.741612] platform_device_add+0x100/0x238
[ 0.745969] platform_device_register_full+0xcc/0x150
[ 0.751134] dma_buf_phys_init+0x6c/0x9c
[ 0.755135] do_one_initcall+0x54/0x1b8
[ 0.759051] kernel_init_freeable+0x220/0x2a0
[ 0.763499] kernel_init+0x14/0x114
[ 0.767056] ret_from_fork+0x10/0x34
[ 0.770725] kobject_add_internal failed for dma_buf_phys with -EEXIST, don't try to register things with the same name in the same directory.
[ 0.783939] megasas: 07.714.04.00-rc1
[ 0.789406] tun: Universal TUN/TAP device driver, 1.6
[ 0.794830] igbvf: Intel(R) Gigabit Virtual Function Network Driver
[ 0.801235] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[ 0.807314] sky2: driver version 1.30
[ 0.811645] VFIO - User Level meta-driver version: 0.3
[ 0.817406] i2c /dev entries driver
[ 0.821632] sdhci: Secure Digital Host Controller Interface driver
[ 0.827948] sdhci: Copyright(c) Pierre Ossman
[ 0.832670] sdhci-pltfm: SDHCI platform and OF driver helper
[ 0.838974] ledtrig-cpu: registered to indicate activity on CPUs
[ 0.845291] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
[ 0.852515] optee: probing for conduit method.
[ 0.857075] optee: revision 3.12 (48625507)
[ 0.857356] optee: initialized driver
[ 0.866710] NET: Registered protocol family 17
[ 0.871344] 9pnet: Installing 9P2000 support
[ 0.875745] Key type dns_resolver registered
[ 0.880205] Loading compiled-in X.509 certificates
[ 0.890159] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
[ 0.896494] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
[ 0.904715] ti-sci 44083000.dmsc: ABI: 3.1 (firmware rev 0x0008 '8.4.1--v08.04.01 (Jolly Jellyfi')
[ 0.996330] davinci-mcasp 2ba0000.mcasp: IRQ common not found
[ 1.004249] omap_i2c 40b00000.i2c: bus 0 rev0.12 at 100 kHz
[ 1.010473] omap_i2c 40b10000.i2c: bus 1 rev0.12 at 100 kHz
[ 1.016650] omap_i2c 42120000.i2c: bus 2 rev0.12 at 100 kHz
[ 1.024326] omap_i2c 2020000.i2c: bus 3 rev0.12 at 400 kHz
[ 1.030663] pca953x 4-0020: supply vcc not found, using dummy regulator
[ 1.037488] pca953x 4-0020: using no AI
[ 1.064902] pca953x 4-0020: failed writing register
[ 1.069946] pca953x: probe of 4-0020 failed with error -121
[ 1.075893] omap_i2c 2030000.i2c: bus 4 rev0.12 at 400 kHz
[ 1.082110] omap_i2c 2040000.i2c: bus 5 rev0.12 at 100 kHz
[ 1.088243] omap_i2c 2050000.i2c: bus 6 rev0.12 at 100 kHz
[ 1.094741] ti-sci-intr bus@100000:bus@28380000:interrupt-controller2: Interrupt Router 137 domain created
[ 1.104756] ti-sci-intr bus@100000:interrupt-controller0: Destination irq resource allocation failed
[ 1.114097] ti-sci-intr: probe of bus@100000:interrupt-controller0 failed with error -22
[ 1.122598] ti-sci-intr bus@100000:main-navss:interrupt-controller1: Interrupt Router 213 domain created
[ 1.132615] ti-sci-inta 33d00000.interrupt-controller: Interrupt Aggregator domain 209 created
[ 1.155046] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,20] sci-dev-id:235
[ 1.164952] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled
[ 1.171712] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66346100, num_proxies:64
[ 1.180886] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:1024, gp-rings[440,150] sci-dev-id:211
[ 1.191038] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled
[ 1.197798] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66346100, num_proxies:64
[ 1.205852] 40a00000.serial: ttyS1 at MMIO 0x40a00000 (irq = 15, base_baud = 6000000) is a 8250
[ 1.215336] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 22, base_baud = 3000000) is a 8250
[ 1.224088] printk: console [ttyS2] enabled
[ 1.224088] printk: console [ttyS2] enabled
[ 1.232525] printk: bootconsole [ns16550a0] disabled
[ 1.232525] printk: bootconsole [ns16550a0] disabled
[ 1.243043] 2810000.serial: ttyS3 at MMIO 0x2810000 (irq = 23, base_baud = 3000000) is a 8250
[ 1.252059] 2840000.serial: ttyS6 at MMIO 0x2840000 (irq = 24, base_baud = 3000000) is a 8250
[ 1.261824] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vdd-hba-supply regulator, assuming enabled
[ 1.272339] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vcc-supply regulator, assuming enabled
[ 1.282492] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vccq-supply regulator, assuming enabled
[ 1.292730] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vccq2-supply regulator, assuming enabled
[ 1.304217] scsi host0: ufshcd
[ 1.309554] davinci_mdio 46000f00.mdio: Configuring MDIO in manual mode
[ 1.352865] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
[ 1.360844] mdio_bus 46000f00.mdio: MDIO device at address 0 is missing.
[ 1.367566] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2 quirks:00000000
[ 1.381770] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010a, freq:200000000, add_val:4 pps:0
[ 1.491512] davinci-mcasp 2ba0000.mcasp: IRQ common not found
[ 1.491754] ti-sci 44083000.dmsc: Message for 0 is not expected!
[ 2.520877] ti-sci 44083000.dmsc: Mbox timedout in resp(caller: ti_sci_cmd_get_clock+0x38/0x48)
[ 2.520883] ti-sci 44083000.dmsc: Mbox timedout in resp(caller: ti_sci_cmd_get_device_exclusive+0x18/0x28)
[ 2.520890] ti-sci 44083000.dmsc: Mbox send fail -110
[ 2.529587] ti-sci 44083000.dmsc: Mbox send fail -110
[ 2.550594] sdhci-am654: probe of 4f80000.mmc failed with error -110
[ 2.550637] mmc1: CQHCI version 5.10
[ 2.560926] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fc7100
[ 2.567988] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fc7100
[ 2.574915] omap-mailbox 31f82000.mailbox: omap mailbox rev 0x66fc7100
[ 2.581907] omap-mailbox 31f83000.mailbox: omap mailbox rev 0x66fc7100
[ 2.588873] omap-mailbox 31f84000.mailbox: omap mailbox rev 0x66fc7100
[ 2.597130] ti-udma 285c0000.dma-controller: Channels: 26 (tchan: 13, rchan: 13, gp-rflow: 8)
[ 2.608020] ti-udma 31150000.dma-controller: Channels: 84 (tchan: 42, rchan: 42, gp-rflow: 16)
[ 2.619232] davinci_mdio 46000f00.mdio: Configuring MDIO in manual mode
[ 2.664865] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
[ 2.672841] mdio_bus 46000f00.mdio: MDIO device at address 0 is missing.
[ 2.679568] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2 quirks:00000000
[ 2.693505] am65-cpsw-nuss 46000000.ethernet: set new flow-id-base 48
[ 2.700800] am65-cpsw-nuss 46000000.ethernet: initialized cpsw ale version 1.4
[ 2.708009] am65-cpsw-nuss 46000000.ethernet: ALE Table size 64
[ 2.714507] am65-cpsw-nuss 46000000.ethernet: CPTS ver 0x4e8a010a, freq:500000000, add_val:1 pps:0
[ 2.725184] davinci-mcasp 2ba0000.mcasp: IRQ common not found
[ 2.745046] debugfs: Directory 'pd:27' with parent 'pm_genpd' already present!
[ 2.752336] debugfs: Directory 'pd:26' with parent 'pm_genpd' already present!
[ 2.760668] debugfs: Directory 'pd:242' with parent 'pm_genpd' already present!
[ 2.760677] cdns-ufshcd 4e84000.ufs: link startup failed 1
[ 2.767992] debugfs: Directory 'pd:241' with parent 'pm_genpd' already present!
[ 2.773451] cdns-ufshcd 4e84000.ufs: UFS Host state=0
[ 2.773454] cdns-ufshcd 4e84000.ufs: outstanding reqs=0x0 tasks=0x0
[ 2.780764] debugfs: Directory 'pd:240' with parent 'pm_genpd' already present!
[ 2.785776] cdns-ufshcd 4e84000.ufs: saved_err=0x0, saved_uic_err=0x0
[ 2.785779] cdns-ufshcd 4e84000.ufs: Device power mode=1, UIC link state=0
[ 2.792054] debugfs: Directory 'pd:239' with parent 'pm_genpd' already present!
[ 2.799331] cdns-ufshcd 4e84000.ufs: PM in progress=0, sys. suspended=0
[ 2.826480] cdns-ufshcd 4e84000.ufs: Auto BKOPS=0, Host self-block=0
[ 2.832817] cdns-ufshcd 4e84000.ufs: Clk gate=1
[ 2.835183] ALSA device list:
[ 2.837339] cdns-ufshcd 4e84000.ufs: last_hibern8_exit_tstamp at 0 us, hibern8_exit_cnt=0
[ 2.837341] cdns-ufshcd 4e84000.ufs: last intr at 2666698 us, last intr status=0x404
[ 2.837346] cdns-ufshcd 4e84000.ufs: error handling flags=0x0, req. abort count=0
[ 2.840304] No soundcards found.
[ 2.848454] cdns-ufshcd 4e84000.ufs: hba->ufs_version=0x210, Host capabilities=0x1587031f, caps=0x0
[ 2.848456] cdns-ufshcd 4e84000.ufs: quirks=0x0, dev. quirks=0x0
[ 2.848459] cdns-ufshcd 4e84000.ufs: clk: core_clk, rate: 250000000
[ 2.848461] cdns-ufshcd 4e84000.ufs: clk: phy_clk, rate: 19200000
[ 2.894367] cdns-ufshcd 4e84000.ufs: clk: ref_clk, rate: 19200000
[ 2.894372] cdns-ufshcd 4e84000.ufs: ufshcd_print_pwr_info:[RX, TX]: gear=[0, 0], lane[0, 0], pwr[INVALID MODE, INVALID MODE], rate = 0
[ 2.912625] host_regs: 00000000: 1587031f 00000000 00000210 00000000
[ 2.918966] host_regs: 00000010: 00000000 00000000 00000000 00000000
[ 2.925313] host_regs: 00000020: 00000000 00000470 00000000 00000000
[ 2.931652] host_regs: 00000030: 00000008 00000001 00000000 00000000
[ 2.938000] host_regs: 00000040: 00000000 00000000 00000000 00000000
[ 2.944338] host_regs: 00000050: 00000000 00000000 00000000 00000000
[ 2.950674] host_regs: 00000060: 00000000 00000000 00000000 00000000
[ 2.957015] host_regs: 00000070: 00000000 00000000 00000000 00000000
[ 2.963353] host_regs: 00000080: 00000000 00000000 00000000 00000000
[ 2.969691] host_regs: 00000090: 00000000 00000000 00000000 00000000
[ 2.976030] cdns-ufshcd 4e84000.ufs: No record of pa_err
[ 2.981328] cdns-ufshcd 4e84000.ufs: No record of dl_err
[ 2.986625] cdns-ufshcd 4e84000.ufs: No record of nl_err
[ 2.991923] cdns-ufshcd 4e84000.ufs: No record of tl_err
[ 2.997220] cdns-ufshcd 4e84000.ufs: No record of dme_err
[ 3.002605] cdns-ufshcd 4e84000.ufs: No record of auto_hibern8_err
[ 3.008769] cdns-ufshcd 4e84000.ufs: No record of fatal_err
[ 3.014328] cdns-ufshcd 4e84000.ufs: link_startup_fail[0] = 0x1 at 2667823 us
[ 3.021447] cdns-ufshcd 4e84000.ufs: No record of resume_fail
[ 3.027177] cdns-ufshcd 4e84000.ufs: No record of suspend_fail
[ 3.032994] cdns-ufshcd 4e84000.ufs: No record of dev_reset
[ 3.038552] cdns-ufshcd 4e84000.ufs: No record of host_reset
[ 3.044200] cdns-ufshcd 4e84000.ufs: No record of task_abort
[ 4.070925] sdhci-am654 4fb0000.mmc: Power on failed
[ 4.106504] mmc1: SDHCI controller on 4fb0000.mmc [4fb0000.mmc] using ADMA 64-bit
[ 4.114470] Waiting for root device PARTUUID=2065c07a-03...
[ 33.848868] vdd_mmc1: disabling
Is this rootfs preblem? but it will normal when power on again.
The same print on this two problem is 'ti-sci 44083000.dmsc: Mbox timedout in resp '.
also this err print is not display on normal logs.
thanks.