TDA4VE-Q1: TDA4-S2: mmc0: running CQE recovery

Part Number: TDA4VE-Q1

Tool/software:

Hi TI experts,

Now i see this error msg 'mmc0: running CQE recovery' on my board.

i use 9.2 SDK to build my soft on TDA4VEco platform.

i find that emmc is run on hs400 mode. i also modify it to hs200 mode. but the issue is the same.

i use emmcboot mode.

Is there anything to modify on this issue?

Thanks!

  • add log file.

    .

    20240903-112938---emmcboot2.log
    OTICE:  BL31: v2.10.0(release):DEVELOP-2024074-33-gc488e19d5
    NOTICE:  BL31: Built : 14:13:17, Jul 24 2024
    ERROR:   Timeout waiting for thread SP_RESPONSE to fill
    ERROR:   Thread SP_RESPONSE verification failed (-60)
    ERROR:   Message receive failed (-60)
    ERROR:   Failed to get response (-60)
    ERROR:   Transfer send failed (-60)
    I/TC: 
    I/TC: OP-TEE version: e838159dd (gcc version 11.3.1 20220712 (Arm GNU Toolchain 11.3.Rel1)) #1 Wed Sep  4 03:03:53 UTC 2024 aarch64
    I/TC: WARNING: This OP-TEE configuration might be insecure!
    I/TC: WARNING: Please check https://optee.readthedocs.io/en/latest/architecture/porting_guidelines.html
    I/TC: Primary CPU initializing
    I/TC: SYSFW ABI: 3.1 (firmware rev 0x0009 '9.2.4--v09.02.04 (Kool Koala)')
    I/TC: HUK Initialized
    I/TC: Activated SA2UL device
    I/TC: Fixing SA2UL firewall owner for GP device
    I/TC: Enabled firewalls for SA2UL TRNG device
    I/TC: SA2UL TRNG initialized
    I/TC: SA2UL Drivers initialized
    I/TC: Primary CPU switching to normal world boot
    
    U-Boot SPL 2023.04 MV_BUILD_TAG: DEVELOP-20240828-4-ge838159dd_v1.0 (Sep 04 2024 - 11:02:38 +0800)
    SYSFW ABI: 3.1 (firmware rev 0x0009 '9.2.4--v09.02.04 (Kool Koala)')
    mv_info: [board_init_r:757]: Enter... 
    mv_info: [__get_primary_bootmedia:315]: bootmode:17 
    Trying to boot from MMC1
    MV_INFO: 0x47000004: 0x4
    MV_INFO: 0x47000004: 0x4
    mv_info: [spl_mmc_load:446] boot_mode:3 
    load_device_info_part success
    mv_info: backup_flag_init:312: update_flag:0x1, boot_flag:0x0 
    mv_info: backup_flag_init:368: backup flag init successed in uboot
    [spl_mmc_load:475] ######start_flag:0x0 
    
    
    U-Boot 2023.04 MV_BUILD_TAG: DEVELOP-20240828-4-ge838159dd_v1.0 (Sep 04 2024 - 11:02:38 +0800)
    
    SoC:   J721S2 SR1.0 GP
    DRAM:  2 GiB (effective 3 GiB)
    Core:  83 devices, 31 uclasses, devicetree: separate
    Flash: 0 Bytes
    MMC:   mmc@4f80000: 0, mmc@4fb0000: 1
    mv_info: env_load:256: There is no place in the eMMC to load env, return.
    In:    serial@2880000
    Out:   serial@2880000
    Err:   serial@2880000
    Hit any key to stop autoboot:  0 
    mv_info: do_mmc_dev:609: using emmc now, return.
    mv_info: do_mmc_rescan:560: using emmc now, return.
    load_device_info_part success
    mv_info: backup_flag_init:312: update_flag:0x1, boot_flag:0x0 
    mv_info: do_checkout_bootmedia:512:  boot from ospi + eMMC, start_flag:0 
    mv_info: do_checkout_bootmedia:520: set get_kern_mmc to uda p2
    ## Error: "main_cpsw0_qsgmii_phyinit" not defined
    k3_r5f_rproc r5f@41000000: Core 1 is already in use. No rproc commands work
    Failed to load '/lib/firmware/j721s2-mcu-r5f0_1-fw'
    5731688 bytes read in 35 ms (156.2 MiB/s) ->/lib/firmware/j721s2-main-r5f0_0-fw
    Load Remote Processor 2 with data@addr=0x82000000 5731688 bytes: Success!
    2363992 bytes read in 24 ms (93.9 MiB/s) ->/lib/firmware/j721s2-main-r5f0_1-fw
    Load Remote Processor 3 with data@addr=0x82000000 2363992 bytes: Success!
    Failed to load '/lib/firmware/j721s2-main-r5f1_0-fw'
    Failed to load '/lib/firmware/j721s2-main-r5f1_1-fw'
    25150728 bytes read in 88 ms (272.6 MiB/s) ->/lib/firmware/j721s2-c71_0-fw
    Load Remote Processor 6 with data@addr=0x82000000 25150728 bytes: Success!
    11748168 bytes read in 50 ms (224.1 MiB/s) ->/lib/firmware/j721s2-c71_1-fw
    Load Remote Processor 7 with data@addr=0x82000000 11748168 bytes: Success!
    mv_info: do_mmc_dev:609: using emmc now, return.
    
    MMC read: dev # 0, block # 22528, count 51200 ... 51200 blocks read: OK
    97248 bytes read in 17 ms (5.5 MiB/s) ->/boot/dtb/ti/k3-j721s2-common-proc-board.dtb
    Working FDT set to 88000000
    12159 bytes read in 17 ms (698.2 KiB/s) ->/boot/dtb/ti/k3-j721s2-vision-apps.dtbo
    ## Flattened Device Tree blob at 88000000
       Booting using the fdt blob at 0x88000000
    Working FDT set to 88000000
    ERROR: reserving fdt memory region failed (addr=880000000 size=17c00000 flags=4)
       Loading Device Tree to 000000008fee5000, end 000000008fffffff ... OK
    Working FDT set to 8fee5000
    
    Starting kernel ...
    
    [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd080]
    [    0.000000] Linux version 6.1.80 (xiejiancheng@motovis --^O^--MV_VER: DEVELOP-20240828-4-ge838159dd_v1.0-----) (aarch64-oe-linux-gcc (GCC) 11.4.0, GNU ld (GNU Binutils) 2.38.20220708) #1 SMP PREEMPT Wed Sep  4 10:58:39 CST 2024
    [    0.000000] Machine model: Texas Instruments J721S2 EVM
    [    0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002880000 (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 32 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-rtos-ipc-memory-region@a8000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000aa000000, size 96 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-dma-memory@aa000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000b0000000, size 1 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-c71-dma-memory@b0000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000b0100000, size 95 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-c71_0-memory@b0100000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000b6000000, size 1 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-c71_1-dma-memory@b6000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000b6100000, size 31 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-c71_1-memory@b6100000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000b8000000, size 64 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-core-heap-memory-lo@b8000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000e0000000, size 32 MiB
    [    0.000000] OF: reserved mem: initialized node vision_apps_shmipc_shared-memories@e0000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000e2000000, size 8 MiB
    [    0.000000] OF: reserved mem: initialized node vision_apps_mcu2_0_log_shared-memories@e2000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000e2800000, size 8 MiB
    [    0.000000] OF: reserved mem: initialized node vision_apps_mcu3_0_log_shared-memories@e2800000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000e3000000, size 1 MiB
    [    0.000000] OF: reserved mem: initialized node ddr_update_ota_mem-buffers@e3000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000fb100400, size 0 MiB
    [    0.000000] OF: reserved mem: initialized node ddr-update-rx-fifo-region-memories@fb100400, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000fb102400, size 0 MiB
    [    0.000000] OF: reserved mem: initialized node ddr-update-tx-fifo-region-memories@fb102400, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x00000000fb200400, size 12 MiB
    [    0.000000] OF: reserved mem: initialized node ddr_update_norflash_shm_region_memories@fb200400, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created DMA memory pool at 0x0000000880000000, size 380 MiB
    [    0.000000] OF: reserved mem: initialized node vision-apps-core-heap-memory-hi@880000000, compatible id shared-dma-pool
    [    0.000000] Reserved memory: created CMA memory pool at 0x0000000897c00000, size 128 MiB
    [    0.000000] OF: reserved mem: initialized node linux-cma-buffers@897c00000, compatible id shared-dma-pool
    [    0.000000] OF: reserved mem: initialized node vision_apps_shared-memories, compatible id dma-heap-carveout
    [    0.000000] Zone ranges:
    [    0.000000]   DMA      [mem 0x0000000080000000-0x00000000ffffffff]
    [    0.000000]   DMA32    empty
    [    0.000000]   Normal   [mem 0x0000000100000000-0x00000008bfffffff]
    [    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-0x00000000bbffffff]
    [    0.000000]   node   0: [mem 0x00000000bc000000-0x00000000e1ffffff]
    [    0.000000]   node   0: [mem 0x00000000e2000000-0x00000000e30fffff]
    [    0.000000]   node   0: [mem 0x00000000e3100000-0x00000000fb0fffff]
    [    0.000000]   node   0: [mem 0x00000000fb101000-0x00000000fb103fff]
    [    0.000000]   node   0: [mem 0x00000000fb105000-0x00000000fb1fffff]
    [    0.000000]   node   0: [mem 0x00000000fb201000-0x00000000fbdfffff]
    [    0.000000]   node   0: [mem 0x00000000fbe01000-0x00000000ffffffff]
    [    0.000000]   node   0: [mem 0x0000000880000000-0x0000000897bfffff]
    [    0.000000]   node   0: [mem 0x0000000897c00000-0x00000008bfffffff]
    [    0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000008bfffffff]
    [    0.000000] On node 0, zone DMA: 1 pages in unavailable ranges
    [    0.000000] On node 0, zone DMA: 1 pages in unavailable ranges
    [    0.000000] On node 0, zone DMA: 1 pages in unavailable ranges
    [    0.000000] On node 0, zone DMA: 1 pages in unavailable ranges
    [    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.4
    [    0.000000] percpu: Embedded 20 pages/cpu s41064 r8192 d32664 u81920
    [    0.000000] Detected PIPT I-cache on CPU0
    [    0.000000] CPU features: detected: GIC system register CPU interface
    [    0.000000] CPU features: detected: Spectre-v3a
    [    0.000000] CPU features: detected: Spectre-BHB
    [    0.000000] CPU features: detected: ARM erratum 1742098
    [    0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
    [    0.000000] alternatives: applying boot alternatives
    [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 774140
    [    0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02880000 root=PARTUUID=7b059277-05f9-42f8-99d9-468d62882432 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: area num 2.
    [    0.000000] software IO TLB: mapped [mem 0x00000000f7100000-0x00000000fb100000] (64MB)
    [    0.000000] Memory: 1412116K/3145712K available (9728K kernel code, 1204K rwdata, 3264K rodata, 1792K init, 417K bss, 1602524K reserved, 131072K 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]  Tracing 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] Root IRQ handler: gic_handle_irq
    [    0.000000] GICv3: GICv3 features: 16 PPIs
    [    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 @80400000 (flat, esz 8, psz 64K, shr 0)
    [    0.000000] ITS: using cache flushing for cmd queue
    [    0.000000] GICv3: using LPI property table @0x00000000fbe30000
    [    0.000000] GIC: using cache flushing for LPI property table
    [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000000fbe40000
    [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
    [    0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys).
    [    0.000000] clocksource: arch_sys_counter: mask: 0x3ffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns
    [    0.000000] sched_clock: 58 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
    [    0.008408] Console: colour dummy device 80x25
    [    0.012983] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
    [    0.023654] pid_max: default: 32768 minimum: 301
    [    0.028390] LSM: Security Framework initializing
    [    0.033166] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
    [    0.040738] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
    [    0.049604] cblist_init_generic: Setting adjustable number of callback queues.
    [    0.057013] cblist_init_generic: Setting shift to 1 and lim to 1.
    [    0.063277] cblist_init_generic: Setting adjustable number of callback queues.
    [    0.070665] cblist_init_generic: Setting shift to 1 and lim to 1.
    [    0.076980] rcu: Hierarchical SRCU implementation.
    [    0.081881] rcu:     Max phase no-delay instances is 1000.
    [    0.087396] Platform MSI: msi-controller@1820000 domain created
    [    0.093613] PCI/MSI: /bus@100000/interrupt-controller@1800000/msi-controller@1820000 domain created
    [    0.103039] EFI services will not be available.
    [    0.107790] smp: Bringing up secondary CPUs ...
    I/TC: Secondary CPU 1 initializing
    I/TC: Secondary CPU 1 switching to normal world boot
    [    0.120860] Detected PIPT I-cache on CPU1
    [    0.120938] GICv3: CPU1: found redistributor 1 region 0:0x0000000001920000
    [    0.120952] GICv3: CPU1: using allocated LPI pending table @0x00000000fbe50000
    [    0.120985] CPU1: Booted secondary processor 0x0000000001 [0x411fd080]
    [    0.121046] smp: Brought up 1 node, 2 CPUs
    [    0.150397] SMP: Total of 2 processors activated.
    [    0.155201] CPU features: detected: 32-bit EL0 Support
    [    0.160456] CPU features: detected: CRC32 instructions
    [    0.165733] CPU: All CPU(s) started at EL2
    [    0.169915] alternatives: applying system-wide alternatives
    [    0.176511] devtmpfs: initialized
    [    0.185659] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
    [    0.195644] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
    [    0.204612] pinctrl core: initialized pinctrl subsystem
    [    0.210332] DMI not present or invalid.
    [    0.214594] NET: Registered PF_NETLINK/PF_ROUTE protocol family
    [    0.221191] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
    [    0.228460] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
    [    0.236422] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
    [    0.244550] audit: initializing netlink subsys (disabled)
    [    0.250187] audit: type=2000 audit(0.160:1): state=initialized audit_enabled=0 res=1
    [    0.250402] thermal_sys: Registered thermal governor 'step_wise'
    [    0.258109] thermal_sys: Registered thermal governor 'power_allocator'
    [    0.264339] cpuidle: using governor menu
    [    0.275092] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
    [    0.282057] ASID allocator initialised with 65536 entries
    [    0.293446] platform a40000.pinctrl: Fixed dependency cycle(s) with /bus@100000/pinctrl@a40000/mcu-cpsw-cpts
    [    0.304894] KASLR disabled due to lack of seed
    [    0.311942] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
    [    0.318888] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
    [    0.325291] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
    [    0.332225] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
    [    0.338626] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
    [    0.345560] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
    [    0.351961] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
    [    0.358894] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
    [    0.366023] k3-chipinfo 43000014.chipid: Family:J721S2 rev:SR1.0 JTAGID[0x0bb7502f] Detected
    [    0.375691] iommu: Default domain type: Translated 
    [    0.380676] iommu: DMA domain TLB invalidation policy: strict mode 
    [    0.387221] SCSI subsystem initialized
    [    0.391241] usbcore: registered new interface driver usbfs
    [    0.396868] usbcore: registered new interface driver hub
    [    0.402307] usbcore: registered new device driver usb
    [    0.407662] pps_core: LinuxPPS API ver. 1 registered
    [    0.412737] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.422078] PTP clock support registered
    [    0.426153] EDAC MC: Ver: 3.0.0
    [    0.430327] clocksource: Switched to clocksource arch_sys_counter
    [    0.436700] VFS: Disk quotas dquot_6.6.0
    [    0.440732] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
    [    0.450785] Carveout Heap: Exported 512 MiB at 0x00000008a0000000
    [    0.457089] NET: Registered PF_INET protocol family
    [    0.462236] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
    [    0.471296] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
    [    0.480077] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
    [    0.488001] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
    [    0.496201] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
    [    0.504261] TCP: Hash tables configured (established 32768 bind 32768)
    [    0.511050] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
    [    0.517968] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
    [    0.525408] NET: Registered PF_UNIX/PF_LOCAL protocol family
    [    0.531219] NET: Registered PF_XDP protocol family
    [    0.536122] PCI: CLS 0 bytes, default 64
    [    0.540547] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
    [    0.549706] Initialise system trusted keyrings
    [    0.554404] workingset: timestamp_bits=46 max_order=19 bucket_order=0
    [    0.562903] squashfs: version 4.0 (2009/01/31) Phillip Lougher
    [    0.588359] Key type asymmetric registered
    [    0.592546] Asymmetric key parser 'x509' registered
    [    0.597556] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
    [    0.605236] io scheduler mq-deadline registered
    [    0.609884] io scheduler kyber registered
    [    0.615921] pinctrl-single 4301c000.pinctrl: 13 pins, size 52
    [    0.621950] pinctrl-single 4301c038.pinctrl: 11 pins, size 44
    [    0.627947] pinctrl-single 4301c068.pinctrl: 72 pins, size 288
    [    0.634065] pinctrl-single 4301c190.pinctrl: 1 pins, size 4
    [    0.639894] pinctrl-single 11c000.pinctrl: 72 pins, size 288
    [    0.646248] pinctrl-single a40000.pinctrl: 512 pins, size 2048
    [    0.655413] Serial: 8250/16550 driver, 12 ports, IRQ sharing enabled
    [    0.666228] loop: module loaded
    [    0.670193] megasas: 07.719.03.00-rc1
    [    0.675116] tun: Universal TUN/TAP device driver, 1.6
    [    0.680704] VFIO - User Level meta-driver version: 0.3
    [    0.686389] usbcore: registered new interface driver usb-storage
    [    0.693425] sdhci: Secure Digital Host Controller Interface driver
    [    0.699754] sdhci: Copyright(c) Pierre Ossman
    [    0.704307] sdhci-pltfm: SDHCI platform and OF driver helper
    [    0.710283] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
    [    0.717016] usbcore: registered new interface driver usbhid
    [    0.722711] usbhid: USB HID core driver
    [    0.727126] optee: probing for conduit method.
    I/TC: Reserved shared memory is enabled
    I/TC: Dynamic shared memory is enabled
    I/TC: Normal World virtualization support is disabled
    I/TC: Asynchronous notifications are disabled
    [    0.731686] optee: revision 3.20 (e838159d)
    [    0.748130] optee: dynamic shared memory is enabled
    [    0.757615] optee: initialized driver
    [    0.762090] Initializing XFRM netlink socket
    [    0.766492] NET: Registered PF_PACKET protocol family
    [    0.771671] Key type dns_resolver registered
    [    0.776257] registered taskstats version 1
    [    0.780464] Loading compiled-in X.509 certificates
    [    0.789558] ti-sci 44083000.system-controller: ABI: 3.1 (firmware rev 0x0009 '9.2.4--v09.02.04 (Kool Koala)')
    [    0.817190] omap_i2c 2000000.i2c: bus 0 rev0.12 at 400 kHz
    [    0.823033] ti-sci-intr 42200000.interrupt-controller: Interrupt Router 125 domain created
    [    0.831580] ti-sci-intr bus@100000:interrupt-controller@a00000: Interrupt Router 148 domain created
    [    0.840919] ti-sci-intr 310e0000.interrupt-controller: Interrupt Router 227 domain created
    [    0.849590] ti-sci-inta 33d00000.msi-controller: Interrupt Aggregator domain 265 created
    [    0.860056] ti-udma 311a0000.dma-controller: Number of rings: 48
    [    0.866805] ti-udma 311a0000.dma-controller: Channels: 24 (bchan: 0, tchan: 8, rchan: 16)
    [    0.876031] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,20] sci-dev-id:272
    [    0.885919] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled
    [    0.892678] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66349100, num_proxies:64
    [    0.901496] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:1024, gp-rings[878,128] sci-dev-id:259
    [    0.911660] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled
    [    0.918420] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66349100, num_proxies:64
    [    0.926379] printk: console [ttyS2] disabled
    [    0.930782] 2880000.serial: ttyS2 at MMIO 0x2880000 (irq = 213, base_baud = 3000000) is a 8250
    [    0.939632] printk: console [ttyS2] enabled
    [    0.939632] printk: console [ttyS2] enabled
    [    0.948078] printk: bootconsole [ns16550a0] disabled
    [    0.948078] printk: bootconsole [ns16550a0] disabled
    [    0.958732] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA02102, cpsw version 0x6BA82102 Ports: 2 quirks:00000000
    [    0.971594] am65-cpsw-nuss 46000000.ethernet: initialized cpsw ale version 1.4
    [    0.978804] am65-cpsw-nuss 46000000.ethernet: ALE Table size 64
    [    0.985029] pps pps0: new PPS source ptp0
    [    0.989244] am65-cpsw-nuss 46000000.ethernet: CPTS ver 0x4e8a010b, freq:500000000, add_val:1 pps:1
    [    0.999283] am65-cpsw-nuss c200000.ethernet: initializing am65 cpsw nuss version 0x6BA02102, cpsw version 0x6BA82102 Ports: 2 quirks:00000000
    [    1.012056] am65-cpsw-nuss c200000.ethernet: Use random MAC address
    [    1.018313] am65-cpsw-nuss c200000.ethernet: initialized cpsw ale version 1.4
    [    1.025431] am65-cpsw-nuss c200000.ethernet: ALE Table size 64
    [    1.031597] am65-cpsw-nuss c200000.ethernet: CPTS ver 0x4e8a010b, freq:200000000, add_val:4 pps:0
    [    1.041605] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010c, freq:200000000, add_val:4 pps:0
    [    1.051232] mmc0: CQHCI version 5.10
    [    1.057701] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fca100
    [    1.064529] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fca100
    [    1.071330] omap-mailbox 31f82000.mailbox: omap mailbox rev 0x66fca100
    [    1.078110] omap-mailbox 31f84000.mailbox: omap mailbox rev 0x66fca100
    [    1.086655] ti-udma 285c0000.dma-controller: Channels: 26 (tchan: 13, rchan: 13, gp-rflow: 8)
    [    1.095412] mmc0: SDHCI controller on 4f80000.mmc [4f80000.mmc] using ADMA 64-bit
    [    1.097669] ti-udma 31150000.dma-controller: Channels: 60 (tchan: 30, rchan: 30, gp-rflow: 16)
    [    1.114363] davinci_mdio 46000f00.mdio: Configuring MDIO in manual mode
    [    1.158370] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
    [    1.166451] mdio_bus 46000f00.mdio: MDIO device at address 31 is missing.
    [    1.173416] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA02102, cpsw version 0x6BA82102 Ports: 2 quirks:00000000
    [    1.186717] am65-cpsw-nuss 46000000.ethernet: initialized cpsw ale version 1.4
    [    1.194018] am65-cpsw-nuss 46000000.ethernet: ALE Table size 64
    [    1.200901] pps pps0: new PPS source ptp1
    [    1.205393] am65-cpsw-nuss 46000000.ethernet: CPTS ver 0x4e8a010b, freq:500000000, add_val:1 pps:1
    [    1.215739] am65-cpsw-nuss 46000000.ethernet: set new flow-id-base 48
    [    1.223672] davinci_mdio c200f00.mdio: Configuring MDIO in manual mode
    [    1.256057] mmc0: Command Queue Engine enabled
    [    1.260508] mmc0: new HS400 MMC card at address 0001
    [    1.265882] mmcblk0: mmc0:0001 A8A398 7.28 GiB 
    [    1.270380] davinci_mdio c200f00.mdio: davinci mdio revision 9.7, bus freq 1000000
    [    1.278576] mdio_bus c200f00.mdio: MDIO device at address 1 is missing.
    [    1.285342] am65-cpsw-nuss c200000.ethernet: initializing am65 cpsw nuss version 0x6BA02102, cpsw version 0x6BA82102 Ports: 2 quirks:00000000
    [    1.298173] am65-cpsw-nuss c200000.ethernet: Use random MAC address
    [    1.304481] am65-cpsw-nuss c200000.ethernet: initialized cpsw ale version 1.4
    [    1.311630] am65-cpsw-nuss c200000.ethernet: ALE Table size 64
    [    1.311684]  mmcblk0: p1 p2 p3 p4 p5 p6 p7 p8 p9 p10 p11 p12 p13 p14 p15
    [    1.317970] am65-cpsw-nuss c200000.ethernet: CPTS ver 0x4e8a010b, freq:200000000, add_val:4 pps:0
    [    1.325777] mmcblk0boot0: mmc0:0001 A8A398 4.00 MiB 
    [    1.338809] mmcblk0boot1: mmc0:0001 A8A398 4.00 MiB 
    [    1.343854] am65-cpsw-nuss c200000.ethernet: set new flow-id-base 82
    [    1.344374] mmcblk0rpmb: mmc0:0001 A8A398 4.00 MiB, chardev (242:0)
    [    1.351942] debugfs: Directory 'pd:39' with parent 'pm_genpd' already present!
    [    1.363716] debugfs: Directory 'pd:38' with parent 'pm_genpd' already present!
    [    1.382093] mmc0: running CQE recovery
    [    1.386236] Unable to handle kernel paging request at virtual address 00000002e2e2f2e0
    [    1.394145] Mem abort info:
    [    1.396931]   ESR = 0x0000000096000004
    [    1.400671]   EC = 0x25: DABT (current EL), IL = 32 bits
    [    1.405981]   SET = 0, FnV = 0
    [    1.409026]   EA = 0, S1PTW = 0
    [    1.412157]   FSC = 0x04: level 0 translation fault
    [    1.417021] Data abort info:
    [    1.419890]   ISV = 0, ISS = 0x00000004
    [    1.423714]   CM = 0, WnR = 0
    [    1.426671] [00000002e2e2f2e0] user address but active_mm is swapper
    [    1.433009] Internal error: Oops: 0000000096000004 [#1] PREEMPT SMP
    [    1.439258] Modules linked in:
    [    1.442302] CPU: 0 PID: 115 Comm: kworker/0:1H Not tainted 6.1.80 #1
    [    1.448638] Hardware name: Texas Instruments J721S2 EVM (DT)
    [    1.454279] Workqueue: kblockd blk_mq_run_work_fn
    [    1.458978] pstate: 80000005 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
    [    1.465920] pc : __blk_rq_map_sg+0x88/0x3fc
    [    1.470094] lr : mmc_queue_map_sg+0x3c/0x70
    [    1.474265] sp : ffff80000a08ba60
    [    1.477564] x29: ffff80000a08ba60 x28: ffff80000a08bb10 x27: 0000000000000000
    [    1.484683] x26: ffff0000016a9200 x25: ffff000001517e80 x24: ffff0000014d5000
    [    1.491801] x23: ffff00000149c000 x22: 0000000000000000 x21: 0000000000000000
    [    1.498919] x20: ffff00000081d410 x19: 000000002e2f2e2e x18: ffffffffffffffff
    [    1.506037] x17: 000000000000001c x16: 0000000000000000 x15: 00009557ca4113ee
    [    1.513154] x14: 00000000000000fb x13: 0000000000000001 x12: 0000000000000000
    [    1.520270] x11: 0000000000000001 x10: ffffffffffffffff x9 : 0000000000000000
    [    1.527388] x8 : ffff0000015180f8 x7 : 0000000000000000 x6 : 0000000000000000
    [    1.534505] x5 : 0000000000000200 x4 : 0000000000000000 x3 : 0000000000000000
    [    1.541621] x2 : ffff0000014d5000 x1 : 00000002e2e2f2e0 x0 : 00000002e2e2f2e0
    [    1.548740] Call trace:
    [    1.551174]  __blk_rq_map_sg+0x88/0x3fc
    [    1.554998]  mmc_queue_map_sg+0x3c/0x70
    [    1.558820]  mmc_blk_data_prep+0x1b0/0x350
    [    1.562901]  mmc_blk_mq_issue_rq+0x244/0x920
    [    1.567156]  mmc_mq_queue_rq+0x118/0x2ac
    [    1.571064]  blk_mq_dispatch_rq_list+0x1a8/0x8b0
    [    1.575666]  __blk_mq_sched_dispatch_requests+0xb8/0x164
    [    1.580963]  blk_mq_sched_dispatch_requests+0x3c/0x80
    [    1.586000]  __blk_mq_run_hw_queue+0x68/0xa0
    [    1.590255]  blk_mq_run_work_fn+0x20/0x30
    [    1.594250]  process_one_work+0x1d0/0x320
    [    1.598249]  worker_thread+0x14c/0x444
    [    1.601985]  kthread+0x10c/0x110
    [    1.605202]  ret_from_fork+0x10/0x20
    [    1.608767] Code: f9403743 d37c7c01 f9004be1 8b010060 (f8616876) 
    [    1.614842] ---[ end trace 0000000000000000 ]---
    [   11.619900] platform mux-controller0: deferred probe pending
    [   11.625648] platform mux-controller1: deferred probe pending

    Thanks!

  • Hi,update some information. 

    This is my test. if i use emmc boot mode, it can not run fine. i also show the logs file last time.

    the different is tiboot3.bin. other files such as uboot/kernel/fs  is the same in my test.

    Do you have any sugesstion about my test?

  • Unlocking

  • Hi Xie,

    This is my test. if i use emmc boot mode, it can not run fine. i also show the logs file last time.

    Can you check if legacy speed mode/High speed SDR is working fine?