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: issue:ti-sci 44083000.dmsc: Mbox timedout in resp

Part Number: TDA4VM

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.

   Mbox_timedout_in_resp.log

  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.

 

  • i meet this  issue sometimes  on my board when i do reset test

    Is this a custom board or TI EVM?

    Also has this error started after 8.4 o4 SDK or it was always coming up?

    - Keerthy

  • Hi Keerthy,

    It is produce on my board, not TI EVM board.

    It is repoduce sometimes, meybe it happen one time when i test 20 times.

    Is there any ways to debug it?

    thanks.

  • Hi,

    Can you attach debugger and check if the MCU r5f and M3 cores are active when this error occurs in the U-Boot?

    Regards,

    Keerthy 

  • Hi Keerthy,

    how to check M3 core is active or not? This error is in normal step not in u-boot, it occurs after u-boot

    from the log file, you can see it happen when drive is running.

    also it not happen every time.

    thanks

  • Hi Xie,

    I understood that it's a not so frequently occuring issue. If you can attach a debugger to M3 and check after the issues come on board. To see if M3 is still active.

    Best Regards,

    Keerthy 

  • Hi Keerthy,

    what is M3 core? as i known in TDA4 platfrom, it has 2 A72 cores, 6 R5f cores, 3 DSP core.

    Do you mean M3 core is mcu1-0 core?

    thanks

  • No i mean the DMSC m3 core that runs the TIFS binary

  • Hi Keerthy,

    if the  issues come on board, and M3 is not active? How can i modify it?

    what will cause mbox fail?

    Is there any way  to monoter mbox err?

    when mbox fail ,then we reboot board. Is this way feasible?

  • Hi Xie,

    [ 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

    The above error comes from ti_sci_rx_callback. There is an unexpected message.

    Can you share the successful log as well?

    - Keerthy

  • Hi Keerthy,

    This is normal logs.

    NOTICE:  BL31: v2.6(release):SBL鍚姩-鎴戜滑鏉垮瓙涓婅繍琛?47-ge28034d1c-dirty
    NOTICE:  BL31: Built : 21:28:54, Apr  7 2023
    I/TC: 
    I/TC: OP-TEE version: e28034d1c-dev (gcc version 9.2.1 20191025 (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10))) #1 Fri Apr  7 13:28:58 UTC 2023 aarch64
    I/TC: Primary CPU initializing
    I/TC: Primary CPU switching to normal world boot
    
    U-Boot SPL 2021.01 (Apr 07 2023 - 21:21:06 +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 07 2023 - 21:21:06 +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 
    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 11 ms (26.2 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 17 ms (82.4 MiB/s) ->/lib/firmware/j7-c66_0-fw
    Load Remote Processor 6 with data@addr=0x82000000 1469172 bytes: Success!
    1469172 bytes read in 18 ms (77.8 MiB/s) ->/lib/firmware/j7-c66_1-fw
    Load Remote Processor 7 with data@addr=0x82000000 1469172 bytes: Success!
    12980176 bytes read in 79 ms (156.7 MiB/s) ->/lib/firmware/j7-c71_0-fw
    Load Remote Processor 8 with data@addr=0x82000000 12980176 bytes: Success!
    18455040 bytes read in 107 ms (164.5 MiB/s) ->/boot/Image
    107968 bytes read in 9 ms (11.4 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 Fri Apr 7 21:21:13 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=90919cc0-02 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.008440] Console: colour dummy device 80x25
    [    0.013016] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
    [    0.023687] pid_max: default: 32768 minimum: 301
    [    0.028450] LSM: Security Framework initializing
    [    0.033215] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
    [    0.040797] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
    [    0.049689] rcu: Hierarchical SRCU implementation.
    [    0.054765] Platform MSI: msi-controller@1820000 domain created
    [    0.061086] PCI/MSI: /bus@100000/interrupt-controller@1800000/msi-controller@1820000 domain created
    [    0.070395] EFI services will not be available.
    [    0.075143] smp: Bringing up secondary CPUs ...
    I/TC: Secondary CPU 1 initializing
    I/TC: Secondary CPU 1 switching to normal world boot
    [    0.088435] Detected PIPT I-cache on CPU1
    [    0.088458] GICv3: CPU1: found redistributor 1 region 0:0x0000000001920000
    [    0.088468] GICv3: CPU1: using allocated LPI pending table @0x00000008a7050000
    [    0.088515] CPU1: Booted secondary processor 0x0000000001 [0x411fd080]
    [    0.088578] smp: Brought up 1 node, 2 CPUs
    [    0.117924] SMP: Total of 2 processors activated.
    [    0.122729] CPU features: detected: 32-bit EL0 Support
    [    0.127983] CPU features: detected: CRC32 instructions
    [    0.142078] CPU: All CPU(s) started at EL2
    [    0.146276] alternatives: patching kernel code
    [    0.151375] devtmpfs: initialized
    [    0.161059] KASLR disabled due to lack of seed
    [    0.165724] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
    [    0.175687] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
    [    0.189115] pinctrl core: initialized pinctrl subsystem
    [    0.194825] DMI not present or invalid.
    [    0.199097] NET: Registered protocol family 16
    [    0.204367] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
    [    0.211681] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
    [    0.219733] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
    [    0.228070] thermal_sys: Registered thermal governor 'step_wise'
    [    0.228073] thermal_sys: Registered thermal governor 'power_allocator'
    [    0.234736] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
    [    0.248374] ASID allocator initialised with 65536 entries
    [    0.268617] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
    [    0.275472] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
    [    0.282318] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
    [    0.289164] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
    [    0.296710] cryptd: max_cpu_qlen set to 1000
    [    0.302959] k3-chipinfo 43000014.chipid: Family:J721E rev:SR2.0 JTAGID[0x1bb6402f] Detected
    [    0.311771] vsys_3v3: supplied by evm_12v0
    [    0.316141] vsys_5v0: supplied by evm_12v0
    [    0.320453] vdd_mmc1: supplied by vsys_3v3
    [    0.325183] iommu: Default domain type: Translated 
    [    0.330340] SCSI subsystem initialized
    [    0.334485] mc: Linux media interface: v0.10
    [    0.338864] videodev: Linux video capture interface: v2.00
    [    0.344494] pps_core: LinuxPPS API ver. 1 registered
    [    0.349564] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.358904] PTP clock support registered
    [    0.362928] EDAC MC: Ver: 3.0.0
    [    0.366736] FPGA manager framework
    [    0.370257] Advanced Linux Sound Architecture Driver Initialized.
    [    0.376881] clocksource: Switched to clocksource arch_sys_counter
    [    0.383228] VFS: Disk quotas dquot_6.6.0
    [    0.387261] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
    [    0.396962] Carveout Heap: Exported 320 MiB at 0x00000000b8000000
    [    0.403263] NET: Registered protocol family 2
    [    0.408067] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
    [    0.416709] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
    [    0.425464] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
    [    0.433670] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
    [    0.441540] TCP: Hash tables configured (established 32768 bind 32768)
    [    0.448359] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
    [    0.455253] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
    [    0.462683] NET: Registered protocol family 1
    [    0.467507] RPC: Registered named UNIX socket transport module.
    [    0.473563] RPC: Registered udp transport module.
    [    0.478368] RPC: Registered tcp transport module.
    [    0.483174] RPC: Registered tcp NFSv4.1 backchannel transport module.
    [    0.489760] PCI: CLS 0 bytes, default 64
    [    0.494177] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
    [    0.504680] Initialise system trusted keyrings
    [    0.509333] workingset: timestamp_bits=46 max_order=20 bucket_order=0
    [    0.517606] squashfs: version 4.0 (2009/01/31) Phillip Lougher
    [    0.523827] NFS: Registering the id_resolver key type
    [    0.529063] Key type id_resolver registered
    [    0.533335] Key type id_legacy registered
    [    0.537457] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
    [    0.544306] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
    [    0.551960] 9p: Installing v9fs 9p2000 file system support
    [    0.576921] Key type asymmetric registered
    [    0.581107] Asymmetric key parser 'x509' registered
    [    0.586109] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243)
    [    0.593668] io scheduler mq-deadline registered
    [    0.598293] io scheduler kyber registered
    [    0.603880] pinctrl-single 4301c000.pinctrl: 94 pins, size 376
    [    0.610061] pinctrl-single 11c000.pinctrl: 173 pins, size 692
    [    0.618586] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
    [    0.624870] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
    [    0.632792] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
    [    0.641025] arm-smmu-v3 36600000.iommu: ias 48-bit, oas 48-bit (features 0x00001faf)
    [    0.649304] arm-smmu-v3 36600000.iommu: allocated 65536 entries for cmdq
    [    0.656405] arm-smmu-v3 36600000.iommu: allocated 32768 entries for evtq
    [    0.665364] arm-smmu-v3 36600000.iommu: msi_domain absent - falling back to wired irqs
    [    0.678258] brd: module loaded
    [    0.685354] loop: module loaded
    [    0.688971] sysfs: cannot create duplicate filename '/devices/platform/dma_buf_phys'
    [    0.696890] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 5.10.120 #1
    [    0.703111] Hardware name: Texas Instruments K3 J721E SoC (DT)
    [    0.709068] Call trace:
    [    0.711574]  dump_backtrace+0x0/0x1a0
    [    0.715310]  show_stack+0x18/0x68
    [    0.718694]  dump_stack+0xd0/0x12c
    [    0.722165]  sysfs_warn_dup+0x60/0x80
    [    0.725898]  sysfs_create_dir_ns+0xe0/0xf8
    [    0.730080]  kobject_add_internal+0x98/0x288
    [    0.734437]  kobject_add+0x94/0x100
    [    0.737997]  device_add+0xe0/0x740
    [    0.741468]  platform_device_add+0x100/0x238
    [    0.745825]  platform_device_register_full+0xcc/0x150
    [    0.750990]  dma_buf_phys_init+0x6c/0x9c
    [    0.754992]  do_one_initcall+0x54/0x1b8
    [    0.758907]  kernel_init_freeable+0x220/0x2a0
    [    0.763355]  kernel_init+0x14/0x114
    [    0.766912]  ret_from_fork+0x10/0x34
    [    0.770569] 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.783795] megasas: 07.714.04.00-rc1
    [    0.789267] tun: Universal TUN/TAP device driver, 1.6
    [    0.794681] igbvf: Intel(R) Gigabit Virtual Function Network Driver
    [    0.801087] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
    [    0.807162] sky2: driver version 1.30
    [    0.811447] VFIO - User Level meta-driver version: 0.3
    [    0.817222] i2c /dev entries driver
    [    0.821459] sdhci: Secure Digital Host Controller Interface driver
    [    0.827775] sdhci: Copyright(c) Pierre Ossman
    [    0.832397] sdhci-pltfm: SDHCI platform and OF driver helper
    [    0.838695] ledtrig-cpu: registered to indicate activity on CPUs
    [    0.845041] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
    [    0.852290] optee: probing for conduit method.
    [    0.856855] optee: revision 3.12 (e28034d1)
    [    0.857128] optee: initialized driver
    [    0.866555] NET: Registered protocol family 17
    [    0.871183] 9pnet: Installing 9P2000 support
    [    0.875593] Key type dns_resolver registered
    [    0.880049] Loading compiled-in X.509 certificates
    [    0.890022] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
    [    0.896364] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
    [    0.904657] ti-sci 44083000.dmsc: ABI: 3.1 (firmware rev 0x0008 '8.4.1--v08.04.01 (Jolly Jellyfi')
    [    0.996728] davinci-mcasp 2ba0000.mcasp: IRQ common not found
    [    1.004773] omap_i2c 40b00000.i2c: bus 0 rev0.12 at 100 kHz
    [    1.010983] omap_i2c 40b10000.i2c: bus 1 rev0.12 at 100 kHz
    [    1.017153] omap_i2c 42120000.i2c: bus 2 rev0.12 at 100 kHz
    [    1.025132] omap_i2c 2020000.i2c: bus 3 rev0.12 at 400 kHz
    [    1.031452] pca953x 4-0020: supply vcc not found, using dummy regulator
    [    1.038288] pca953x 4-0020: using no AI
    [    1.064924] pca953x 4-0020: failed writing register
    [    1.069969] pca953x: probe of 4-0020 failed with error -121
    [    1.075932] omap_i2c 2030000.i2c: bus 4 rev0.12 at 400 kHz
    [    1.082126] omap_i2c 2040000.i2c: bus 5 rev0.12 at 100 kHz
    [    1.088266] omap_i2c 2050000.i2c: bus 6 rev0.12 at 100 kHz
    [    1.094857] ti-sci-intr bus@100000:bus@28380000:interrupt-controller2: Interrupt Router 137 domain created
    [    1.104940] ti-sci-intr bus@100000:interrupt-controller0: Destination irq resource allocation failed
    [    1.114282] ti-sci-intr: probe of bus@100000:interrupt-controller0 failed with error -22
    [    1.122813] ti-sci-intr bus@100000:main-navss:interrupt-controller1: Interrupt Router 213 domain created
    [    1.132828] ti-sci-inta 33d00000.interrupt-controller: Interrupt Aggregator domain 209 created
    [    1.155208] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,20] sci-dev-id:235
    [    1.165126] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled
    [    1.171887] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66346100, num_proxies:64
    [    1.181047] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:1024, gp-rings[440,150] sci-dev-id:211
    [    1.191199] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled
    [    1.197958] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66346100, num_proxies:64
    [    1.206049] 40a00000.serial: ttyS1 at MMIO 0x40a00000 (irq = 15, base_baud = 6000000) is a 8250
    [    1.215581] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 22, base_baud = 3000000) is a 8250
    [    1.224330] printk: console [ttyS2] enabled
    [    1.224330] printk: console [ttyS2] enabled
    [    1.232771] printk: bootconsole [ns16550a0] disabled
    [    1.232771] printk: bootconsole [ns16550a0] disabled
    [    1.243438] 2810000.serial: ttyS3 at MMIO 0x2810000 (irq = 23, base_baud = 3000000) is a 8250
    [    1.252545] 2840000.serial: ttyS6 at MMIO 0x2840000 (irq = 24, base_baud = 3000000) is a 8250
    [    1.262342] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vdd-hba-supply regulator, assuming enabled
    [    1.272851] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vcc-supply regulator, assuming enabled
    [    1.283002] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vccq-supply regulator, assuming enabled
    [    1.293243] cdns-ufshcd 4e84000.ufs: ufshcd_populate_vreg: Unable to find vccq2-supply regulator, assuming enabled
    [    1.304714] scsi host0: ufshcd
    [    1.310107] davinci_mdio 46000f00.mdio: Configuring MDIO in manual mode
    [    1.356892] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
    [    1.364872] mdio_bus 46000f00.mdio: MDIO device at address 0 is missing.
    [    1.371597] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2 quirks:00000000
    [    1.385853] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010a, freq:200000000, add_val:4 pps:0
    [    1.495958] davinci-mcasp 2ba0000.mcasp: IRQ common not found
    [    1.501855] mmc0: CQHCI version 5.10
    [    1.502097] mmc1: CQHCI version 5.10
    [    1.513578] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fc7100
    [    1.520556] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fc7100
    [    1.527534] omap-mailbox 31f82000.mailbox: omap mailbox rev 0x66fc7100
    [    1.534555] omap-mailbox 31f83000.mailbox: omap mailbox rev 0x66fc7100
    [    1.541550] omap-mailbox 31f84000.mailbox: omap mailbox rev 0x66fc7100
    [    1.542711] mmc0: SDHCI controller on 4f80000.mmc [4f80000.mmc] using ADMA 64-bit
    [    1.549601] ti-udma 285c0000.dma-controller: Channels: 26 (tchan: 13, rchan: 13, gp-rflow: 8)
    [    1.566615] ti-udma 31150000.dma-controller: Channels: 84 (tchan: 42, rchan: 42, gp-rflow: 16)
    [    1.578333] davinci_mdio 46000f00.mdio: Configuring MDIO in manual mode
    [    1.624889] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
    [    1.632871] mdio_bus 46000f00.mdio: MDIO device at address 0 is missing.
    [    1.639614] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2 quirks:00000000
    [    1.653588] am65-cpsw-nuss 46000000.ethernet: set new flow-id-base 48
    [    1.660790] am65-cpsw-nuss 46000000.ethernet: initialized cpsw ale version 1.4
    [    1.668021] am65-cpsw-nuss 46000000.ethernet: ALE Table size 64
    [    1.674569] am65-cpsw-nuss 46000000.ethernet: CPTS ver 0x4e8a010a, freq:500000000, add_val:1 pps:0
    [    1.685351] davinci-mcasp 2ba0000.mcasp: IRQ common not found
    [    1.695821] mmc0: Command Queue Engine enabled
    [    1.700273] mmc0: new HS200 MMC card at address 0001
    [    1.705557] mmcblk0: mmc0:0001 8GUF4R 7.28 GiB 
    [    1.706434] debugfs: Directory 'pd:27' with parent 'pm_genpd' already present!
    [    1.710209] mmcblk0boot0: mmc0:0001 8GUF4R partition 1 31.9 MiB
    [    1.717447] debugfs: Directory 'pd:26' with parent 'pm_genpd' already present!
    [    1.723314] mmcblk0boot1: mmc0:0001 8GUF4R partition 2 31.9 MiB
    [    1.730456] cdns-ufshcd 4e84000.ufs: link startup failed 1
    [    1.736444] mmcblk0rpmb: mmc0:0001 8GUF4R partition 3 4.00 MiB, chardev (237:0)
    [    1.741823] cdns-ufshcd 4e84000.ufs: UFS Host state=0
    [    1.754195] cdns-ufshcd 4e84000.ufs: outstanding reqs=0x0 tasks=0x0
    [    1.754204]  mmcblk0: p1 p2
    [    1.760461] cdns-ufshcd 4e84000.ufs: saved_err=0x0, saved_uic_err=0x0
    [    1.764383] debugfs: Directory 'pd:242' with parent 'pm_genpd' already present!
    [    1.769672] cdns-ufshcd 4e84000.ufs: Device power mode=1, UIC link state=0
    [    1.778410] debugfs: Directory 'pd:241' with parent 'pm_genpd' already present!
    [    1.783859] cdns-ufshcd 4e84000.ufs: PM in progress=0, sys. suspended=0
    [    1.783862] cdns-ufshcd 4e84000.ufs: Auto BKOPS=0, Host self-block=0
    [    1.783864] cdns-ufshcd 4e84000.ufs: Clk gate=1
    [    1.783868] cdns-ufshcd 4e84000.ufs: last_hibern8_exit_tstamp at 0 us, hibern8_exit_cnt=0
    [    1.783870] cdns-ufshcd 4e84000.ufs: last intr at 1624447 us, last intr status=0x404
    [    1.791568] debugfs: Directory 'pd:240' with parent 'pm_genpd' already present!
    [    1.797790] cdns-ufshcd 4e84000.ufs: error handling flags=0x0, req. abort count=0
    [    1.804607] debugfs: Directory 'pd:239' with parent 'pm_genpd' already present!
    [    1.808650] cdns-ufshcd 4e84000.ufs: hba->ufs_version=0x210, Host capabilities=0x1587031f, caps=0x0
    [    1.855640] cdns-ufshcd 4e84000.ufs: quirks=0x0, dev. quirks=0x0
    [    1.861647] cdns-ufshcd 4e84000.ufs: clk: core_clk, rate: 250000000
    [    1.867908] cdns-ufshcd 4e84000.ufs: clk: phy_clk, rate: 19200000
    [    1.873998] cdns-ufshcd 4e84000.ufs: clk: ref_clk, rate: 19200000
    [    1.880085] cdns-ufshcd 4e84000.ufs: ufshcd_print_pwr_info:[RX, TX]: gear=[0, 0], lane[0, 0], pwr[INVALID MODE, INVALID MODE], rate = 0
    [    1.892256] host_regs: 00000000: 1587031f 00000000 00000210 00000000
    [    1.898601] host_regs: 00000010: 00000000 00000000 00000000 00000000
    [    1.904944] host_regs: 00000020: 00000000 00000470 00000000 00000000
    [    1.911288] host_regs: 00000030: 00000008 00000001 00000000 00000000
    [    1.917657] host_regs: 00000040: 00000000 00000000 00000000 00000000
    [    1.924002] host_regs: 00000050: 00000000 00000000 00000000 00000000
    [    1.930344] host_regs: 00000060: 00000000 00000000 00000000 00000000
    [    1.936685] host_regs: 00000070: 00000000 00000000 00000000 00000000
    [    1.943029] host_regs: 00000080: 00000000 00000000 00000000 00000000
    [    1.949374] host_regs: 00000090: 00000000 00000000 00000000 00000000
    [    1.955720] cdns-ufshcd 4e84000.ufs: No record of pa_err
    [    1.961024] cdns-ufshcd 4e84000.ufs: No record of dl_err
    [    1.966327] cdns-ufshcd 4e84000.ufs: No record of nl_err
    [    1.971630] cdns-ufshcd 4e84000.ufs: No record of tl_err
    [    1.976934] cdns-ufshcd 4e84000.ufs: No record of dme_err
    [    1.982323] cdns-ufshcd 4e84000.ufs: No record of auto_hibern8_err
    [    1.988494] cdns-ufshcd 4e84000.ufs: No record of fatal_err
    [    1.994059] cdns-ufshcd 4e84000.ufs: link_startup_fail[0] = 0x1 at 1637579 us
    [    2.001183] cdns-ufshcd 4e84000.ufs: No record of resume_fail
    [    2.006917] cdns-ufshcd 4e84000.ufs: No record of suspend_fail
    [    2.012742] cdns-ufshcd 4e84000.ufs: No record of dev_reset
    [    2.018304] cdns-ufshcd 4e84000.ufs: No record of host_reset
    [    2.023968] cdns-ufshcd 4e84000.ufs: No record of task_abort
    [    2.053954] ALSA device list:
    [    2.056922]   No soundcards found.
    [    3.025171] sdhci-am654 4fb0000.mmc: Power on failed
    [    3.060752] mmc1: SDHCI controller on 4fb0000.mmc [4fb0000.mmc] using ADMA 64-bit
    [    3.220695] EXT4-fs (mmcblk0p2): recovery complete
    [    3.225880] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
    [    3.233998] VFS: Mounted root (ext4 filesystem) on device 179:2.
    [    3.240210] devtmpfs: mounted
    [    3.244235] Freeing unused kernel memory: 1792K
    [    3.248872] Run /sbin/init as init process
    [    3.302444] systemd[1]: System time before build time, advancing clock.
    [    3.326701] NET: Registered protocol family 10
    [    3.331723] Segment Routing with IPv6
    [    3.342398] 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)
    [    3.364191] systemd[1]: Detected architecture arm64.
    
    Welcome to Arago 2021.09!
    
    [    3.401166] systemd[1]: Set hostname to <j7-evm>.
    [    3.527461] systemd[1]: /lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock 鈫?/run/docker.sock; please update the unit file accordingly.
    [    3.549037] systemd[1]: /etc/systemd/system/boot_script.service:11: Support for option SysVStartPriority= has been removed and it is ignored
    [    3.594614] random: systemd: uninitialized urandom read (16 bytes read)
    [    3.601364] systemd[1]: system-getty.slice: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling.
    [    3.613688] systemd[1]: (This warning is only shown for the first unit using IP firewalling.)
    [    3.623841] systemd[1]: Created slice system-getty.slice.
    [  OK  ] Created slice system-getty.slice.
    [    3.644979] random: systemd: uninitialized urandom read (16 bytes read)
    [    3.652410] systemd[1]: Created slice system-serial\x2dgetty.slice.
    [  OK  ] Created slice system-serial\x2dgetty.slice.
    [    3.672969] random: systemd: uninitialized urandom read (16 bytes read)
    [    3.680224] systemd[1]: Created slice User and Session Slice.
    [  OK  ] Created slice User and Session Slice.
    [    3.701122] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
    [  OK  ] Started Dispatch Password 鈥s to Console Directory Watch.
    [    3.725010] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
    [  OK  ] Started Forward Password R鈥ests to Wall Directory Watch.
    [    3.749007] systemd[1]: Reached target Paths.
    [  OK  ] Reached target Paths.
    [    3.764949] systemd[1]: Reached target Remote File Systems.
    [  OK  ] Reached target Remote File Systems.
    [    3.784936] systemd[1]: Reached target Slices.
    [  OK  ] Reached target Slices.
    [    3.800945] systemd[1]: Reached target Swap.
    [  OK  ] Reached target Swap.
    [    3.818591] systemd[1]: Listening on RPCbind Server Activation Socket.
    [  OK  ] Listening on RPCbind Server Activation Socket.
    [    3.841002] systemd[1]: Reached target RPC Port Mapper.
    [  OK  ] Reached target RPC Port Mapper.
    [    3.862850] systemd[1]: Listening on Process Core Dump Socket.
    [  OK  ] Listening on Process Core Dump Socket.
    [    3.885134] systemd[1]: Listening on initctl Compatibility Named Pipe.
    [  OK  ] Listening on initctl Compatibility Named Pipe.
    [    3.912622] systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
    [    3.921041] systemd[1]: Listening on Journal Socket (/dev/log).
    [  OK  ] Listening on Journal Socket (/dev/log).
    [    3.941246] systemd[1]: Listening on Journal Socket.
    [  OK  ] Listening on Journal Socket.
    [    3.957282] systemd[1]: Listening on Network Service Netlink Socket.
    [  OK  ] Listening on Network Service Netlink Socket.
    [    3.981172] systemd[1]: Listening on udev Control Socket.
    [  OK  ] Listening on udev Control Socket.
    [    4.001100] systemd[1]: Listening on udev Kernel Socket.
    [  OK  ] Listening on udev Kernel Socket.
    [    4.023641] systemd[1]: Mounting Huge Pages File System...
             Mounting Huge Pages File System...
    [    4.043404] systemd[1]: Mounting POSIX Message Queue File System...
             Mounting POSIX Message Queue File System...
    [    4.067459] systemd[1]: Mounting Kernel Debug File System...
             Mounting Kernel Debug File System...
    [    4.087699] systemd[1]: Mounting Temporary Directory (/tmp)...
             Mounting Temporary Directory (/tmp)...
    [    4.107895] systemd[1]: Starting Create list of static device nodes for the current kernel...
             Starting Create list of st鈥des for the current kernel...
    [    4.135413] systemd[1]: Starting Start psplash boot splash screen...
             Starting Start psplash boot splash screen...
    [    4.160111] systemd[1]: Starting RPC Bind...
             Starting RPC Bind...
    [    4.173132] systemd[1]: Condition check resulted in File System Check on Root Device being skipped.
    [    4.185338] systemd[1]: Starting Journal Service...
             Starting Journal Service...
    [    4.208749] systemd[1]: Starting Load Kernel Modules...
             Starting Load Kernel Modules...
    [    4.227284] systemd[1]: Starting Remount Root and Kernel File Systems...
             Starting Remount Root and Kernel File Systems   4.238880] cryptodev: loading out-of-tree module taints kernel.
    [0m...
    [    4.252706] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
    [    4.254555] cryptodev: driver 1.10 loaded.
    [    4.265468] systemd[1]: Starting udev Coldplug all Devices...
             Starting udev Coldplug all Devices...
    [    4.284318] systemd[1]: Started RPC Bind.
    [  OK  ] Started RPC Bind.
    [    4.309448] systemd[1]: Started Journal Service.
    [  OK  ] Started Journal Service.
    [  OK  ] Mounted Huge Pages File System.
    [  OK  ] Mounted POSIX Message Queue File System.
    [  OK  ] Mounted Kernel Debug File System.
    [  OK  ] Mounted Temporary Directory (/tmp).
    [  OK  ] Started Create list of sta鈥?nodes for the current kernel.
    [FAILED] Failed to start Start psplash boot splash screen.
    See 'systemctl status psplash-start.service' for details.
    [DEPEND] Dependency failed for Star鈥rogress communication helper.
    [  OK  ] Started Load Kernel Modules.
    [  OK  ] Started Remount Root and Kernel File Systems.
             Mounting Kernel Configuration File System...
             Starting Flush Journal to Persistent Storage...
    [    4.542899] systemd-journald[165]: Received client request to flush runtime journal.
             Starting Apply Kernel Variables...
             Starting Create Static Device Nodes in /dev...
    [  OK  ] Mounted Kernel Configuration File System.
    [  OK  ] Started Flush Journal to Persistent Storage.
    [  OK  ] Started Apply Kernel Variables.
    [  OK  ] Started Create Static Device Nodes in /dev.
    [  OK  ] Started udev Coldplug all Devices.
    [    4.669534] urandom_read_iter: 47 callbacks suppressed
    [    4.669538] random: systemd: uninitialized urandom read (16 bytes read)
    [  OK  ] Reached target Local File Systems (Pre).
    [    4.701004] random: systemd: uninitialized urandom read (16 bytes read)
             Mounting /media/ram...
    [    4.711476] random: systemd-journal: uninitialized urandom read (16 bytes read)
             Mounting /var/volatile...
             Starting udev Wait for Complete Device Initialization...
             Starting udev Kernel Device Manager...
    [  OK  ] Mounted /media/ram.
    [  OK  ] Mounted /var/volatile.
             Starting Load/Save Random Seed...
    [  OK  ] Reached target Local File Systems.
             Starting Create Volatile Files and Directories...
    [  OK  ] Started udev Kernel Device Manager.
    [  OK  ] Started Create Volatile Files and Directories.
    [FAILED] Failed to start Network Time Synchronization.
    See 'systemctl status systemd-timesyncd.service' for details.
    [  OK  ] Reached target System Time Set.
    [  OK  ] Reached target System Time Synchronized.
             Starting Update UTMP about System Boot/Shutdown...
    [  OK  ] Stopped Network Time Synchronization.
    [FAILED] Failed to start Network Time Synchronization.
    See 'systemctl status systemd-timesyncd.service' for details.
    [  OK  ] Stopped Network Time Synchronization.
    [FAILED] Failed to start Network Time Synchronization.
    See 'systemctl status systemd-timesyncd.service' for details.
    [  OK  ] Started Update UTMP about System Boot/Shutdown.
    [  OK  ] Stopped Network Time Synchronization.
    [FAILED] Failed to start Network Time Synchronization.
    See 'systemctl status systemd-timesyncd.service' for details.
    [  OK  ] Stopped Network Time Synchronization.
    [FAILED] Failed to start Network Time Sync[    5.174785] CAN device driver interface
    hronization.
    See 'systemctl status systemd-timesyncd.service' for details.
    [  OK  ] Stopped Network Time Synchronization.
    [FAILED] Failed to start Network Time Synchronization.
    See 'systemctl status systemd-timesyncd.service' for details.
    [    5.253061] img_enc 4200000.video-encoder: vxe_enc_probe: using heap 1 for internal alloc
    [    5.449337] ina2xx 3-0040: error configuring the device: -121
    [    5.462346] ina2xx 3-0041: error configuring the device: -121
    [    5.479520] img_enc 4200000.video-encoder: encoder registered as /dev/video0
    [    5.486821] img_dec 4300000.video-decoder: decoder registered as /dev/video1
    [    5.501768] ina2xx 3-0042: error configuring the device: -121
    [    5.525221] ina2xx 3-0043: error configuring the device: -121
    [    5.557176] ina2xx 3-0044: error configuring the device: -121
    [    5.583674] ina2xx 3-0045: error configuring the device: -121
    [    5.607057] ina2xx 3-0046: error configuring the device: -121
    [    5.622089] k3-dsp-rproc 4d80800000.dsp: assigned reserved memory node vision-apps-c66-dma-memory@a9000000
    [    5.632982] ina2xx 3-0047: error configuring the device: -121
    [    5.645498] k3-dsp-rproc 4d80800000.dsp: configured DSP for IPC-only mode
    [    5.653089] ina2xx 3-0048: error configuring the device: -121
    [    5.664977] remoteproc remoteproc0: 4d80800000.dsp is available
    [    5.671838] ina2xx 3-0049: error configuring the device: -121
    [    5.684949] remoteproc remoteproc0: attaching to 4d80800000.dsp
    [    5.691517] ina2xx 3-004a: error configuring the device: -121
    [    5.705062] k3-dsp-rproc 4d80800000.dsp: DSP initialized in IPC-only mode
    [    5.712560] ina2xx 3-004b: error configuring the device: -121
    [    5.725129] ina2xx 3-004c: error configuring the device: -121
    [    5.731395]  remoteproc0#vdev0buffer: assigned reserved memory node vision-apps-c66-dma-memory@a9000000
    [    5.745110] ina2xx 3-004d: error configuring the device: -121
    [    5.761538] virtio_rpmsg_bus virtio0: rpmsg host is online
    [    5.767103] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xd
    [    5.775043] ina2xx 3-004e: error configuring the device: -121
    [    5.781581]  remoteproc0#vdev0buffer: registered virtio0 (type 7)
    [    5.793134] ina2xx 3-004f: error configuring the device: -121
    [    5.798992] remoteproc remoteproc0: remote processor 4d80800000.dsp is now attached
    [    5.848825] k3-dsp-rproc 4d81800000.dsp: assigned reserved memory node vision-apps-c66-dma-memory@a8000000
    [    5.969011] k3-dsp-rproc 4d81800000.dsp: configured DSP for IPC-only mode
    [    6.029237] pvrsrvkm 4e20000000.gpu: More than one power domain for this GPU, gpu driver manages power domains
    [    6.064135] remoteproc remoteproc1: 4d81800000.dsp is available
    [    6.113271] platform 5c00000.r5f: configured R5F for IPC-only mode
    [    6.149857] remoteproc remoteproc1: attaching to 4d81800000.dsp
    [    6.173435] PVR_K:  202: Read BVNC 22.104.208.318 from HW device registers
    [    6.207368] platform 5c00000.r5f: assigned reserved memory node vision-apps-r5f-dma-memory@a2000000
    [    6.231322] k3-dsp-rproc 4d81800000.dsp: DSP initialized in IPC-only mode
    [    6.261183] PVR_K:  202: RGX Device registered with BVNC 22.104.208.318
    [    6.333475] urandom_read_iter: 28 callbacks suppressed
    [    6.333480] random: systemd: uninitialized urandom read (16 bytes read)
    [    6.350488] random: systemd: uninitialized urandom read (16 bytes read)
    [    6.398146] remoteproc remoteproc2: 5c00000.r5f is available
    [    6.423280]  remoteproc1#vdev0buffer: assigned reserved memory node vision-apps-c66-dma-memory@a8000000
    [    6.441187] [drm] Initialized pvr 1.15.6133109 20170530 for 4e20000000.gpu on minor 0
    [    6.487277] virtio_rpmsg_bus virtio1: rpmsg host is online
    [    6.492312] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0xd
    [    6.522019]  remoteproc1#vdev0buffer: registered virtio1 (type 7)
    [    6.527148] remoteproc remoteproc2: attaching to 5c00000.r5f
    [    6.530641] remoteproc remoteproc1: remote processor 4d81800000.dsp is now attached
    [    6.546342] k3-dsp-rproc 64800000.dsp: assigned reserved memory node vision-apps-c71-dma-memory@aa000000
    [    6.606374] platform 5c00000.r5f: R5F core initialized in IPC-only mode
    [    6.669045] k3-dsp-rproc 64800000.dsp: configured DSP for IPC-only mode
    [    6.717665]  remoteproc2#vdev0buffer: assigned reserved memory node vision-apps-r5f-dma-memory@a2000000
    [    6.781465] random: systemd: uninitialized urandom read (16 bytes read)
    [    6.788537] remoteproc remoteproc3: 64800000.dsp is available
    [    6.824522] virtio_rpmsg_bus virtio2: rpmsg host is online
    [    6.839799] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0xd
    [    6.846707] remoteproc remoteproc3: attaching to 64800000.dsp
    [    6.852462]  remoteproc2#vdev0buffer: registered virtio2 (type 7)
    [    6.859562] remoteproc remoteproc2: remote processor 5c00000.r5f is now attached
    [    6.876942] random: crng init done
    [    6.880242] remoteproc remoteproc3: unsupported resource 65538
    [    6.880343] random: 3 urandom warning(s) missed due to ratelimiting
    [    6.886289] k3-dsp-rproc 64800000.dsp: DSP initialized in IPC-only mode
    [    6.899296]  remoteproc3#vdev0buffer: assigned reserved memory node vision-apps-c71-dma-memory@aa000000
    [    6.910851] platform 5d00000.r5f: configured R5F for IPC-only mode
    [    6.913238] virtio_rpmsg_bus virtio3: rpmsg host is online
    [    6.922615] virtio_rpmsg_bus virtio3: creating channel rpmsg_chrdev addr 0xd
    [    6.927358] platform 5d00000.r5f: assigned reserved memory node vision-apps-r5f-dma-memory@a4000000
    [    6.930342]  remoteproc3#vdev0buffer: registered virtio3 (type 7)
    [    6.945581] remoteproc remoteproc3: remote processor 64800000.dsp is now attached
    [    6.958415] remoteproc remoteproc4: 5d00000.r5f is available
    
    [    6.966536] remoteproc remoteproc4: attaching to 5d00000.r5f
    [    6.972487] platform 5d00000.r5f: R5F core initialized in IPC-only mode
    [    6.981190]  remoteproc4#vdev0buffer: assigned reserved memory node vision-apps-r5f-dma-memory@a4000000
    [    6.991030] virtio_rpmsg_bus virtio4: rpmsg host is online
    [    6.999761]  remoteproc4#vdev0buffer: registered virtio4 (type 7)
    [    7.006476] virtio_rpmsg_bus virtio4: creating channel rpmsg_chrdev addr 0xd
    [    7.015650] virtio_rpmsg_bus virtio4: creating channel rpmsg_chrdev addr 0x15
    [    7.023747] remoteproc remoteproc4: remote processor 5d00000.r5f is now attached
    [    7.031280] virtio_rpmsg_bus virtio3: creating channel rpmsg_chrdev addr 0x15
    [    7.038629] virtio_rpmsg_bus virtio3: creating channel ti.ipc4.ping-pong addr 0xe
    [    7.046226] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0x15
    [    7.053474] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xe
    [    7.061057] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0x15
    [    7.068360] virtio_rpmsg_bus virtio1: creating channel ti.ipc4.ping-pong addr 0xe
    [    7.075988] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0x15
    [    7.084753] platform 5e00000.r5f: configured R5F for remoteproc mode
    [    7.085012] virtio_rpmsg_bus virtio4: creating channel ti.ipc4.ping-pong addr 0xe
    [    7.107536] platform 5e00000.r5f: assigned reserved memory node vision-apps-r5f-dma-memory@a6000000
    [    7.117407] remoteproc remoteproc5: 5e00000.r5f is available
    [    7.125041] remoteproc remoteproc5: Direct firmware load for j7-main-r5f1_0-fw failed with error -2
    [    7.134237] remoteproc remoteproc5: powering up 5e00000.r5f
    [    7.139913] remoteproc remoteproc5: Direct firmware load for j7-main-r5f1_0-fw failed with error -2
    [    7.151903] remoteproc remoteproc5: request_firmware failed: -2
    [    7.157912] platform 5f00000.r5f: configured R5F for remoteproc mode
    [    7.168929] platform 5f00000.r5f: assigned reserved memory node vision-apps-r5f-dma-memory@a7000000
    [    7.191791] remoteproc remoteproc6: 5f00000.r5f is available
    [    7.247056] remoteproc remoteproc6: Direct firmware load for j7-main-r5f1_1-fw failed with error -2
    [    7.258448] remoteproc remoteproc6: powering up 5f00000.r5f
    [    7.265904] remoteproc remoteproc6: Direct firmware load for j7-main-r5f1_1-fw failed with error -2
    [    7.279333] remoteproc remoteproc6: request_firmware failed: -2
    [    7.285857] virtio_rpmsg_bus virtio2: creating channel ti.ethfw.notifyservice addr 0x1e
    [    7.296868] virtio_rpmsg_bus virtio2: creating channel rpmsg-kdrv addr 0x1a
    [    7.304697] rpmsg-kdrv-eth-switch rpmsg-kdrv-1-mpu_1_0_ethmac-device-1: Device info: permissions: 3FFFFFFF uart_id: 2
    [    7.317060] rpmsg-kdrv-eth-switch rpmsg-kdrv-1-mpu_1_0_ethmac-device-1: FW ver 0.2 (rev 0)  7/Apr/2023 SHA:e28034d1
    [    7.405695] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    7.436617] virtio_rpmsg_bus virtio2: creating channel ti.ipc4.ping-pong addr 0xe
    [    7.447851] j721e-cpsw-virt-mac main-r5fss-cpsw9g-virt-mac1: rpmsg attach_ext - rx_mtu:1522 features:00000007 tx_mtu[0]:2024 flow_idx:172 tx_cpsw_psil_dst_id:51712 mac_addr:70:ff:76:1d:92:c1 mac-only:1
    [    7.535359] j721e-cpsw-virt-mac main-r5fss-cpsw9g-virt-mac1: virt_cpsw_nuss mac loaded
    [    7.552976] j721e-cpsw-virt-mac main-r5fss-cpsw9g-virt-mac1: rdev_features:00000007 rdev_mtu:1522 flow_id:172 tx_psil_dst_id:4A00 mac_only:1
    [    7.643303] j721e-cpsw-virt-mac main-r5fss-cpsw9g-virt-mac1: local_mac_addr:00:00:00:00:00:00 rdev_mac_addr:70:ff:76:1d:92:c1
    [    7.819606] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [  OK  ] Created slice system-systemd\x2dfsck.slice.
    [    8.131532] usbcore: registered new interface driver usbfs
    [    8.137210] omap_rng 4e10000.rng: Random Number Generator ver. 241b34c
    [    8.150181] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.165094] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.182914] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.199088] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.219065] remoteproc remoteproc7: b034000.pru is available
    [    8.219656] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.243866] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [  OK  ] Found device /dev/mmcblk0p1.
    [    8.259991] usbcore: registered new interface driver hub
    [    8.264363] remoteproc remoteproc8: b004000.rtu is available
             Starting File System Check on /dev/mmcblk0p1    8.278514] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    0m...
    [    8.304999] usbcore: registered new device driver usb
    [    8.360778] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [  OK  ] Started File System Check on /dev/mmcblk0p1.
    [    8.375592] remoteproc remoteproc9: b00a000.txpru is available
    [    8.384003] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
             Mounting /run/media/mmcblk0p1...
    [    8.402493] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.412352] remoteproc remoteproc10: b038000.pru is available
    [  OK  ] Mounted /run/media/mmcblk0p1.
    [    8.435623] remoteproc remoteproc11: b006000.rtu is available
    [    8.447230] remoteproc remoteproc12: b00c000.txpru is available
    [    8.455005] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.462865] remoteproc remoteproc13: b134000.pru is available
    [    8.472787] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.480431] remoteproc remoteproc14: b104000.rtu is available
    [    8.488604] remoteproc remoteproc15: b10a000.txpru is available
    [    8.495631] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.503669] remoteproc remoteproc16: b138000.pru is available
    [    8.512824] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.520526] remoteproc remoteproc17: b106000.rtu is available
    [    8.529946] remoteproc remoteproc18: b10c000.txpru is available
    [    8.536943] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.639299] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
    [    8.730751] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
    [    8.740189] xhci-hcd xhci-hcd.0.auto: hcc params 0x200073c9 hci version 0x100 quirks 0x0000002000010010
    [    8.749662] xhci-hcd xhci-hcd.0.auto: irq 422, io mem 0x06410000
    [    8.756175] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
    [    8.764836] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [    8.772069] usb usb1: Product: xHCI Host Controller
    [    8.776949] usb usb1: Manufacturer: Linux 5.10.120 xhci-hcd
    [    8.782516] usb usb1: SerialNumber: xhci-hcd.0.auto
    [    8.787682] hub 1-0:1.0: USB hub found
    [    8.791475] hub 1-0:1.0: 1 port detected
    [    8.795941] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.797293] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
    [    8.806685] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [    8.808314] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
    [    8.822876] xhci-hcd xhci-hcd.0.auto: Host supports USB 3.0 SuperSpeed
    [    8.829424] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
    [    8.837556] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
    [    8.845811] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [    8.853022] usb usb2: Product: xHCI Host Controller
    [    8.857890] usb usb2: Manufacturer: Linux 5.10.120 xhci-hcd
    [    8.863451] usb usb2: SerialNumber: xhci-hcd.0.auto
    [    8.868596] hub 2-0:1.0: USB hub found
    [    8.872366] hub 2-0:1.0: 1 port detected
    [    8.880369] j721e-audio sound@0: devm_snd_soc_register_card() failed: -517
    [  OK  ] Started udev Wait for Complete Device Initialization.
    [  OK  ] Started Hardware RNG Entropy Gatherer Daemon.
    [  OK  ] Reached target System Initialization.
    [  OK  ] Started Daily rotation of log files.
    [  OK  ] Started Daily Cleanup of Temporary Directories.
    [  OK  ] Reached target Timers.
    [  OK  ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
    [  OK  ] Listening on D-Bus System Message Bus Socket.
             Starting Docker Socket for the API.
    [  OK  ] Listening on dropbear.socket.
             Starting Reboot and dump vmcore via kexec...
    [  OK  ] Listening on Docker Socket for the API.
    [  OK  ] Started Reboot and dump vmcore via kexec.
    [  OK  ] Reached target Sockets.
    [  OK  ] Reached target Basic System.
    [  OK  ] Started Job spooling tools.
             Starting /etc/rc.local Compatibility...
    [  OK  ] Started Periodic Command Scheduler.
    >>>>start to run ./vx_motovis_surround_view.out --cfg app_around_cam.cfg
    
    [  OK  ] Started D-Bus System Message Bus.
             Starting Print notice about GPLv3 packages...
             Starting set host name as per compatible name...
             Starting IPv6 Packet Filtering Framework...
             Starting IPv4 Packet Filtering Framework...
    [  OK  ] Started irqbalance daemon.
             Starting Telephony service...
             Starting Update pmic regis鈥ety feature on power rails...
             Starting rc.pvr.service...
             Starting startwlanap...
             Starting startwlansta...
    [FAILED] Failed to start Login Service.
    See 'systemctl status systemd-logind.service' for details.
    [  OK  ] Started TEE Supplicant.
             Starting Update weston ini鈥?based on the platform name...
    [  OK  ] Started /etc/rc.local Compatibility.
    [  OK  ] Started IPv6 Packet Filtering Framework.
    [  OK  ] Started IPv4 Packet Filtering Framework.
    [  OK  ] Reached target Network (Pre).
    [  OK  ] Stopped Login Service.
    [FAILED] Failed to start Login Service.
    See 'systemctl status systemd-logind.service' for details.
             Starting Net[    9.385109] Bluetooth: Core ver 2.22
    work Service...
    [  OK  ] Started Teleph[    9.390449] NET: Registered protocol family 31
    ony service.
    [  OK  ] Stopped Login Service.
    [FAILED] Failed to start Login [    9.406967] Bluetooth: HCI device and connection manager initialized
    Service.
    See 'systemctl status systemd-logind.service' for details.
    [  OK  ] Started startwlansta.[    9.423439] Bluetooth: HCI socket layer initialized
    
    [  OK  ] Listening on Load/Save RF 鈥tch Status /dev/rfkill Watch.
    [  OK  ] Stopped     9.443160] Bluetooth: L2CAP socket layer initialized
    1;39mLogin Service.
    [FAILED] Failed to start    9.454730] Bluetooth: SCO socket layer initialized
    [0;1;39mLogin Service.
    See 'systemctl status systemd-logind.service' for details.
    [  OK  ] Stopped Login Service.
    [FAILED] Failed to start Login Service.
    See 'systemctl status systemd-logind.service' for details.
    [  OK  ] Stopped Login Service.
    [FAILED] Failed to start Login Service.
    See 'systemctl status systemd-logind.service' for details.
    [  OK  ] Started set host name as per compatible name.
    [  OK  ] Started Update pmic regist鈥afety feature on power rails.
    [  OK  ] Started Update weston ini 鈥e based on the platform name.
    [  OK  ] Started startwlanap.
    [  OK  ] Started Network Service.
             Starting Wait for Network to be Configured...
    [FAILED] Failed to start Network Name Resolution.
    See 'systemctl status systemd-resolved.service' for details.
    [  OK  ] Reached target Network.
    [  OK  ] Reached target Host and Network Name Lookups.
             Starting Avahi mDNS/DNS-SD Stack...
             Starting Enable and configure wl18xx bluetooth stack...
    [  OK  ] Started NFS status monitor for NFSv2/3 locking..
             Starting Simple Network Ma鈥nt Protocol (SNMP) Daemon....
             Starting Permit User Sessions...
    [  OK  ] Stopped Network Name Resolution.
    [FAILED] Failed to start Network Name Resolution.
    See 'systemctl status systemd-resolved.service' for details.
    [  OK  ] Stopped Network Name Resolution.
    [FAILED] Failed to start Network Name Resolution.
    See 'systemctl status systemd-resolved.service' for details.
    [  OK  ] Started Enable and configure wl18xx bluetooth stack.
    [  OK  ] Started Avahi mDNS/DNS-SD Stack.
    [  OK  ] Stopped Network Name Resolution.
    [FAILED] Failed to start Network Name Resolution.
    [    9.709387] j721e-cpsw-virt-mac main-r5fss-cpsw9g-virt-mac1: virt_cpsw_nuss mac started
    
    [  OK  ] Stopped Network Name Resolution.
    [FAILED] Failed to start Network Name Resolution.
    See 'systemctl status systemd-resolved.service' for details.
    [  OK  ] Stopped Network Name Resolution.
    [FAILED] Failed to start Network Name Resolution.
    See 'systemctl status systemd-resolved.service' for details.
    [  OK  ] Started Permit User Sessions.
    [  OK  ] Started Getty on tty1.
    [  OK  ] Started Serial Getty on ttyS2.
    APP: Init ... !!!
    MEM: Init ... !!!
    MEM: Initialized DMA HEAP (fd=4) !!!
    MEM: Init ... Done !!!
    IPC: Init ... !!!
    [  OK  ] Started Serial Getty on ttyS3.
    [  OK  ] Reached target Login Prompts.
             Starting Synchronize System and HW clocks...
    [FAILED] Failed to start Synchronize System and HW clocks.
    See 'systemctl status sync-clocks.service' for details.
    IPC: Init ... Done !!!
    REMOTE_SERVICE: Init ... !!!
    REMOTE_SERVICE: Init ... Done !!!
        31.428181 s: GTC Frequency = 200 MHz
    APP: Init ... Done !!!
        31.430425 s:  VX_ZONE_INIT:Enabled
        31.430447 s:  VX_ZONE_ERROR:Enabled
        31.430466 s:  VX_ZONE_WARNING:Enabled
        31.431256 s:  VX_ZONE_INIT:[tivxInitLocal:130] Initialization Done !!!
        31.432318 s:  VX_ZONE_INIT:[tivxHostInitLocal:86] Initialization Done for HOST !!!
    app_init_capture_graph Init Done! 
    app init capture graph scccessful!
    ldcObj Init Done!
    app init ldc graph scccessful!
    Img Mosaic Init Done! 
    app_init_m2m_graph Init Done! 
    app_init_m2m successful!
    app_init_csitx_graph Init Done! 
    app_init_csitx_graph successful!
    app_create_all_graph status 0
    app_create_graph_capture TIVX_TARGET_CAPTURE1
    app_create_graph_capture status 0
    app creat capture graph scccessful!
    app creat ldc graph scccessful!
    app create msc graph ......!
    success to create scaler node
    app creat m2m2 graph scccessful!
    app creat csitx graph scccessful!
    app_create_all_graph 1
    app_create_all_graph 3
    app_create_all_graph 4
    app_create_all_graph 6
    app_verify_graph saxasx1
    app_verify_graph 2
    [  OK  ] Started rc.pvr.service.
             Starting weston.service...
    app_verify_graph 3
    app creat queue scccessful!
    Waitting Deque... 
    app_init_camera1
    [  OK  ] Started Simple Network Man鈥ment Protocol (SNMP) Daemon..
    ***************************************************************
    ***************************************************************
    NOTICE: This file system contains the following GPLv3 packages:
            autoconf
            bash-dev
            bash
            bc
            binutils
            cifs-utils
            coreutils-stdbuf
            coreutils
            cpio
            cpp-symlinks
            cpp
            dosfstools
            elfutils
            g++-symlinks
            g++
            gawk
            gcc-symlinks
            gcc
            gdb
            gdbserver
            gettext
            glmark2
            gstreamer1.0-libav-dev
            gstreamer1.0-libav
            gzip
            less
            libasm1
            libbfd
            libdw1
            libelf1
            libgdbm-compat4
            libgdbm-dev
            libgdbm6
            libgettextlib
            libgettextsrc
            libgmp-dev
            libgmp10
            libgmpxx4
            libidn2-0
            libidn2-dev
            libmpc3
            libmpfr6
            libreadline-dev
            libreadline8
            libunistring-dev
            libunistring2
            m4-dev
            m4
            make
            nettle-dev
            nettle
            parted
            python3-rfc3987
            python3-strict-rfc3339
            tar
            which
            zeromq
    
    If you do not wish to distribute GPLv3 components please remove
    the above packages prior to distribution.  This can be done using
    the opkg remove command.  i.e.:
        opkg remove <package>
    Where <package> is the name printed in the list above
    
    NOTE: If the package is a dependency of another package you
          will be notified of the dependent packages.  You should
          use the --force-removal-of-dependent-packages option to
          also remove the dependent packages as well
    ***************************************************************
    ***************************************************************
    [  OK  ] Started Print notice about GPLv3 packages.
    [  OK  ] Started weston.service.
             Starting DEMO...
             Starting telnetd.service...
    [  OK  ] Started DEMO.
    [  OK  ] Started telnetd.service.
    
     _____                    _____           _         _   
    |  _  |___ ___ ___ ___   |  _  |___ ___  |_|___ ___| |_ 
    |     |  _| .'| . | . |  |   __|  _| . | | | -_|  _|  _|
    |__|__|_| |__,|_  |___|  |__|  |_| |___|_| |___|___|_|  
                  |___|                    |___|            
    
    Arago Project j7-evm ttyS2
    
    Arago 2021.09 j7-evm ttyS2
    
    j7-evm login: root
    
    
    
    

    As i share in file 'Mbox_timedout_in_resp.log'. This is another type err.

    This is mbox timeout err.

    thanks

  • Hi Keerthy,

    Can  you share any detail about Mbox Components in TDA4 platform?

    i can not see anything about Mbox on this docs directory 'Docs » 3. Foundational Components » 3.2. Kernel » 3.2.2. Kernel Drivers'.

    thanks

  • Hi Keerthy,

    Is any update for this process?

    Regards.

  • Hi Xie,

    What firmware are you using on MCU1_0 on your board? Do you use a firmware delivered from TI SDK, or use your own firmware?

    The TI-SCI message that is failing would have been handled by the SciServer running on your MCU1_0 Device Management firmware. The failure happens when the MCU1_0 has not responded to the TI-SCI request in a timely fashion.

    Please connect the JTAG debugger to the MCU R5F core, and see where the execution is when you see an issue. Check if it has run into exception and has aborted, and stopped responding to all incoming TI-SCI requests.

    regards

    Suman