Hi,
system blocked after booting fw with "remoteproc mode"
I do the test on my platform , psdkla version is sdk7.2 , platform is our customer board,
1, set dorprocboot=0 in uboot, linux blocked at "remoteproc remoteproc4: Booting fw image j7-main-r5f0_1-fw"
2. set dorprocboot=1 in uboot, linux work fine.
About the block problem, I add some log for simple test, it seems that the system was blocked at below code in funciton k3_r5_rproc_prepare
memset(core->mem[0].cpu_addr, 0x00, core->mem[0].size);
please check the picture attached.
system blocked log:
[2021-08-19 16:23:42.584] [ 3.065923] remoteproc remoteproc4: 5d00000.r5f is available
[2021-08-19 16:23:42.757] [ 3.258858] hjwang rproc_boot-2110:5d00000.r5f 0
[2021-08-19 16:23:42.803] [ 3.263490] remoteproc remoteproc4: powering up 5d00000.r5f
[2021-08-19 16:23:42.803] [ 3.269910] remoteproc remoteproc4: Booting fw image j7-main-r5f0_1-fw, size 1923072
[2021-08-19 16:23:42.804] [ 3.277664] hjwang rproc_fw_boot-1663:5d00000.r5f
[2021-08-19 16:23:42.804] [ 3.282753] hjwang rproc_fw_boot-1665:5d00000.r5f ret=0
[2021-08-19 16:23:42.804] [ 3.288107] hjwang k3_r5_rproc_prepare-396:5d00000.r5f
[2021-08-19 16:23:42.804] [ 3.293588] hjwang k3_r5_rproc_prepare-399:5d00000.r5f
[2021-08-19 16:23:42.805] [ 3.299141] hjwang k3_r5_rproc_prepare-407:5d00000.r5f
[2021-08-19 16:23:42.805] [ 3.304369] hjwang k3_r5_rproc_prepare-413:5d00000.r5f
[2021-08-19 16:23:42.824] [ 3.309590] hjwang k3_r5_rproc_prepare-425:5d00000.r5f
source code picture:
After compare the logs between good and no good, the difference as below, I hope it is useful.
and I attach the log to the case
ipc_only_mode_work.log : boot up ok
remoteproc_mode_fail.log : boot up failed
[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd080] [ 0.000000] Linux version 5.4.74-ACU-1.3.21.1 (hjwang@Tower-5810-Nvidia-Host) (gcc version 9.2.1 20191025 (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10))) #11 SMP PREEMPT Thu Aug 19 15:51:24 CST 2021 [ 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] OF: reserved mem: not enough space all defined regions. [ 0.000000] OF: reserved mem: not enough space all defined regions. [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [ 0.000000] vision_apps-r5f-dma-memory@a1000000 (0x00000000a1000000--0x00000000a1100000) overlaps with r5f-dma-memory@a1000000 (0x00000000a1000000--0x00000000a1100000) [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [ 0.000000] vision_apps-r5f-memory@a1100000 (0x00000000a1100000--0x00000000a3000000) overlaps with r5f-memory@a1100000 (0x00000000a1100000--0x00000000a2000000) [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [ 0.000000] r5f-memory@a3100000 (0x00000000a3100000--0x00000000a4000000) overlaps with vision_apps-r5f-memory@a3100000 (0x00000000a3100000--0x00000000a5000000) [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [ 0.000000] vision_apps-r5f-memory@a3100000 (0x00000000a3100000--0x00000000a5000000) overlaps with r5f-dma-memory@a4000000 (0x00000000a4000000--0x00000000a4100000) [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [ 0.000000] vision_apps-r5f-dma-memory@a5000000 (0x00000000a5000000--0x00000000a5100000) overlaps with r5f-dma-memory@a5000000 (0x00000000a5000000--0x00000000a5100000) [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [ 0.000000] r5f-memory@a5100000 (0x00000000a5100000--0x00000000a6000000) overlaps with vision_apps-r5f-memory@a5100000 (0x00000000a5100000--0x00000000a5800000) [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000094000000, size 128 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-core-heap-memory@94000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a0000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node 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 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 0x00000000a1000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a1000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a1100000, size 31 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a1100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a1100000, size 15 MiB [ 0.000000] OF: reserved mem: initialized node 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 r5f-dma-memory@a2000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a2100000, size 15 MiB [ 0.000000] OF: reserved mem: initialized node r5f-memory@a2100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a3000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a3000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a3100000, size 15 MiB [ 0.000000] OF: reserved mem: initialized node r5f-memory@a3100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a3100000, size 31 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a3100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a4000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a4000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a4100000, size 15 MiB [ 0.000000] OF: reserved mem: initialized node r5f-memory@a4100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-dma-memory@a5000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a5000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5100000, size 15 MiB [ 0.000000] OF: reserved mem: initialized node r5f-memory@a5100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5100000, size 7 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a5100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5800000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-dma-memory@a5800000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5900000, size 7 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a5900000, 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 c66-dma-memory@a6000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a6100000, size 15 MiB [ 0.000000] OF: reserved mem: initialized node c66-memory@a6100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a7000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node c66-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 c66-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 c71-dma-memory@a8000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a8100000, size 31 MiB [ 0.000000] OF: reserved mem: initialized node c71-memory@a8100000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000ac000000, size 32 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-dma-memory@ac000000, 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 0x00000000ce000000, size 720 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-core-heap-memory@ce000000, compatible id shared-dma-pool [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000fb000000, size 1 MiB [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-dma-memory@fb000000, compatible id shared-dma-pool [ 0.000000] cma: Failed to reserve 512 MiB [ 0.000000] On node 0 totalpages: 27840 [ 0.000000] DMA zone: 11 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 10368 pages, LIFO batch:1 [ 0.000000] DMA32 zone: 16 pages used for memmap [ 0.000000] DMA32 zone: 18446744073709536320 pages, LIFO batch:3 [ 0.000000] Normal zone: 32 pages used for memmap [ 0.000000] Normal zone: 32768 pages, LIFO batch:3 [ 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.0 [ 0.000000] percpu: Embedded 2 pages/cpu s48408 r8192 d74472 u131072 [ 0.000000] pcpu-alloc: s48408 r8192 d74472 u131072 alloc=2*65536 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] CPU features: detected: EL2 vector hardening [ 0.000000] Built 1 zonelists, mobility grouping off. Total pages: 27781 [ 0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 mtdparts=47040000.spi.0:512k(ospi.sbl),512k(ospi.tifs_a),512k(ospi.tifs_b),4m(ospi.mcufw_a),4m(ospi.mcufw_b),2m(ospi.atf_optee_a),2m(ospi.atf_optee_b),1m(ospi.u-boot-spl_a),1m(ospi.u-boot-spl_b),2m(ospi.u-boot_a),2m(ospi.u-boot_b),128k(ospi.misc_a),128k(ospi.misc_b),128k(ospi.factory),128k(ospi.safe_a),128k(ospi.safe_b),2m(ospi.mcudata),256k(ospi.sonar_data),10092544(ospi.reserved) root=PARTUUID=00000000-02 ro rootfstype=ext4 rootwait loglevel=0 lpj=800000 [ 0.000000] Dentry cache hash table entries: 262144 (order: 5, 2097152 bytes, linear) [ 0.000000] Inode-cache hash table entries: 131072 (order: 4, 1048576 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: mapped [mem 0x90000000-0x94000000] (64MB) [ 0.000000] Memory: 2435968K/1781760K available (9406K kernel code, 784K rwdata, 3776K rodata, 1664K init, 705K bss, 18446744073708897408K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=2. [ 0.000000] 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: no VLPI support, no direct LPI support [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001900000 [ 0.000000] ITS [mem 0x01820000-0x0182ffff] [ 0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS [ 0.000000] ITS@0x0000000001820000: allocated 1048576 Devices @8c0800000 (flat, esz 8, psz 64K, shr 0) [ 0.000000] ITS: using cache flushing for cmd queue [ 0.000000] GICv3: using LPI property table @0x00000008c00c0000 [ 0.000000] GIC: using cache flushing for LPI property table [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000008c00d0000 [ 0.000000] random: get_random_bytes called from start_kernel+0x2b8/0x43c with crng_init=0 [ 0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns [ 0.000001] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns [ 0.000102] Console: colour dummy device 80x25 [ 0.000126] Calibrating delay loop (skipped) preset value.. 400.00 BogoMIPS (lpj=800000) [ 0.000131] pid_max: default: 32768 minimum: 301 [ 0.000168] LSM: Security Framework initializing [ 0.000200] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [ 0.000210] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [ 0.001199] ASID allocator initialised with 32768 entries [ 0.001246] rcu: Hierarchical SRCU implementation. [ 0.001361] Platform MSI: gic-its@1820000 domain created [ 0.001439] PCI/MSI: /bus@100000/interrupt-controller@1800000/gic-its@1820000 domain created [ 0.001576] smp: Bringing up secondary CPUs ... [ 0.002233] Detected PIPT I-cache on CPU1 [ 0.002255] GICv3: CPU1: found redistributor 1 region 0:0x0000000001920000 [ 0.002265] GICv3: CPU1: using allocated LPI pending table @0x00000008c00e0000 [ 0.002290] CPU1: Booted secondary processor 0x0000000001 [0x411fd080] [ 0.002334] smp: Brought up 1 node, 2 CPUs [ 0.002336] SMP: Total of 2 processors activated. [ 0.002339] CPU features: detected: 32-bit EL0 Support [ 0.002341] CPU features: detected: CRC32 instructions [ 0.008672] CPU: All CPU(s) started at EL2 [ 0.008685] alternatives: patching kernel code [ 0.009142] devtmpfs: initialized [ 0.011569] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.011577] futex hash table entries: 512 (order: -1, 32768 bytes, linear) [ 0.011701] pinctrl core: initialized pinctrl subsystem [ 0.012090] NET: Registered protocol family 16 [ 0.012371] DMA: preallocated 256 KiB pool for atomic allocations [ 0.012616] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.017662] HugeTLB registered 16.0 GiB page size, pre-allocated 0 pages [ 0.017666] HugeTLB registered 512 MiB page size, pre-allocated 0 pages [ 0.017668] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.018615] cryptd: max_cpu_qlen set to 1000 [ 0.020134] iommu: Default domain type: Translated [ 0.020277] SCSI subsystem initialized [ 0.020375] mc: Linux media interface: v0.10 [ 0.020384] videodev: Linux video capture interface: v2.00 [ 0.020393] pps_core: LinuxPPS API ver. 1 registered [ 0.020395] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [ 0.020400] PTP clock support registered [ 0.020409] EDAC MC: Ver: 3.0.0 [ 0.020819] FPGA manager framework [ 0.021222] clocksource: Switched to clocksource arch_sys_counter [ 0.021294] VFS: Disk quotas dquot_6.6.0 [ 0.021327] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes) [ 0.023483] Carveout Heap: Exported 512 MiB at 0x00000000ae000000 [ 0.023488] thermal_sys: Registered thermal governor 'step_wise' [ 0.023489] thermal_sys: Registered thermal governor 'power_allocator' [ 0.023779] NET: Registered protocol family 2 [ 0.024103] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear) [ 0.024147] TCP established hash table entries: 16384 (order: 1, 131072 bytes, linear) [ 0.024199] TCP bind hash table entries: 16384 (order: 2, 262144 bytes, linear) [ 0.024348] TCP: Hash tables configured (established 16384 bind 16384) [ 0.024392] UDP hash table entries: 2048 (order: 0, 65536 bytes, linear) [ 0.024432] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes, linear) [ 0.024521] NET: Registered protocol family 1 [ 0.024749] RPC: Registered named UNIX socket transport module. [ 0.024751] RPC: Registered udp transport module. [ 0.024752] RPC: Registered tcp transport module. [ 0.024754] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.024760] PCI: CLS 0 bytes, default 64 [ 0.025060] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available [ 0.026745] Initialise system trusted keyrings [ 0.026809] workingset: timestamp_bits=46 max_order=16 bucket_order=0 [ 0.028728] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 0.028973] NFS: Registering the id_resolver key type [ 0.028984] Key type id_resolver registered [ 0.028986] Key type id_legacy registered [ 0.028992] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 0.029084] 9p: Installing v9fs 9p2000 file system support [ 0.036406] Key type asymmetric registered [ 0.036409] Asymmetric key parser 'x509' registered [ 0.036428] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) [ 0.036431] io scheduler mq-deadline registered [ 0.036433] io scheduler kyber registered [ 0.037106] pinctrl-single 4301c000.pinmux: 94 pins, size 376 [ 0.037354] pinctrl-single 11c000.pinmux: 173 pins, size 692 [ 0.038773] k3-ringacc 2b800000.ringacc: Failed to get MSI domain [ 0.038798] k3-ringacc 3c000000.ringacc: Failed to get MSI domain [ 0.038872] ti-pat 31010000.pat: Found PAT Rev 1.0 with 16384 pages [ 0.038880] debugfs: Directory '31010000.pat' with parent 'regmap' already present! [ 0.039026] ti-pat 31011000.pat: Found PAT Rev 1.0 with 16384 pages [ 0.039033] debugfs: Directory '31011000.pat' with parent 'regmap' already present! [ 0.039127] ti-pat 31012000.pat: Found PAT Rev 1.0 with 16384 pages [ 0.039134] debugfs: Directory '31012000.pat' with parent 'regmap' already present! [ 0.039217] ti-pat 31013000.pat: Found PAT Rev 1.0 with 2048 pages [ 0.039223] debugfs: Directory '31013000.pat' with parent 'regmap' already present! [ 0.039309] ti-pat 31014000.pat: Found PAT Rev 1.0 with 2048 pages [ 0.039315] debugfs: Directory '31014000.pat' with parent 'regmap' already present! [ 0.040488] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled [ 0.044808] brd: module loaded [ 0.047577] loop: module loaded [ 0.047608] mtip32xx Version 1.3.1 [ 0.047846] sysfs: cannot create duplicate filename '/devices/platform/dma_buf_phys' [ 0.047851] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.4.74-ACU-1.3.21.1 #11 [ 0.047852] Hardware name: Texas Instruments K3 J721E SoC (DT) [ 0.047855] Call trace: [ 0.047863] dump_backtrace+0x0/0x140 [ 0.047866] show_stack+0x14/0x20 [ 0.047873] dump_stack+0xb4/0x114 [ 0.047879] sysfs_warn_dup+0x5c/0x78 [ 0.047882] sysfs_create_dir_ns+0xd8/0xf0 [ 0.047885] kobject_add_internal+0x94/0x280 [ 0.047887] kobject_add+0x90/0xf8 [ 0.047891] device_add+0xdc/0x600 [ 0.047894] platform_device_add+0xfc/0x228 [ 0.047896] platform_device_register_full+0xc8/0x140 [ 0.047903] dma_buf_phys_init+0x68/0x94 [ 0.047906] do_one_initcall+0x50/0x1a8 [ 0.047910] kernel_init_freeable+0x194/0x23c [ 0.047913] kernel_init+0x10/0xfc [ 0.047915] ret_from_fork+0x10/0x1c [ 0.047918] 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.048549] libphy: Fixed MDIO Bus: probed [ 0.048703] tun: Universal TUN/TAP device driver, 1.6 [ 0.048854] igbvf: Intel(R) Gigabit Virtual Function Network Driver - version 2.4.0-k [ 0.048856] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [ 0.048871] sky2: driver version 1.30 [ 0.049194] VFIO - User Level meta-driver version: 0.3 [ 0.049512] i2c /dev entries driver [ 0.049703] Error: Driver 'k3-soc-thermal' is already registered, aborting... [ 0.049851] sdhci: Secure Digital Host Controller Interface driver [ 0.049852] sdhci: Copyright(c) Pierre Ossman [ 0.049946] sdhci-pltfm: SDHCI platform and OF driver helper [ 0.050212] ledtrig-cpu: registered to indicate activity on CPUs [ 0.050668] optee: probing for conduit method from DT. [ 0.050679] optee: revision 3.8 (199fca17) [ 0.050950] optee: initialized driver [ 0.051095] NET: Registered protocol family 17 [ 0.051160] 9pnet: Installing 9P2000 support [ 0.051182] Key type dns_resolver registered [ 0.051318] registered taskstats version 1 [ 0.051320] Loading compiled-in X.509 certificates [ 0.052848] k3-ringacc 2b800000.ringacc: Failed to get MSI domain [ 0.052934] k3-ringacc 3c000000.ringacc: Failed to get MSI domain [ 0.053737] ti-sci 44083000.dmsc: ABI: 3.1 (firmware rev 0x0014 '20.8.7--v2020.08d (Terrific Lla') [ 0.065809] ti-sci-intr bus@100000:navss@30000000:interrupt-controller1: Interrupt Router 213 domain created [ 0.065983] ti-sci-inta 33d00000.interrupt-controller: Interrupt Aggregator domain 209 created [ 0.066537] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,20] sci-dev-id:235 [ 0.066540] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled [ 0.066543] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66346100, num_proxies:64 [ 0.067962] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:1024, gp-rings[440,150] sci-dev-id:211 [ 0.067964] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled [ 0.067967] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66346100, num_proxies:64 [ 0.068347] printk: console [ttyS2] disabled [ 0.068368] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 11, base_baud = 3000000) is a 8250 [ 0.068394] printk: console [ttyS2] enabled [ 0.068395] printk: bootconsole [ns16550a0] disabled [ 0.068709] arm-smmu-v3 36600000.smmu: ias 48-bit, oas 48-bit (features 0x00001faf) [ 0.069802] arm-smmu-v3 36600000.smmu: allocated 524288 entries for cmdq [ 0.071641] arm-smmu-v3 36600000.smmu: allocated 524288 entries for evtq [ 0.072350] arm-smmu-v3 36600000.smmu: msi_domain absent - falling back to wired irqs [ 0.073457] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010a, freq:200000000, add_val:4 pps:0 [ 0.073677] value of fuse 0 is 0x33d71bf3 [ 0.073679] value of fuse 1 is 0x0 [ 0.073681] value of fuse 2 is 0x5b5ba000 [ 0.073683] value of fuse 3 is 0x1b3b9b [ 0.073688] k3_bandgap_probe and count is 5 [ 0.073691] id is 0 and i is 0 and err is -13 [ 0.073693] id is 0 and i is 1 and err is -35 [ 0.073695] id is 0 and i is 2 and err is 0 [ 0.073697] The errors in adc code for -40C, 30C & 125C 150C respectively:: -13 -35 -28 0 [ 0.073699] slope m1::-11 and const c1::-132 [ 0.073702] slope m2::68 and const c2::2634 [ 0.073707] slope m3::7 and const c3::926 [ 0.073736] id is 1 and i is 0 and err is -17 [ 0.073738] id is 1 and i is 1 and err is -38 [ 0.073740] id is 1 and i is 2 and err is 0 [ 0.073753] id is 2 and i is 0 and err is -15 [ 0.073754] id is 2 and i is 1 and err is -38 [ 0.073756] id is 2 and i is 2 and err is 0 [ 0.073769] id is 3 and i is 0 and err is -11 [ 0.073770] id is 3 and i is 1 and err is -36 [ 0.073772] id is 3 and i is 2 and err is 0 [ 0.073785] id is 4 and i is 0 and err is -13 [ 0.073787] id is 4 and i is 1 and err is -39 [ 0.073788] id is 4 and i is 2 and err is 0 [ 0.073803] Value of CTRLMMR_WKUP_RESET_SRC_STAT Register is 0x800 [ 0.073805] high_max is 742 and low_max is 632 and regval is 0x27802e6 [ 0.174789] Value of WKUP_VTM_MISC_CTRL2 is 0x27802e6 [ 0.174791] Value of WKUP_VTM_MISC_CTRL is 0x1 [ 0.175218] mmc0: CQHCI version 5.10 [ 0.216026] mmc0: SDHCI controller on 4f80000.sdhci [4f80000.sdhci] using ADMA 64-bit [ 0.216517] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fc7100 [ 0.216910] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fc7100 [ 0.217227] omap-mailbox 31f82000.mailbox: omap mailbox rev 0x66fc7100 [ 0.217572] omap-mailbox 31f83000.mailbox: omap mailbox rev 0x66fc7100 [ 0.217871] omap-mailbox 31f84000.mailbox: omap mailbox rev 0x66fc7100 [ 0.218587] ti-udma 285c0000.dma-controller: Channels: 26 (tchan: 13, rchan: 13, gp-rflow: 8) [ 0.220292] ti-udma 31150000.dma-controller: Channels: 84 (tchan: 42, rchan: 42, gp-rflow: 16) [ 0.222503] hctosys: unable to open rtc device (rtc0) [ 0.228318] Waiting for root device PARTUUID=00000000-02... [ 0.272168] random: fast init done [ 0.273298] mmc0: new DDR MMC card at address 0001 [ 0.273653] mmcblk0: mmc0:0001 MMC32G 29.1 GiB [ 0.273817] mmcblk0boot0: mmc0:0001 MMC32G partition 1 4.00 MiB [ 0.273986] mmcblk0boot1: mmc0:0001 MMC32G partition 2 4.00 MiB [ 0.274081] mmcblk0rpmb: mmc0:0001 MMC32G partition 3 4.00 MiB, chardev (240:0) [ 0.282095] mmcblk0: p1 p2 p3 p4 < p5 p6 p7 p8 p9 > [ 0.292521] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem [ 0.292525] EXT4-fs (mmcblk0p2): write access will be enabled during recovery [ 0.791973] EXT4-fs (mmcblk0p2): orphan cleanup on readonly fs [ 0.792298] EXT4-fs (mmcblk0p2): 4 orphan inodes deleted [ 0.792300] EXT4-fs (mmcblk0p2): recovery complete [ 0.800405] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 0.800445] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 0.801000] devtmpfs: mounted [ 0.801311] Freeing unused kernel memory: 1664K [ 0.813233] Run /sbin/init as init process [ 0.931468] systemd[1]: System time before build time, advancing clock. [ 0.962491] NET: Registered protocol family 10 [ 0.962871] Segment Routing with IPv6 [ 0.974490] systemd[1]: systemd 246 running in system mode. (-PAM -AUDIT -SELINUX -IMA -APPARMOR -SMACK -SYSVINIT -UTMP -LIBCRYPTSETUP +GCRYPT +GNUTLS -ACL +XZ -LZ4 -ZSTD -SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN -PCRE2 default-hierarchy=hybrid) [ 0.974655] systemd[1]: Detected architecture arm64. [ 1.013669] systemd[1]: Set hostname to <buildroot>. [ 1.082162] systemd[1]: multi-user.target: Wants dependency dropin /etc/systemd/system/multi-user.target.wants/daemon_watch.service_original is not a symlink, ignoring. [ 1.099920] systemd[1]: sysinit.target: Wants dependency dropin /etc/systemd/system/sysinit.target.wants/daemon_watch.service is not a symlink, ignoring. [ 1.141290] systemd[1]: Configuration file /etc/systemd/system/daemon_watch.service is marked executable. Please remove executable permission bits. Proceeding anyway. [ 1.141653] systemd[1]: /etc/systemd/system/daemon_watch.service:10: Support for option SysVStartPriority= has been removed and it is ignored [ 1.141832] systemd[1]: Configuration file /etc/systemd/system/boot_test.service is marked executable. Please remove executable permission bits. Proceeding anyway. [ 1.141838] systemd[1]: Configuration file /etc/systemd/system/boot_test.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. [ 1.142196] systemd[1]: /etc/systemd/system/boot_test.service:12: Support for option SysVStartPriority= has been removed and it is ignored [ 1.150897] systemd[1]: Queued start job for default target Multi-User System. [ 1.151269] random: systemd: uninitialized urandom read (16 bytes read) [ 1.151334] systemd[1]: system-serial\x2dgetty.slice: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. [ 1.151339] systemd[1]: (This warning is only shown for the first unit using IP firewalling.) [ 1.152467] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 1.169325] random: systemd: uninitialized urandom read (16 bytes read) [ 1.169417] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 1.185269] random: systemd: uninitialized urandom read (16 bytes read) [ 1.185340] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 1.201400] systemd[1]: Reached target Paths. [ 1.213275] systemd[1]: Reached target Remote File Systems. [ 1.225263] systemd[1]: Reached target Slices. [ 1.237283] systemd[1]: Reached target Swap. [ 1.249501] systemd[1]: Listening on Syslog Socket. [ 1.267175] systemd[1]: Condition check resulted in Journal Audit Socket being skipped. [ 1.267509] systemd[1]: Listening on Journal Socket (/dev/log). [ 1.281494] systemd[1]: Listening on Journal Socket. [ 1.293507] systemd[1]: Listening on udev Control Socket. [ 1.305409] systemd[1]: Listening on udev Kernel Socket. [ 1.319108] systemd[1]: Mounting Huge Pages File System... [ 1.335570] systemd[1]: Mounting POSIX Message Queue File System... [ 1.347934] systemd[1]: Mounting Kernel Debug File System... [ 1.361477] systemd[1]: Condition check resulted in Kernel Trace File System being skipped. [ 1.363850] systemd[1]: Mounting Temporary Directory (/tmp)... [ 1.373732] systemd[1]: Condition check resulted in /opt/gaia/test_boot_performance.sh Compatibility being skipped. [ 1.375753] systemd[1]: Starting Create list of static device nodes for the current kernel... [ 1.396241] systemd[1]: Starting Journal Service... [ 1.407967] systemd[1]: Starting Load Kernel Modules... [ 1.423407] systemd[1]: Starting Remount Root and Kernel File Systems... [ 1.436391] systemd[1]: Starting Coldplug All udev Devices... [ 1.451725] systemd[1]: Started Journal Service. [ 1.871840] k3-dsp-rproc 4d80800000.dsp: assigned reserved memory node c66-dma-memory@a7000000 [ 1.871993] k3-dsp-rproc 4d80800000.dsp: configured DSP for remoteproc mode [ 1.872130] remoteproc remoteproc0: 4d80800000.dsp is available [ 1.873322] k3-dsp-rproc 4d81800000.dsp: assigned reserved memory node c66-dma-memory@a6000000 [ 1.873491] k3-dsp-rproc 4d81800000.dsp: configured DSP for remoteproc mode [ 1.873629] remoteproc remoteproc1: 4d81800000.dsp is available [ 1.873887] k3-dsp-rproc 64800000.dsp: assigned reserved memory node c71-dma-memory@a8000000 [ 1.874092] k3-dsp-rproc 64800000.dsp: configured DSP for remoteproc mode [ 1.874134] remoteproc remoteproc2: 64800000.dsp is available [ 1.954802] platform 41000000.r5f: ti-sci processor request failed: -19 [ 1.954808] platform 41000000.r5f: ti_sci_proc_request failed, ret = -19 [ 1.954820] k3_r5_rproc bus@100000:bus@28380000:r5fss@41000000: k3_r5_core_of_init failed, ret = -19 [ 1.954823] k3_r5_rproc bus@100000:bus@28380000:r5fss@41000000: k3_r5_cluster_of_init failed, ret = -19 [ 1.956146] platform 5c00000.r5f: configured R5F for IPC-only mode [ 1.956172] platform 5c00000.r5f: assigned reserved memory node vision_apps-r5f-dma-memory@a1000000 [ 1.956259] remoteproc remoteproc3: 5c00000.r5f is available [ 1.956841] platform 5d00000.r5f: configured R5F for IPC-only mode [ 1.956866] platform 5d00000.r5f: assigned reserved memory node r5f-dma-memory@a3000000 [ 1.956976] remoteproc remoteproc4: 5d00000.r5f is available [ 2.172423] hjwang rproc_boot-2110:5d00000.r5f 0 [ 2.172432] remoteproc remoteproc4: powering up 5d00000.r5f [ 2.172439] remoteproc remoteproc4: Booting fw image j7-main-r5f0_1-fw, size 1923072 [ 2.172441] hjwang rproc_fw_boot-1663:5d00000.r5f [ 2.172443] hjwang rproc_fw_boot-1665:5d00000.r5f ret=0 [ 2.172445] hjwang rproc_fw_boot-1676:5d00000.r5f ret=0 [ 2.172447] hjwang rproc_fw_boot-1683:5d00000.r5f [ 2.172448] hjwang rproc_fw_boot-1685:5d00000.r5f [ 2.172452] hjwang rproc_fw_boot-1689:5d00000.r5f ret=0 [ 2.172507] hjwang rproc_fw_boot-1702:5d00000.r5f ret=0 [ 2.172525] hjwang rproc_fw_boot-1711:5d00000.r5f ret=0 [ 2.172526] hjwang rproc_start-1568:5d00000.r5f ret=0 [ 2.172530] hjwang rproc_start-1583:5d00000.r5f ret=0 [ 2.172533] hjwang rproc_start-1587:5d00000.r5f ret=0 [ 2.172535] hjwang rproc_start-1596:5d00000.r5f ret=0 [ 2.172583] platform 5d00000.r5f: R5F core initialized in IPC-only mode [ 2.172585] hjwang rproc_start-1606:5d00000.r5f ret=0 [ 2.172593] remoteproc4#vdev0buffer: assigned reserved memory node r5f-dma-memory@a3000000 [ 2.172655] remoteproc4#vdev0buffer: registered virtio0 (type 7) [ 2.172657] hjwang rproc_start-1615:5d00000.r5f ret=0 [ 2.172660] remoteproc remoteproc4: remote processor 5d00000.r5f is now up [ 2.172661] hjwang rproc_start-1626:5d00000.r5f ret=0 [ 2.172663] hjwang rproc_fw_boot-1720:5d00000.r5f ret=0 [ 2.221928] omap_rng 4e10000.rng: Random Number Generator ver. 241b34c [ 2.222378] virtio_rpmsg_bus virtio0: rpmsg host is online [ 2.222452] random: crng init done [ 2.222455] random: 7 urandom warning(s) missed due to ratelimiting [ 2.227604] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xd [ 2.273338] hjwang rproc_boot-2110:5c00000.r5f 0 [ 2.273347] remoteproc remoteproc3: powering up 5c00000.r5f [ 2.273353] remoteproc remoteproc3: Booting fw image j7-main-r5f0_0-fw, size 4712824 [ 2.273355] hjwang rproc_fw_boot-1663:5c00000.r5f [ 2.273357] hjwang rproc_fw_boot-1665:5c00000.r5f ret=0 [ 2.273360] hjwang rproc_fw_boot-1676:5c00000.r5f ret=0 [ 2.273361] hjwang rproc_fw_boot-1683:5c00000.r5f [ 2.273363] hjwang rproc_fw_boot-1685:5c00000.r5f [ 2.273368] hjwang rproc_fw_boot-1689:5c00000.r5f ret=0 [ 2.273423] hjwang rproc_fw_boot-1702:5c00000.r5f ret=0 [ 2.273441] hjwang rproc_fw_boot-1711:5c00000.r5f ret=0 [ 2.273443] hjwang rproc_start-1568:5c00000.r5f ret=0 [ 2.273446] hjwang rproc_start-1583:5c00000.r5f ret=0 [ 2.273450] hjwang rproc_start-1587:5c00000.r5f ret=0 [ 2.273451] hjwang rproc_start-1596:5c00000.r5f ret=0 [ 2.273482] platform 5c00000.r5f: R5F core initialized in IPC-only mode [ 2.273484] hjwang rproc_start-1606:5c00000.r5f ret=0 [ 2.273491] remoteproc3#vdev0buffer: assigned reserved memory node vision_apps-r5f-dma-memory@a1000000 [ 2.273900] virtio_rpmsg_bus virtio1: rpmsg host is online [ 2.273926] remoteproc3#vdev0buffer: registered virtio1 (type 7) [ 2.273928] hjwang rproc_start-1615:5c00000.r5f ret=0 [ 2.273931] remoteproc remoteproc3: remote processor 5c00000.r5f is now up [ 2.273933] hjwang rproc_start-1626:5c00000.r5f ret=0 [ 2.273935] hjwang rproc_fw_boot-1720:5c00000.r5f ret=0 [ 2.279221] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0xd [ 2.479095] hjwang rproc_boot-2110:4d81800000.dsp 0 [ 2.479104] remoteproc remoteproc1: powering up 4d81800000.dsp [ 2.479111] remoteproc remoteproc1: Booting fw image j7-c66_1-fw, size 11705956 [ 2.479113] hjwang rproc_fw_boot-1663:4d81800000.dsp [ 2.479115] hjwang rproc_fw_boot-1665:4d81800000.dsp ret=0 [ 2.479321] hjwang rproc_fw_boot-1676:4d81800000.dsp ret=0 [ 2.479322] hjwang rproc_fw_boot-1683:4d81800000.dsp [ 2.479324] hjwang rproc_fw_boot-1685:4d81800000.dsp [ 2.479328] hjwang rproc_fw_boot-1689:4d81800000.dsp ret=0 [ 2.479408] hjwang rproc_fw_boot-1702:4d81800000.dsp ret=0 [ 2.479425] hjwang rproc_fw_boot-1711:4d81800000.dsp ret=0 [ 2.480509] hjwang rproc_start-1568:4d81800000.dsp ret=0 [ 2.480514] hjwang rproc_start-1583:4d81800000.dsp ret=0 [ 2.480517] hjwang rproc_start-1587:4d81800000.dsp ret=0 [ 2.480519] hjwang rproc_start-1596:4d81800000.dsp ret=0 [ 2.480581] k3-dsp-rproc 4d81800000.dsp: booting DSP core using boot addr = 0xa7200000 [ 2.480909] hjwang rproc_start-1606:4d81800000.dsp ret=0 [ 2.480919] remoteproc1#vdev0buffer: assigned reserved memory node c66-dma-memory@a6000000 [ 2.481393] virtio_rpmsg_bus virtio2: rpmsg host is online [ 2.481417] remoteproc1#vdev0buffer: registered virtio2 (type 7) [ 2.481420] hjwang rproc_start-1615:4d81800000.dsp ret=0 [ 2.481423] remoteproc remoteproc1: remote processor 4d81800000.dsp is now up [ 2.481425] hjwang rproc_start-1626:4d81800000.dsp ret=0 [ 2.481427] hjwang rproc_fw_boot-1720:4d81800000.dsp ret=0 [ 2.489752] hjwang rproc_boot-2110:4d80800000.dsp 0 [ 2.489882] remoteproc remoteproc0: powering up 4d80800000.dsp [ 2.489946] remoteproc remoteproc0: Booting fw image j7-c66_0-fw, size 11705900 [ 2.489957] hjwang rproc_fw_boot-1663:4d80800000.dsp [ 2.489967] hjwang rproc_fw_boot-1665:4d80800000.dsp ret=0 [ 2.492084] hjwang rproc_fw_boot-1676:4d80800000.dsp ret=0 [ 2.492090] hjwang rproc_fw_boot-1683:4d80800000.dsp [ 2.492095] hjwang rproc_fw_boot-1685:4d80800000.dsp [ 2.492161] hjwang rproc_fw_boot-1689:4d80800000.dsp ret=0 [ 2.493028] hjwang rproc_fw_boot-1702:4d80800000.dsp ret=0 [ 2.493094] hjwang rproc_fw_boot-1711:4d80800000.dsp ret=0 [ 2.501899] hjwang rproc_start-1568:4d80800000.dsp ret=0 [ 2.501906] hjwang rproc_start-1583:4d80800000.dsp ret=0 [ 2.501910] hjwang rproc_start-1587:4d80800000.dsp ret=0 [ 2.501912] hjwang rproc_start-1596:4d80800000.dsp ret=0 [ 2.501945] k3-dsp-rproc 4d80800000.dsp: booting DSP core using boot addr = 0xa6200000 [ 2.502331] hjwang rproc_start-1606:4d80800000.dsp ret=0 [ 2.502341] remoteproc0#vdev0buffer: assigned reserved memory node c66-dma-memory@a7000000 [ 2.505077] virtio_rpmsg_bus virtio3: rpmsg host is online [ 2.505106] remoteproc0#vdev0buffer: registered virtio3 (type 7) [ 2.505109] hjwang rproc_start-1615:4d80800000.dsp ret=0 [ 2.505112] remoteproc remoteproc0: remote processor 4d80800000.dsp is now up [ 2.505114] hjwang rproc_start-1626:4d80800000.dsp ret=0 [ 2.505115] hjwang rproc_fw_boot-1720:4d80800000.dsp ret=0 [ 2.524589] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0xd [ 2.534306] virtio_rpmsg_bus virtio3: creating channel rpmsg_chrdev addr 0xd [ 2.662360] hjwang rproc_boot-2110:64800000.dsp 0 [ 2.662369] remoteproc remoteproc2: powering up 64800000.dsp [ 2.662376] remoteproc remoteproc2: Booting fw image j7-c71_0-fw, size 17699336 [ 2.662379] hjwang rproc_fw_boot-1663:64800000.dsp [ 2.662381] hjwang rproc_fw_boot-1665:64800000.dsp ret=0 [ 2.662384] hjwang rproc_fw_boot-1676:64800000.dsp ret=0 [ 2.662385] hjwang rproc_fw_boot-1683:64800000.dsp [ 2.662387] hjwang rproc_fw_boot-1685:64800000.dsp [ 2.662394] hjwang rproc_fw_boot-1689:64800000.dsp ret=0 [ 2.662447] hjwang rproc_fw_boot-1702:64800000.dsp ret=0 [ 2.662465] hjwang rproc_fw_boot-1711:64800000.dsp ret=0 [ 2.664903] hjwang rproc_start-1568:64800000.dsp ret=0 [ 2.664911] hjwang rproc_start-1583:64800000.dsp ret=0 [ 2.664916] hjwang rproc_start-1587:64800000.dsp ret=0 [ 2.664918] hjwang rproc_start-1596:64800000.dsp ret=0 [ 2.664972] k3-dsp-rproc 64800000.dsp: booting DSP core using boot addr = 0xa8200000 [ 2.665971] hjwang rproc_start-1606:64800000.dsp ret=0 [ 2.665990] remoteproc2#vdev0buffer: assigned reserved memory node c71-dma-memory@a8000000 [ 2.666415] virtio_rpmsg_bus virtio4: rpmsg host is online [ 2.666434] remoteproc2#vdev0buffer: registered virtio4 (type 7) [ 2.666436] hjwang rproc_start-1615:64800000.dsp ret=0 [ 2.666439] remoteproc remoteproc2: remote processor 64800000.dsp is now up [ 2.666440] hjwang rproc_start-1626:64800000.dsp ret=0 [ 2.666443] hjwang rproc_fw_boot-1720:64800000.dsp ret=0 [ 2.696147] virtio_rpmsg_bus virtio4: creating channel rpmsg_chrdev addr 0xd [ 2.696360] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0x15 [ 2.696450] virtio_rpmsg_bus virtio3: creating channel rpmsg_chrdev addr 0x15 [ 2.696802] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0x15 [ 2.697063] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0x15 [ 2.697182] virtio_rpmsg_bus virtio4: creating channel rpmsg_chrdev addr 0x15 [ 2.697627] virtio_rpmsg_bus virtio4: creating channel ti.ipc4.ping-pong addr 0xe [ 2.706206] virtio_rpmsg_bus virtio3: creating channel ti.ipc4.ping-pong addr 0xe [ 2.706347] virtio_rpmsg_bus virtio2: creating channel ti.ipc4.ping-pong addr 0xe [ 2.745765] EXT4-fs (mmcblk0p3): recovery complete [ 2.745774] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) [ 2.761859] EXT4-fs (mmcblk0p5): recovery complete [ 2.761869] EXT4-fs (mmcblk0p5): mounted filesystem with ordered data mode. Opts: (null) [ 2.774043] EXT4-fs (mmcblk0p7): recovery complete [ 2.774051] EXT4-fs (mmcblk0p7): mounted filesystem with ordered data mode. Opts: (null) [ 2.777868] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xe [ 2.790855] EXT4-fs (mmcblk0p9): recovery complete [ 2.790863] EXT4-fs (mmcblk0p9): mounted filesystem with ordered data mode. Opts: (null) [ 2.807491] EXT4-fs (mmcblk0p6): recovery complete [ 2.808571] EXT4-fs (mmcblk0p6): mounted filesystem with ordered data mode. Opts: (null) [ 2.814745] EXT4-fs (mmcblk0p8): recovery complete [ 2.814753] EXT4-fs (mmcblk0p8): mounted filesystem with ordered data mode. Opts: (null) [ 2.877021] virtio_rpmsg_bus virtio1: creating channel ti.ethfw.notifyservice addr 0x1e [ 2.878476] virtio_rpmsg_bus virtio1: creating channel rpmsg-kdrv addr 0x1a [ 2.879680] rpmsg-kdrv-eth-switch rpmsg-kdrv-2-mpu_1_0_ethswitch-device-0: Device info: permissions: 07FFFFFF uart_id: 6 [ 2.879686] rpmsg-kdrv-eth-switch rpmsg-kdrv-2-mpu_1_0_ethswitch-device-0: FW ver 0.1 (rev 1) 17/Aug/2021 SHA:a3cbb14d [ 2.889618] j721e-cpsw-virt-mac main_r5fss_cpsw9g_virt_mac0: virt_cpsw_nuss mac loaded [ 2.889626] j721e-cpsw-virt-mac main_r5fss_cpsw9g_virt_mac0: rdev_features:00000003 rdev_mtu:1522 flow_id:172 tx_psil_dst_id:4A00 [ 2.889630] j721e-cpsw-virt-mac main_r5fss_cpsw9g_virt_mac0: local_mac_addr:00:00:00:00:00:00 rdev_mac_addr:70:ff:76:1d:92:c1 [ 3.375563] j721e-cpsw-virt-mac main_r5fss_cpsw9g_virt_mac0: virt_cpsw_nuss mac started [ 3.400451] 8021q: 802.1Q VLAN Support v1.8 [ 4.183927] virtio_rpmsg_bus virtio1: creating channel ti.ipc4.ping-pong addr 0xe [ 16.002934] spi-nor spi0.0: Unknown command extension type [ 16.002950] spi-nor spi0.0: Unknown command extension type [ 16.016625] cadence-qspi 47040000.spi: PHY calibration failed: -2 [ 16.016632] spi-nor spi0.0: mt35xu256aba (32768 Kbytes) [ 16.016648] 19 cmdlinepart partitions found on MTD device 47040000.spi.0 [ 16.016650] Creating 19 MTD partitions on "47040000.spi.0": [ 16.016655] 0x000000000000-0x000000080000 : "ospi.sbl" [ 16.025989] 0x000000080000-0x000000100000 : "ospi.tifs_a" [ 16.045658] 0x000000100000-0x000000180000 : "ospi.tifs_b" [ 16.061797] 0x000000180000-0x000000580000 : "ospi.mcufw_a" [ 16.077681] 0x000000580000-0x000000980000 : "ospi.mcufw_b" [ 16.097778] 0x000000980000-0x000000b80000 : "ospi.atf_optee_a" [ 16.117646] 0x000000b80000-0x000000d80000 : "ospi.atf_optee_b" [ 16.137688] 0x000000d80000-0x000000e80000 : "ospi.u-boot-spl_a" [ 16.153676] 0x000000e80000-0x000000f80000 : "ospi.u-boot-spl_b" [ 16.169645] 0x000000f80000-0x000001180000 : "ospi.u-boot_a" [ 16.185667] 0x000001180000-0x000001380000 : "ospi.u-boot_b" [ 16.201675] 0x000001380000-0x0000013a0000 : "ospi.misc_a" [ 16.221662] 0x0000013a0000-0x0000013c0000 : "ospi.misc_b" [ 16.237639] 0x0000013c0000-0x0000013e0000 : "ospi.factory" [ 16.253665] 0x0000013e0000-0x000001400000 : "ospi.safe_a" [ 16.277706] 0x000001400000-0x000001420000 : "ospi.safe_b" [ 16.293646] 0x000001420000-0x000001620000 : "ospi.mcudata" [ 16.317787] 0x000001620000-0x000001660000 : "ospi.sonar_data" [ 16.333715] 0x000001660000-0x000002000000 : "ospi.reserved"
root@buildroot:~# [2021-08-19 16:22:46.649] root@buildroot:~# ls [2021-08-19 16:22:47.496] root@buildroot:~# NOTICE: BL31: v2.3():07.01.00.006-dirty [2021-08-19 16:22:52.334] NOTICE: BL31: Built : 03:49:38, Jan 25 2021 [2021-08-19 16:22:52.414] [2021-08-19 16:22:52.414] U-Boot SPL 2020.01 (Aug 19 2021 - 15:56:43 +0800) [2021-08-19 16:22:52.429] K3_PRIMARY_BOOTMODE bootmode = 0x3 [2021-08-19 16:22:52.446] spl_boot_device from SPI [2021-08-19 16:22:52.749] [2021-08-19 16:22:52.749] [2021-08-19 16:22:52.749] U-Boot 2020.01 (Aug 19 2021 - 15:56:43 +0800) [2021-08-19 16:22:52.749] [2021-08-19 16:22:52.749] 4 GiB [2021-08-19 16:22:52.781] Flash: 0 Bytes [2021-08-19 16:22:52.781] MMC: sdhci@4f80000: 0 [2021-08-19 16:22:52.927] MMC: block number 0x3500 exceeds max(0x2000) [2021-08-19 16:22:52.927] MMC: block number 0x3600 exceeds max(0x2000) [2021-08-19 16:22:52.927] *** Error - No Valid Environment Area found [2021-08-19 16:22:52.928] *** Warning - bad env area, using default environment [2021-08-19 16:22:52.928] [2021-08-19 16:22:52.928] serial@2800000 [2021-08-19 16:22:52.928] serial@2800000 [2021-08-19 16:22:52.928] serial@2800000 [2021-08-19 16:22:52.975] No ethernet found. [2021-08-19 16:22:52.991] Hit any key to stop autoboot: 2 0 [2021-08-19 16:22:53.199] => [2021-08-19 16:22:54.893] => set do env dorprocboot [2021-08-19 16:23:00.983] => em ditenv do eor dorprocboot [2021-08-19 16:23:13.914] edit: 0 [2021-08-19 16:23:16.104] => [2021-08-19 16:23:16.600] => [2021-08-19 16:23:16.759] => [2021-08-19 16:23:16.887] => prin editenv emm mmc [2021-08-19 16:23:26.190] mmcboot mmcdev mmcloados mmcrootfstype [2021-08-19 16:23:26.206] => editenv mmcrootfstype [2021-08-19 16:23:29.083] edit: ext4 rootwait loglevel=0 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 lpj=800000 [2021-08-19 16:23:34.310] => [2021-08-19 16:23:35.253] => [2021-08-19 16:23:35.397] => boot [2021-08-19 16:23:37.906] switch to partitions #0, OK [2021-08-19 16:23:37.906] mmc0(part 0) is current device [2021-08-19 16:23:37.984] SD/MMC found on device 0 [2021-08-19 16:23:37.984] ** Unrecognized filesystem type ** [2021-08-19 16:23:38.064] 16400392 bytes read in 91 ms (171.9 MiB/s) [2021-08-19 16:23:38.088] 45697 bytes read in 2 ms (21.8 MiB/s) [2021-08-19 16:23:38.088] Invalid bus 0 (err=-19) [2021-08-19 16:23:38.089] Failed to initialize SPI flash at 0:0 (error -19) [2021-08-19 16:23:38.162] ## Flattened Device Tree blob at 88000000 [2021-08-19 16:23:38.162] Booting using the fdt blob at 0x88000000 [2021-08-19 16:23:38.162] ERROR: reserving fdt memory region failed (addr=a1000000 size=100000) [2021-08-19 16:23:38.163] ERROR: reserving fdt memory region failed (addr=a1100000 size=1f00000) [2021-08-19 16:23:38.163] ERROR: reserving fdt memory region failed (addr=a3100000 size=1f00000) [2021-08-19 16:23:38.164] ERROR: reserving fdt memory region failed (addr=a5000000 size=100000) [2021-08-19 16:23:38.164] ERROR: reserving fdt memory region failed (addr=a5100000 size=700000) [2021-08-19 16:23:38.165] ERROR: reserving fdt memory region failed (addr=a5800000 size=100000) [2021-08-19 16:23:38.205] ERROR: reserving fdt memory region failed (addr=a5900000 size=700000) [2021-08-19 16:23:38.206] ERROR: reserving fdt memory region failed (addr=fdc00000 size=400000) [2021-08-19 16:23:38.206] Loading Device Tree to 000000008fef1000, end 000000008fffffff ... OK [2021-08-19 16:23:38.206] [2021-08-19 16:23:38.207] Starting kernel ... [2021-08-19 16:23:38.207] [2021-08-19 16:23:38.477] [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd080] [2021-08-19 16:23:38.521] [ 0.000000] Linux version 5.4.74-ACU-1.3.21.1 (hjwang@Tower-5810-Nvidia-Host) (gcc version 9.2.1 20191025 (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10))) #11 SMP PREEMPT Thu Aug 19 15:51:24 CST 2021 [2021-08-19 16:23:38.523] [ 0.000000] Machine model: Texas Instruments K3 J721E SoC [2021-08-19 16:23:38.523] [ 0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002800000 (options '') [2021-08-19 16:23:38.523] [ 0.000000] printk: bootconsole [ns16550a0] enabled [2021-08-19 16:23:38.524] [ 0.000000] OF: reserved mem: not enough space all defined regions. [2021-08-19 16:23:38.565] [ 0.000000] OF: reserved mem: not enough space all defined regions. [2021-08-19 16:23:38.566] [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [2021-08-19 16:23:38.566] [ 0.000000] vision_apps-r5f-dma-memory@a1000000 (0x00000000a1000000--0x00000000a1100000) overlaps with r5f-dma-memory@a1000000 (0x00000000a1000000--0x00000000a1100000) [2021-08-19 16:23:38.567] [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [2021-08-19 16:23:38.567] [ 0.000000] vision_apps-r5f-memory@a1100000 (0x00000000a1100000--0x00000000a3000000) overlaps with r5f-memory@a1100000 (0x00000000a1100000--0x00000000a2000000) [2021-08-19 16:23:38.609] [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [2021-08-19 16:23:38.610] [ 0.000000] r5f-memory@a3100000 (0x00000000a3100000--0x00000000a4000000) overlaps with vision_apps-r5f-memory@a3100000 (0x00000000a3100000--0x00000000a5000000) [2021-08-19 16:23:38.610] [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [2021-08-19 16:23:38.611] [ 0.000000] vision_apps-r5f-memory@a3100000 (0x00000000a3100000--0x00000000a5000000) overlaps with r5f-dma-memory@a4000000 (0x00000000a4000000--0x00000000a4100000) [2021-08-19 16:23:38.612] [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [2021-08-19 16:23:38.653] [ 0.000000] vision_apps-r5f-dma-memory@a5000000 (0x00000000a5000000--0x00000000a5100000) overlaps with r5f-dma-memory@a5000000 (0x00000000a5000000--0x00000000a5100000) [2021-08-19 16:23:38.654] [ 0.000000] OF: reserved mem: OVERLAP DETECTED! [2021-08-19 16:23:38.655] [ 0.000000] r5f-memory@a5100000 (0x00000000a5100000--0x00000000a6000000) overlaps with vision_apps-r5f-memory@a5100000 (0x00000000a5100000--0x00000000a5800000) [2021-08-19 16:23:38.655] [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000094000000, size 128 MiB [2021-08-19 16:23:38.697] [ 0.000000] OF: reserved mem: initialized node vision_apps-core-heap-memory@94000000, compatible id shared-dma-pool [2021-08-19 16:23:38.698] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a0000000, size 1 MiB [2021-08-19 16:23:38.698] [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a0000000, compatible id shared-dma-pool [2021-08-19 16:23:38.699] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a0100000, size 15 MiB [2021-08-19 16:23:38.699] [ 0.000000] OF: reserved mem: initialized node r5f-memory@a0100000, compatible id shared-dma-pool [2021-08-19 16:23:38.741] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a1000000, size 1 MiB [2021-08-19 16:23:38.742] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-dma-memory@a1000000, compatible id shared-dma-pool [2021-08-19 16:23:38.742] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a1000000, size 1 MiB [2021-08-19 16:23:38.742] [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a1000000, compatible id shared-dma-pool [2021-08-19 16:23:38.743] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a1100000, size 31 MiB [2021-08-19 16:23:38.786] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a1100000, compatible id shared-dma-pool [2021-08-19 16:23:38.786] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a1100000, size 15 MiB [2021-08-19 16:23:38.786] [ 0.000000] OF: reserved mem: initialized node r5f-memory@a1100000, compatible id shared-dma-pool [2021-08-19 16:23:38.787] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a2000000, size 1 MiB [2021-08-19 16:23:38.787] [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a2000000, compatible id shared-dma-pool [2021-08-19 16:23:38.830] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a2100000, size 15 MiB [2021-08-19 16:23:38.830] [ 0.000000] OF: reserved mem: initialized node r5f-memory@a2100000, compatible id shared-dma-pool [2021-08-19 16:23:38.831] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a3000000, size 1 MiB [2021-08-19 16:23:38.831] [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a3000000, compatible id shared-dma-pool [2021-08-19 16:23:38.832] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a3100000, size 15 MiB [2021-08-19 16:23:38.874] [ 0.000000] OF: reserved mem: initialized node r5f-memory@a3100000, compatible id shared-dma-pool [2021-08-19 16:23:38.874] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a3100000, size 31 MiB [2021-08-19 16:23:38.875] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a3100000, compatible id shared-dma-pool [2021-08-19 16:23:38.875] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a4000000, size 1 MiB [2021-08-19 16:23:38.876] [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a4000000, compatible id shared-dma-pool [2021-08-19 16:23:38.918] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a4100000, size 15 MiB [2021-08-19 16:23:38.918] [ 0.000000] OF: reserved mem: initialized node r5f-memory@a4100000, compatible id shared-dma-pool [2021-08-19 16:23:38.919] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5000000, size 1 MiB [2021-08-19 16:23:38.919] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-dma-memory@a5000000, compatible id shared-dma-pool [2021-08-19 16:23:38.920] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5000000, size 1 MiB [2021-08-19 16:23:38.962] [ 0.000000] OF: reserved mem: initialized node r5f-dma-memory@a5000000, compatible id shared-dma-pool [2021-08-19 16:23:38.963] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5100000, size 15 MiB [2021-08-19 16:23:38.963] [ 0.000000] OF: reserved mem: initialized node r5f-memory@a5100000, compatible id shared-dma-pool [2021-08-19 16:23:38.963] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5100000, size 7 MiB [2021-08-19 16:23:38.964] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a5100000, compatible id shared-dma-pool [2021-08-19 16:23:39.006] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5800000, size 1 MiB [2021-08-19 16:23:39.007] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-dma-memory@a5800000, compatible id shared-dma-pool [2021-08-19 16:23:39.007] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a5900000, size 7 MiB [2021-08-19 16:23:39.008] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-memory@a5900000, compatible id shared-dma-pool [2021-08-19 16:23:39.008] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a6000000, size 1 MiB [2021-08-19 16:23:39.050] [ 0.000000] OF: reserved mem: initialized node c66-dma-memory@a6000000, compatible id shared-dma-pool [2021-08-19 16:23:39.051] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a6100000, size 15 MiB [2021-08-19 16:23:39.051] [ 0.000000] OF: reserved mem: initialized node c66-memory@a6100000, compatible id shared-dma-pool [2021-08-19 16:23:39.052] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a7000000, size 1 MiB [2021-08-19 16:23:39.052] [ 0.000000] OF: reserved mem: initialized node c66-dma-memory@a7000000, compatible id shared-dma-pool [2021-08-19 16:23:39.094] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a7100000, size 15 MiB [2021-08-19 16:23:39.095] [ 0.000000] OF: reserved mem: initialized node c66-memory@a7100000, compatible id shared-dma-pool [2021-08-19 16:23:39.095] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a8000000, size 1 MiB [2021-08-19 16:23:39.096] [ 0.000000] OF: reserved mem: initialized node c71-dma-memory@a8000000, compatible id shared-dma-pool [2021-08-19 16:23:39.096] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000a8100000, size 31 MiB [2021-08-19 16:23:39.138] [ 0.000000] OF: reserved mem: initialized node c71-memory@a8100000, compatible id shared-dma-pool [2021-08-19 16:23:39.139] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000ac000000, size 32 MiB [2021-08-19 16:23:39.139] [ 0.000000] OF: reserved mem: initialized node vision_apps-dma-memory@ac000000, compatible id shared-dma-pool [2021-08-19 16:23:39.140] [ 0.000000] OF: reserved mem: initialized node vision_apps_shared-memories, compatible id dma-heap-carveout [2021-08-19 16:23:39.140] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000ce000000, size 720 MiB [2021-08-19 16:23:39.192] [ 0.000000] OF: reserved mem: initialized node vision_apps-core-heap-memory@ce000000, compatible id shared-dma-pool [2021-08-19 16:23:39.193] [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000fb000000, size 1 MiB [2021-08-19 16:23:39.193] [ 0.000000] OF: reserved mem: initialized node vision_apps-r5f-dma-memory@fb000000, compatible id shared-dma-pool [2021-08-19 16:23:39.194] [ 0.000000] cma: Failed to reserve 512 MiB [2021-08-19 16:23:39.194] [ 0.000000] psci: probing for conduit method from DT. [2021-08-19 16:23:39.237] [ 0.000000] psci: PSCIv1.1 detected in firmware. [2021-08-19 16:23:39.237] [ 0.000000] psci: Using standard PSCI v0.2 function IDs [2021-08-19 16:23:39.237] [ 0.000000] psci: Trusted OS migration not required [2021-08-19 16:23:39.237] [ 0.000000] psci: SMC Calling Convention v1.0 [2021-08-19 16:23:39.238] [ 0.000000] percpu: Embedded 2 pages/cpu s48408 r8192 d74472 u131072 [2021-08-19 16:23:39.238] [ 0.000000] Detected PIPT I-cache on CPU0 [2021-08-19 16:23:39.238] [ 0.000000] CPU features: detected: GIC system register CPU interface [2021-08-19 16:23:39.239] [ 0.000000] CPU features: detected: EL2 vector hardening [2021-08-19 16:23:39.239] [ 0.000000] Built 1 zonelists, mobility grouping off. Total pages: 27781 [2021-08-19 16:23:39.281] [ 0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 mtdparts=47040000.spi.0:512k(ospi.sbl),512k(ospi.tifs_a),512k(ospi.tifs_b),4m(ospi.mcufw_a),4m(ospi.mcufw_b),2m(ospi.atf_optee_a),2m(ospi.atf_optee_b),1m(ospi.u-boot-spl_a),1m(ospi.u-boot-spl_b),2m(ospi.u-boot_a),2m(ospi.u-boot_b),128k(ospi.misc_a),128k(ospi.misc_b),128k(ospi.factory),128k(ospi.safe_a),128k(ospi.safe_b),2m(ospi.mcudata),256k(ospi.sonar_data),10092544(ospi.reserved) root=PARTUUID=00000000-02 ro rootfstype=ext4 rootwait lpj=800000 [2021-08-19 16:23:39.335] [ 0.000000] Dentry cache hash table entries: 262144 (order: 5, 2097152 bytes, linear) [2021-08-19 16:23:39.335] [ 0.000000] Inode-cache hash table entries: 131072 (order: 4, 1048576 bytes, linear) [2021-08-19 16:23:39.336] [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [2021-08-19 16:23:39.336] [ 0.000000] software IO TLB: mapped [mem 0x90000000-0x94000000] (64MB) [2021-08-19 16:23:39.336] [ 0.000000] Memory: 2435968K/1781760K available (9406K kernel code, 784K rwdata, 3776K rodata, 1664K init, 705K bss, 18446744073708897408K reserved, 0K cma-reserved) [2021-08-19 16:23:39.379] [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [2021-08-19 16:23:39.379] [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [2021-08-19 16:23:39.380] [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=2. [2021-08-19 16:23:39.380] [ 0.000000] Tasks RCU enabled. [2021-08-19 16:23:39.380] [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [2021-08-19 16:23:39.381] [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [2021-08-19 16:23:39.423] [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [2021-08-19 16:23:39.423] [ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode [2021-08-19 16:23:39.424] [ 0.000000] GICv3: 960 SPIs implemented [2021-08-19 16:23:39.424] [ 0.000000] GICv3: 0 Extended SPIs implemented [2021-08-19 16:23:39.424] [ 0.000000] GICv3: Distributor has no Range Selector support [2021-08-19 16:23:39.425] [ 0.000000] GICv3: 16 PPIs implemented [2021-08-19 16:23:39.425] [ 0.000000] GICv3: no VLPI support, no direct LPI support [2021-08-19 16:23:39.425] [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001900000 [2021-08-19 16:23:39.470] [ 0.000000] ITS [mem 0x01820000-0x0182ffff] [2021-08-19 16:23:39.470] [ 0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS [2021-08-19 16:23:39.470] [ 0.000000] ITS@0x0000000001820000: allocated 1048576 Devices @8c0800000 (flat, esz 8, psz 64K, shr 0) [2021-08-19 16:23:39.470] [ 0.000000] ITS: using cache flushing for cmd queue [2021-08-19 16:23:39.471] [ 0.000000] GICv3: using LPI property table @0x00000008c00c0000 [2021-08-19 16:23:39.471] [ 0.000000] GIC: using cache flushing for LPI property table [2021-08-19 16:23:39.472] [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000008c00d0000 [2021-08-19 16:23:39.515] [ 0.000000] random: get_random_bytes called from start_kernel+0x2b8/0x43c with crng_init=0 [2021-08-19 16:23:39.515] [ 0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys). [2021-08-19 16:23:39.515] [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns [2021-08-19 16:23:39.516] [ 0.000001] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns [2021-08-19 16:23:39.516] [ 0.008291] Console: colour dummy device 80x25 [2021-08-19 16:23:39.516] [ 0.012850] Calibrating delay loop (skipped) preset value.. 400.00 BogoMIPS (lpj=800000) [2021-08-19 16:23:39.560] [ 0.021120] pid_max: default: 32768 minimum: 301 [2021-08-19 16:23:39.560] [ 0.025868] LSM: Security Framework initializing [2021-08-19 16:23:39.561] [ 0.030611] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [2021-08-19 16:23:39.561] [ 0.038176] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [2021-08-19 16:23:39.562] [ 0.047138] ASID allocator initialised with 32768 entries [2021-08-19 16:23:39.562] [ 0.052715] rcu: Hierarchical SRCU implementation. [2021-08-19 16:23:39.562] [ 0.057726] Platform MSI: gic-its@1820000 domain created [2021-08-19 16:23:39.605] [ 0.063244] PCI/MSI: /bus@100000/interrupt-controller@1800000/gic-its@1820000 domain created [2021-08-19 16:23:39.605] [ 0.072007] smp: Bringing up secondary CPUs ... [2021-08-19 16:23:39.606] [ 0.077242] Detected PIPT I-cache on CPU1 [2021-08-19 16:23:39.606] [ 0.077263] GICv3: CPU1: found redistributor 1 region 0:0x0000000001920000 [2021-08-19 16:23:39.606] [ 0.077273] GICv3: CPU1: using allocated LPI pending table @0x00000008c00e0000 [2021-08-19 16:23:39.607] [ 0.077296] CPU1: Booted secondary processor 0x0000000001 [0x411fd080] [2021-08-19 16:23:39.607] [ 0.077340] smp: Brought up 1 node, 2 CPUs [2021-08-19 16:23:39.607] [ 0.106684] SMP: Total of 2 processors activated. [2021-08-19 16:23:39.659] [ 0.111487] CPU features: detected: 32-bit EL0 Support [2021-08-19 16:23:39.659] [ 0.116740] CPU features: detected: CRC32 instructions [2021-08-19 16:23:39.659] [ 0.128276] CPU: All CPU(s) started at EL2 [2021-08-19 16:23:39.659] [ 0.132468] alternatives: patching kernel code [2021-08-19 16:23:39.660] [ 0.137491] devtmpfs: initialized [2021-08-19 16:23:39.660] [ 0.143182] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [2021-08-19 16:23:39.661] [ 0.153149] futex hash table entries: 512 (order: -1, 32768 bytes, linear) [2021-08-19 16:23:39.661] [ 0.160438] pinctrl core: initialized pinctrl subsystem [2021-08-19 16:23:39.710] [ 0.166165] NET: Registered protocol family 16 [2021-08-19 16:23:39.710] [ 0.171008] DMA: preallocated 256 KiB pool for atomic allocations [2021-08-19 16:23:39.710] [ 0.177483] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [2021-08-19 16:23:39.711] [ 0.189485] HugeTLB registered 16.0 GiB page size, pre-allocated 0 pages [2021-08-19 16:23:39.711] [ 0.196341] HugeTLB registered 512 MiB page size, pre-allocated 0 pages [2021-08-19 16:23:39.712] [ 0.203099] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [2021-08-19 16:23:39.712] [ 0.210934] cryptd: max_cpu_qlen set to 1000 [2021-08-19 16:23:39.756] [ 0.216866] iommu: Default domain type: Translated [2021-08-19 16:23:39.756] [ 0.221987] SCSI subsystem initialized [2021-08-19 16:23:39.756] [ 0.225920] mc: Linux media interface: v0.10 [2021-08-19 16:23:39.756] [ 0.230288] videodev: Linux video capture interface: v2.00 [2021-08-19 16:23:39.756] [ 0.235899] pps_core: LinuxPPS API ver. 1 registered [2021-08-19 16:23:39.757] [ 0.240968] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [2021-08-19 16:23:39.757] [ 0.250304] PTP clock support registered [2021-08-19 16:23:39.757] [ 0.254314] EDAC MC: Ver: 3.0.0 [2021-08-19 16:23:39.757] [ 0.257930] FPGA manager framework [2021-08-19 16:23:39.803] [ 0.261778] clocksource: Switched to clocksource arch_sys_counter [2021-08-19 16:23:39.804] [ 0.268072] VFS: Disk quotas dquot_6.6.0 [2021-08-19 16:23:39.804] [ 0.272161] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes) [2021-08-19 16:23:39.804] [ 0.281525] Carveout Heap: Exported 512 MiB at 0x00000000ae000000 [2021-08-19 16:23:39.805] [ 0.287766] thermal_sys: Registered thermal governor 'step_wise' [2021-08-19 16:23:39.805] [ 0.287768] thermal_sys: Registered thermal governor 'power_allocator' [2021-08-19 16:23:39.806] [ 0.294165] NET: Registered protocol family 2 [2021-08-19 16:23:39.806] [ 0.305515] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear) [2021-08-19 16:23:39.848] [ 0.314275] TCP established hash table entries: 16384 (order: 1, 131072 bytes, linear) [2021-08-19 16:23:39.848] [ 0.322419] TCP bind hash table entries: 16384 (order: 2, 262144 bytes, linear) [2021-08-19 16:23:39.849] [ 0.330021] TCP: Hash tables configured (established 16384 bind 16384) [2021-08-19 16:23:39.849] [ 0.336729] UDP hash table entries: 2048 (order: 0, 65536 bytes, linear) [2021-08-19 16:23:39.850] [ 0.343614] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes, linear) [2021-08-19 16:23:39.894] [ 0.350993] NET: Registered protocol family 1 [2021-08-19 16:23:39.894] [ 0.355630] RPC: Registered named UNIX socket transport module. [2021-08-19 16:23:39.895] [ 0.361686] RPC: Registered udp transport module. [2021-08-19 16:23:39.895] [ 0.366498] RPC: Registered tcp transport module. [2021-08-19 16:23:39.895] [ 0.371301] RPC: Registered tcp NFSv4.1 backchannel transport module. [2021-08-19 16:23:39.896] [ 0.377884] PCI: CLS 0 bytes, default 64 [2021-08-19 16:23:39.896] [ 0.382198] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available [2021-08-19 16:23:39.896] [ 0.391818] Initialise system trusted keyrings [2021-08-19 16:23:39.897] [ 0.396417] workingset: timestamp_bits=46 max_order=16 bucket_order=0 [2021-08-19 16:23:39.948] [ 0.404972] squashfs: version 4.0 (2009/01/31) Phillip Lougher [2021-08-19 16:23:39.948] [ 0.411183] NFS: Registering the id_resolver key type [2021-08-19 16:23:39.948] [ 0.416352] Key type id_resolver registered [2021-08-19 16:23:39.949] [ 0.420622] Key type id_legacy registered [2021-08-19 16:23:39.949] [ 0.424718] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [2021-08-19 16:23:39.949] [ 0.431660] 9p: Installing v9fs 9p2000 file system support [2021-08-19 16:23:39.950] [ 0.444199] Key type asymmetric registered [2021-08-19 16:23:39.950] [ 0.448394] Asymmetric key parser 'x509' registered [2021-08-19 16:23:39.994] [ 0.453396] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) [2021-08-19 16:23:39.995] [ 0.460955] io scheduler mq-deadline registered [2021-08-19 16:23:39.995] [ 0.465580] io scheduler kyber registered [2021-08-19 16:23:39.995] [ 0.470376] pinctrl-single 4301c000.pinmux: 94 pins, size 376 [2021-08-19 16:23:39.995] [ 0.476413] pinctrl-single 11c000.pinmux: 173 pins, size 692 [2021-08-19 16:23:39.996] [ 0.483600] k3-ringacc 2b800000.ringacc: Failed to get MSI domain [2021-08-19 16:23:39.996] [ 0.489868] k3-ringacc 3c000000.ringacc: Failed to get MSI domain [2021-08-19 16:23:39.996] [ 0.496174] ti-pat 31010000.pat: Found PAT Rev 1.0 with 16384 pages [2021-08-19 16:23:40.039] [ 0.502585] debugfs: Directory '31010000.pat' with parent 'regmap' already present! [2021-08-19 16:23:40.039] [ 0.510533] ti-pat 31011000.pat: Found PAT Rev 1.0 with 16384 pages [2021-08-19 16:23:40.040] [ 0.516947] debugfs: Directory '31011000.pat' with parent 'regmap' already present! [2021-08-19 16:23:40.040] [ 0.524863] ti-pat 31012000.pat: Found PAT Rev 1.0 with 16384 pages [2021-08-19 16:23:40.041] [ 0.531274] debugfs: Directory '31012000.pat' with parent 'regmap' already present! [2021-08-19 16:23:40.041] [ 0.539189] ti-pat 31013000.pat: Found PAT Rev 1.0 with 2048 pages [2021-08-19 16:23:40.091] [ 0.545512] debugfs: Directory '31013000.pat' with parent 'regmap' already present! [2021-08-19 16:23:40.092] [ 0.553424] ti-pat 31014000.pat: Found PAT Rev 1.0 with 2048 pages [2021-08-19 16:23:40.092] [ 0.559746] debugfs: Directory '31014000.pat' with parent 'regmap' already present! [2021-08-19 16:23:40.093] [ 0.568806] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled [2021-08-19 16:23:40.093] [ 0.579708] brd: module loaded [2021-08-19 16:23:40.093] [ 0.585507] loop: module loaded [2021-08-19 16:23:40.094] [ 0.588762] mtip32xx Version 1.3.1 [2021-08-19 16:23:40.094] [ 0.592472] sysfs: cannot create duplicate filename '/devices/platform/dma_buf_phys' [2021-08-19 16:23:40.136] [ 0.600393] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.4.74-ACU-1.3.21.1 #11 [2021-08-19 16:23:40.136] [ 0.607680] Hardware name: Texas Instruments K3 J721E SoC (DT) [2021-08-19 16:23:40.137] [ 0.613634] Call trace: [2021-08-19 16:23:40.137] [ 0.616131] dump_backtrace+0x0/0x140 [2021-08-19 16:23:40.137] [ 0.619865] show_stack+0x14/0x20 [2021-08-19 16:23:40.137] [ 0.623248] dump_stack+0xb4/0x114 [2021-08-19 16:23:40.137] [ 0.626719] sysfs_warn_dup+0x5c/0x78 [2021-08-19 16:23:40.138] [ 0.630453] sysfs_create_dir_ns+0xd8/0xf0 [2021-08-19 16:23:40.138] [ 0.634632] kobject_add_internal+0x94/0x280 [2021-08-19 16:23:40.180] [ 0.638987] kobject_add+0x90/0xf8 [2021-08-19 16:23:40.180] [ 0.642457] device_add+0xdc/0x600 [2021-08-19 16:23:40.180] [ 0.645925] platform_device_add+0xfc/0x228 [2021-08-19 16:23:40.180] [ 0.650191] platform_device_register_full+0xc8/0x140 [2021-08-19 16:23:40.181] [ 0.655351] dma_buf_phys_init+0x68/0x94 [2021-08-19 16:23:40.181] [ 0.659352] do_one_initcall+0x50/0x1a8 [2021-08-19 16:23:40.181] [ 0.663266] kernel_init_freeable+0x194/0x23c [2021-08-19 16:23:40.181] [ 0.667712] kernel_init+0x10/0xfc [2021-08-19 16:23:40.182] [ 0.671179] ret_from_fork+0x10/0x1c [2021-08-19 16:23:40.182] [ 0.674838] kobject_add_internal failed for dma_buf_phys with -EEXIST, don't try to register things with the same name in the same directory. [2021-08-19 16:23:40.226] [ 0.688473] libphy: Fixed MDIO Bus: probed [2021-08-19 16:23:40.226] [ 0.692850] tun: Universal TUN/TAP device driver, 1.6 [2021-08-19 16:23:40.226] [ 0.698176] igbvf: Intel(R) Gigabit Virtual Function Network Driver - version 2.4.0-k [2021-08-19 16:23:40.227] [ 0.706179] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [2021-08-19 16:23:40.227] [ 0.712241] sky2: driver version 1.30 [2021-08-19 16:23:40.227] [ 0.716272] VFIO - User Level meta-driver version: 0.3 [2021-08-19 16:23:40.228] [ 0.721796] i2c /dev entries driver [2021-08-19 16:23:40.228] [ 0.725541] Error: Driver 'k3-soc-thermal' is already registered, aborting... [2021-08-19 16:23:40.271] [ 0.732979] sdhci: Secure Digital Host Controller Interface driver [2021-08-19 16:23:40.272] [ 0.739293] sdhci: Copyright(c) Pierre Ossman [2021-08-19 16:23:40.272] [ 0.743834] sdhci-pltfm: SDHCI platform and OF driver helper [2021-08-19 16:23:40.272] [ 0.749889] ledtrig-cpu: registered to indicate activity on CPUs [2021-08-19 16:23:40.273] [ 0.756492] optee: probing for conduit method from DT. [2021-08-19 16:23:40.273] [ 0.761761] optee: revision 3.8 (199fca17) [2021-08-19 16:23:40.273] [ 0.762037] optee: initialized driver [2021-08-19 16:23:40.273] [ 0.770132] NET: Registered protocol family 17 [2021-08-19 16:23:40.328] [ 0.774742] 9pnet: Installing 9P2000 support [2021-08-19 16:23:40.328] [ 0.779125] Key type dns_resolver registered [2021-08-19 16:23:40.328] [ 0.783622] registered taskstats version 1 [2021-08-19 16:23:40.329] [ 0.787808] Loading compiled-in X.509 certificates [2021-08-19 16:23:40.329] [ 0.794233] k3-ringacc 2b800000.ringacc: Failed to get MSI domain [2021-08-19 16:23:40.330] [ 0.800550] k3-ringacc 3c000000.ringacc: Failed to get MSI domain [2021-08-19 16:23:40.330] [ 0.807574] ti-sci 44083000.dmsc: ABI: 3.1 (firmware rev 0x0014 '20.8.7--v2020.08d (Terrific Lla') [2021-08-19 16:23:40.330] [ 0.828668] ti-sci-intr bus@100000:navss@30000000:interrupt-controller1: Interrupt Router 213 domain created [2021-08-19 16:23:40.375] [ 0.838934] ti-sci-inta 33d00000.interrupt-controller: Interrupt Aggregator domain 209 created [2021-08-19 16:23:40.375] [ 0.848332] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,20] sci-dev-id:235 [2021-08-19 16:23:40.376] [ 0.858208] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled [2021-08-19 16:23:40.376] [ 0.864966] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66346100, num_proxies:64 [2021-08-19 16:23:40.377] [ 0.873935] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:1024, gp-rings[440,150] sci-dev-id:211 [2021-08-19 16:23:40.419] [ 0.884072] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled [2021-08-19 16:23:40.420] [ 0.890830] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66346100, num_proxies:64 [2021-08-19 16:23:40.420] [ 0.898711] printk: console [ttyS2] disabled [2021-08-19 16:23:40.420] [ 0.903093] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 11, base_baud = 3000000) is a 8250 [2021-08-19 16:23:40.421] [ 0.911828] printk: console [ttyS2] enabled [2021-08-19 16:23:40.421] [ 0.911828] printk: console [ttyS2] enabled [2021-08-19 16:23:40.421] [ 0.920262] printk: bootconsole [ns16550a0] disabled [2021-08-19 16:23:40.467] [ 0.920262] printk: bootconsole [ns16550a0] disabled [2021-08-19 16:23:40.467] [ 0.930608] arm-smmu-v3 36600000.smmu: ias 48-bit, oas 48-bit (features 0x00001faf) [2021-08-19 16:23:40.468] [ 0.939289] arm-smmu-v3 36600000.smmu: allocated 524288 entries for cmdq [2021-08-19 16:23:40.468] [ 0.947796] arm-smmu-v3 36600000.smmu: allocated 524288 entries for evtq [2021-08-19 16:23:40.469] [ 0.955187] arm-smmu-v3 36600000.smmu: msi_domain absent - falling back to wired irqs [2021-08-19 16:23:40.469] [ 0.964087] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010a, freq:200000000, add_val:4 pps:0 [2021-08-19 16:23:40.510] [ 0.972509] value of fuse 0 is 0x33d71bf3 [2021-08-19 16:23:40.511] [ 0.976509] value of fuse 1 is 0x0 [2021-08-19 16:23:40.511] [ 0.979899] value of fuse 2 is 0x5b5ba000 [2021-08-19 16:23:40.511] [ 0.983895] value of fuse 3 is 0x1b3b9b [2021-08-19 16:23:40.511] [ 0.987722] k3_bandgap_probe and count is 5 [2021-08-19 16:23:40.512] [ 0.991894] id is 0 and i is 0 and err is -13 [2021-08-19 16:23:40.512] [ 0.996237] id is 0 and i is 1 and err is -35 [2021-08-19 16:23:40.512] [ 1.000580] id is 0 and i is 2 and err is 0 [2021-08-19 16:23:40.512] [ 1.004751] The errors in adc code for -40C, 30C & 125C 150C respectively:: -13 -35 -28 0 [2021-08-19 16:23:40.553] [ 1.012907] slope m1::-11 and const c1::-132 [2021-08-19 16:23:40.554] [ 1.017165] slope m2::68 and const c2::2634 [2021-08-19 16:23:40.554] [ 1.021340] slope m3::7 and const c3::926 [2021-08-19 16:23:40.554] [ 1.025363] id is 1 and i is 0 and err is -17 [2021-08-19 16:23:40.554] [ 1.029706] id is 1 and i is 1 and err is -38 [2021-08-19 16:23:40.555] [ 1.034053] id is 1 and i is 2 and err is 0 [2021-08-19 16:23:40.555] [ 1.038235] id is 2 and i is 0 and err is -15 [2021-08-19 16:23:40.555] [ 1.042579] id is 2 and i is 1 and err is -38 [2021-08-19 16:23:40.556] [ 1.046921] id is 2 and i is 2 and err is 0 [2021-08-19 16:23:40.556] [ 1.051103] id is 3 and i is 0 and err is -11 [2021-08-19 16:23:40.556] [ 1.055446] id is 3 and i is 1 and err is -36 [2021-08-19 16:23:40.602] [ 1.059789] id is 3 and i is 2 and err is 0 [2021-08-19 16:23:40.602] [ 1.063971] id is 4 and i is 0 and err is -13 [2021-08-19 16:23:40.603] [ 1.068315] id is 4 and i is 1 and err is -39 [2021-08-19 16:23:40.603] [ 1.072658] id is 4 and i is 2 and err is 0 [2021-08-19 16:23:40.603] [ 1.076843] Value of CTRLMMR_WKUP_RESET_SRC_STAT Register is 0x800 [2021-08-19 16:23:40.603] [ 1.083008] high_max is 742 and low_max is 632 and regval is 0x27802e6 [2021-08-19 16:23:40.714] [ 1.190482] Value of WKUP_VTM_MISC_CTRL2 is 0x27802e6 [2021-08-19 16:23:40.715] [ 1.195519] Value of WKUP_VTM_MISC_CTRL is 0x1 [2021-08-19 16:23:40.715] [ 1.200396] mmc0: CQHCI version 5.10 [2021-08-19 16:23:40.746] [ 1.244770] mmc0: SDHCI controller on 4f80000.sdhci [4f80000.sdhci] using ADMA 64-bit [2021-08-19 16:23:40.792] [ 1.252966] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fc7100 [2021-08-19 16:23:40.793] [ 1.259965] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fc7100 [2021-08-19 16:23:40.793] [ 1.266830] omap-mailbox 31f82000.mailbox: omap mailbox rev 0x66fc7100 [2021-08-19 16:23:40.793] [ 1.273720] omap-mailbox 31f83000.mailbox: omap mailbox rev 0x66fc7100 [2021-08-19 16:23:40.794] [ 1.280617] omap-mailbox 31f84000.mailbox: omap mailbox rev 0x66fc7100 [2021-08-19 16:23:40.794] [ 1.288017] ti-udma 285c0000.dma-controller: Channels: 26 (tchan: 13, rchan: 13, gp-rflow: 8) [2021-08-19 16:23:40.833] [ 1.298559] ti-udma 31150000.dma-controller: Channels: 84 (tchan: 42, rchan: 42, gp-rflow: 16) [2021-08-19 16:23:40.834] [ 1.309079] hctosys: unable to open rtc device (rtc0) [2021-08-19 16:23:40.834] [ 1.319814] Waiting for root device PARTUUID=00000000-02... [2021-08-19 16:23:40.849] [ 1.348005] random: fast init done [2021-08-19 16:23:40.906] [ 1.352517] mmc0: new DDR MMC card at address 0001 [2021-08-19 16:23:40.907] [ 1.357656] mmcblk0: mmc0:0001 MMC32G 29.1 GiB [2021-08-19 16:23:40.907] [ 1.362344] mmcblk0boot0: mmc0:0001 MMC32G partition 1 4.00 MiB [2021-08-19 16:23:40.907] [ 1.368427] mmcblk0boot1: mmc0:0001 MMC32G partition 2 4.00 MiB [2021-08-19 16:23:40.908] [ 1.374421] mmcblk0rpmb: mmc0:0001 MMC32G partition 3 4.00 MiB, chardev (240:0) [2021-08-19 16:23:40.908] [ 1.389715] mmcblk0: p1 p2 p3 p4 < p5 p6 p7 p8 p9 > [2021-08-19 16:23:40.908] [ 1.405638] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [2021-08-19 16:23:40.954] [ 1.413750] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [2021-08-19 16:23:40.954] [ 1.422560] devtmpfs: mounted [2021-08-19 16:23:40.954] [ 1.425819] Freeing unused kernel memory: 1664K [2021-08-19 16:23:40.954] [ 1.437789] Run /sbin/init as init process [2021-08-19 16:23:41.079] [ 1.560348] systemd[1]: System time before build time, advancing clock. [2021-08-19 16:23:41.117] [ 1.598205] NET: Registered protocol family 10 [2021-08-19 16:23:41.117] [ 1.602994] Segment Routing with IPv6 [2021-08-19 16:23:41.118] [ 1.619060] systemd[1]: systemd 246 running in system mode. (-PAM -AUDIT -SELINUX -IMA -APPARMOR -SMACK -SYSVINIT -UTMP -LIBCRYPTSETUP +GCRYPT +GNUTLS -ACL +XZ -LZ4 -ZSTD -SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN -PCRE2 default-hierarchy=hybrid) [2021-08-19 16:23:41.155] [ 1.641018] systemd[1]: Detected architecture arm64. [2021-08-19 16:23:41.186] [2021-08-19 16:23:41.186] Welcome to Buildroot 2020.11.2! [2021-08-19 16:23:41.186] [2021-08-19 16:23:41.202] [ 1.690225] systemd[1]: Set hostname to <buildroot>. [2021-08-19 16:23:41.286] [ 1.762432] systemd[1]: multi-user.target: Wants dependency dropin /etc/systemd/system/multi-user.target.wants/daemon_watch.service_original is not a symlink, ignoring. [2021-08-19 16:23:41.319] [ 1.794991] systemd[1]: sysinit.target: Wants dependency dropin /etc/systemd/system/sysinit.target.wants/daemon_watch.service is not a symlink, ignoring. [2021-08-19 16:23:41.351] [ 1.850046] systemd[1]: Configuration file /etc/systemd/system/daemon_watch.service is marked executable. Please remove executable permission bits. Proceeding anyway. [2021-08-19 16:23:41.395] [ 1.865261] systemd[1]: /etc/systemd/system/daemon_watch.service:10: Support for option SysVStartPriority= has been removed and it is ignored [2021-08-19 16:23:41.396] [ 1.878122] systemd[1]: Configuration file /etc/systemd/system/boot_test.service is marked executable. Please remove executable permission bits. Proceeding anyway. [2021-08-19 16:23:41.397] [ 1.892702] systemd[1]: Configuration file /etc/systemd/system/boot_test.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. [2021-08-19 16:23:41.448] [ 1.908615] systemd[1]: /etc/systemd/system/boot_test.service:12: Support for option SysVStartPriority= has been removed and it is ignored [2021-08-19 16:23:41.448] [ 1.929676] systemd[1]: Queued start job for default target Multi-User System. [2021-08-19 16:23:41.449] [ 1.937266] random: systemd: uninitialized urandom read (16 bytes read) [2021-08-19 16:23:41.449] [ 1.943933] systemd[1]: system-serial\x2dgetty.slice: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. [2021-08-19 16:23:41.498] [ 1.957127] systemd[1]: (This warning is only shown for the first unit using IP firewalling.) [2021-08-19 16:23:41.498] [ 1.966770] systemd[1]: Created slice system-serial\x2dgetty.slice. [2021-08-19 16:23:41.499] [ OK ] Created slice system-serial\x2dgetty.slice. [2021-08-19 16:23:41.499] [ 1.985911] random: systemd: uninitialized urandom read (16 bytes read) [2021-08-19 16:23:41.499] [ 1.992605] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [2021-08-19 16:23:41.562] [ OK ] Started Dispatch Password �ts to Console Directory Watch. [2021-08-19 16:23:41.563] [ 2.017826] random: systemd: uninitialized urandom read (16 bytes read) [2021-08-19 16:23:41.563] [ 2.024503] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [2021-08-19 16:23:41.563] [ OK ] Started Forward Password R�uests to Wall Directory Watch. [2021-08-19 16:23:41.564] [ 2.045963] systemd[1]: Reached target Paths. [2021-08-19 16:23:41.564] [ OK ] Reached target Paths. [2021-08-19 16:23:41.564] [ 2.061837] systemd[1]: Reached target Remote File Systems. [2021-08-19 16:23:41.629] [ OK ] Reached target Remote File Systems. [2021-08-19 16:23:41.629] [ 2.077822] systemd[1]: Reached target Slices. [2021-08-19 16:23:41.629] [ OK ] Reached target Slices. [2021-08-19 16:23:41.630] [ 2.093842] systemd[1]: Reached target Swap. [2021-08-19 16:23:41.630] [ OK ] Reached target Swap. [2021-08-19 16:23:41.630] [ 2.110057] systemd[1]: Listening on Syslog Socket. [2021-08-19 16:23:41.630] [ OK ] Listening on Syslog Socket. [2021-08-19 16:23:41.689] [ 2.131585] systemd[1]: Condition check resulted in Journal Audit Socket being skipped. [2021-08-19 16:23:41.689] [ 2.139913] systemd[1]: Listening on Journal Socket (/dev/log). [2021-08-19 16:23:41.689] [ OK ] Listening on Journal Socket (/dev/log). [2021-08-19 16:23:41.690] [ 2.158038] systemd[1]: Listening on Journal Socket. [2021-08-19 16:23:41.690] [ OK ] Listening on Journal Socket. [2021-08-19 16:23:41.690] [ 2.174056] systemd[1]: Listening on udev Control Socket. [2021-08-19 16:23:41.691] [ OK ] Listening on udev Control Socket. [2021-08-19 16:23:41.691] [ 2.189967] systemd[1]: Listening on udev Kernel Socket. [2021-08-19 16:23:41.749] [ OK ] Listening on udev Kernel Socket. [2021-08-19 16:23:41.749] [ 2.207734] systemd[1]: Mounting Huge Pages File System... [2021-08-19 16:23:41.749] Mounting Huge Pages File System... [2021-08-19 16:23:41.749] [ 2.223726] systemd[1]: Mounting POSIX Message Queue File System... [2021-08-19 16:23:41.749] Mounting POSIX Message Queue File System... [2021-08-19 16:23:41.749] [ 2.247993] systemd[1]: Mounting Kernel Debug File System... [2021-08-19 16:23:41.770] Mounting Kernel Debug File System... [2021-08-19 16:23:41.770] [ 2.269998] systemd[1]: Condition check resulted in Kernel Trace File System being skipped. [2021-08-19 16:23:41.804] [ 2.280401] systemd[1]: Mounting Temporary Directory (/tmp)... [2021-08-19 16:23:41.804] Mounting Temporary Directory (/tmp)... [2021-08-19 16:23:41.805] [ 2.302252] systemd[1]: Condition check resulted in /opt/gaia/test_boot_performance.sh Compatibility being skipped. [2021-08-19 16:23:41.843] [ 2.314651] systemd[1]: Starting Create list of static device nodes for the current kernel... [2021-08-19 16:23:41.843] Starting Create list of st�odes for the current kernel... [2021-08-19 16:23:41.844] [ 2.341343] systemd[1]: Starting Journal Service... [2021-08-19 16:23:41.879] Starting Journal Service... [2021-08-19 16:23:41.879] [ 2.360756] systemd[1]: Starting Load Kernel Modules... [2021-08-19 16:23:41.879] Starting Load Kernel Modules... [2021-08-19 16:23:41.956] [ 2.384739] systemd[1]: Starting Remount Root and Kernel File Systems... [2021-08-19 16:23:41.956] Starting Remount Root and Kernel File Systems... [2021-08-19 16:23:41.956] [ 2.404009] systemd[1]: Starting Coldplug All udev Devices... [2021-08-19 16:23:41.957] Starting Coldplug All udev Devices... [2021-08-19 16:23:41.957] [ 2.424201] systemd[1]: Started Journal Service. [2021-08-19 16:23:41.957] [ OK ] Started Journal Service. [2021-08-19 16:23:41.958] [ OK ] Mounted Huge Pages File System. [2021-08-19 16:23:41.958] [ OK ] Mounted POSIX Message Queue File System. [2021-08-19 16:23:41.985] [ OK ] Mounted Kernel Debug File System. [2021-08-19 16:23:41.986] [ OK ] Mounted Temporary Directory (/tmp). [2021-08-19 16:23:42.047] [ OK ] Finished Create list of st� nodes for the current kernel. [2021-08-19 16:23:42.048] [ OK ] Finished Load Kernel Modules. [2021-08-19 16:23:42.048] [ OK ] Finished Remount Root and Kernel File Systems. [2021-08-19 16:23:42.070] Mounting Kernel Configuration File System... [2021-08-19 16:23:42.112] Starting Flush Journal to Persistent Storage... [2021-08-19 16:23:42.113] Starting Apply Kernel Variables... [2021-08-19 16:23:42.113] Starting Create Static Device Nodes in /dev... [2021-08-19 16:23:42.113] [ OK ] Mounted Kernel Configuration File System. [2021-08-19 16:23:42.161] [ OK ] Finished Flush Journal to Persistent Storage. [2021-08-19 16:23:42.162] [ OK ] Finished Coldplug All udev Devices. [2021-08-19 16:23:42.162] [ OK ] Finished Apply Kernel Variables. [2021-08-19 16:23:42.228] [ OK ] Finished Create Static Device Nodes in /dev. [2021-08-19 16:23:42.228] [ OK ] Reached target Local File Systems (Pre). [2021-08-19 16:23:42.229] Starting Rule-based Manage�for Device Events and Files... [2021-08-19 16:23:42.267] [ OK ] Started Rule-based Manager for Device Events and Files. [2021-08-19 16:23:42.315] [ 2.815719] k3-dsp-rproc 4d80800000.dsp: assigned reserved memory node c66-dma-memory@a7000000 [2021-08-19 16:23:42.377] [ OK ] Found device /dev/ttyS2. [2021-08-19 16:23:42.377] [ 2.835091] k3-dsp-rproc 4d80800000.dsp: configured DSP for remoteproc mode [2021-08-19 16:23:42.377] [ 2.847884] platform 41000000.r5f: ti-sci processor request failed: -19 [2021-08-19 16:23:42.378] [ 2.861121] k3-dsp-rproc 4d80800000.dsp: local reset is deasserted for device [2021-08-19 16:23:42.378] [ 2.865841] platform 41000000.r5f: ti_sci_proc_request failed, ret = -19 [2021-08-19 16:23:42.378] [ 2.872022] remoteproc remoteproc0: 4d80800000.dsp is available [2021-08-19 16:23:42.429] [ 2.885760] k3_r5_rproc bus@100000:bus@28380000:r5fss@41000000: k3_r5_core_of_init failed, ret = -19 [2021-08-19 16:23:42.430] [ 2.886543] k3-dsp-rproc 4d81800000.dsp: assigned reserved memory node c66-dma-memory@a6000000 [2021-08-19 16:23:42.430] [ 2.906350] k3-dsp-rproc 4d81800000.dsp: configured DSP for remoteproc mode [2021-08-19 16:23:42.431] [ 2.913994] k3-dsp-rproc 4d81800000.dsp: local reset is deasserted for device [2021-08-19 16:23:42.431] [ 2.921944] remoteproc remoteproc1: 4d81800000.dsp is available [2021-08-19 16:23:42.432] [ 2.928519] k3-dsp-rproc 64800000.dsp: assigned reserved memory node c71-dma-memory@a8000000 [2021-08-19 16:23:42.472] [ 2.931743] k3_r5_rproc bus@100000:bus@28380000:r5fss@41000000: k3_r5_cluster_of_init failed, ret = -19 [2021-08-19 16:23:42.473] [ 2.938034] k3-dsp-rproc 64800000.dsp: configured DSP for remoteproc mode [2021-08-19 16:23:42.473] [ 2.953673] remoteproc remoteproc2: 64800000.dsp is available [2021-08-19 16:23:42.582] [ 3.016409] platform 5c00000.r5f: configured R5F for remoteproc mode [2021-08-19 16:23:42.582] [ 3.028636] platform 5c00000.r5f: assigned reserved memory node vision_apps-r5f-dma-memory@a1000000 [2021-08-19 16:23:42.583] [ 3.039708] remoteproc remoteproc3: 5c00000.r5f is available [2021-08-19 16:23:42.583] [ 3.047582] platform 5d00000.r5f: configured R5F for remoteproc mode [2021-08-19 16:23:42.583] [ 3.056400] platform 5d00000.r5f: assigned reserved memory node r5f-dma-memory@a3000000 [2021-08-19 16:23:42.584] [ 3.065923] remoteproc remoteproc4: 5d00000.r5f is available [2021-08-19 16:23:42.757] [ 3.258858] hjwang rproc_boot-2110:5d00000.r5f 0 [2021-08-19 16:23:42.803] [ 3.263490] remoteproc remoteproc4: powering up 5d00000.r5f [2021-08-19 16:23:42.803] [ 3.269910] remoteproc remoteproc4: Booting fw image j7-main-r5f0_1-fw, size 1923072 [2021-08-19 16:23:42.804] [ 3.277664] hjwang rproc_fw_boot-1663:5d00000.r5f [2021-08-19 16:23:42.804] [ 3.282753] hjwang rproc_fw_boot-1665:5d00000.r5f ret=0 [2021-08-19 16:23:42.804] [ 3.288107] hjwang k3_r5_rproc_prepare-396:5d00000.r5f [2021-08-19 16:23:42.804] [ 3.293588] hjwang k3_r5_rproc_prepare-399:5d00000.r5f [2021-08-19 16:23:42.805] [ 3.299141] hjwang k3_r5_rproc_prepare-407:5d00000.r5f [2021-08-19 16:23:42.805] [ 3.304369] hjwang k3_r5_rproc_prepare-413:5d00000.r5f [2021-08-19 16:23:42.824] [ 3.309590] hjwang k3_r5_rproc_prepare-425:5d00000.r5f