This thread has been locked.

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

AM623: EMMC backup startup(Falcon Mode)

Part Number: AM623


Tool/software:

Hi, TI expert! 

I have a development environment for am6234, with our own evaluation board.

The software SDK version is PROCESSOR-SDK-LINUX-RT-AM62X-08.06.00.42.

On the hardware side, I set the board to EMMC backup startup as follows:

I refer to the following link and use an uncompressed kernel image (Image)to achieve quick startup. 

https://e2e.ti.com/support/processors-group/processors/f/processors-forum/1205638/faq-am625-how-to-boot-from-r5-u-boot-spl-directly-into-the-linux-kernel-skipping-a53-spl-and-a53-u-boot-falcon-mode

In this case, it is possible to start the kernel normally.

However, when r5 SPL loads the kernel image and ramfs, it takes a long time to wait, as shown in the following video:

The following are the sizes of kernel images, ramfs images, and atf-tee-dm-kernel-fdt.bin images:

root@ubuntu-1804:/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/linux-rt-5.10.168+gitAUTOINC+c1a1291911-gc1a1291911/arch/arm64/boot# du -sh Image
18M     Image

root@ubuntu-1804:/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/build/gen-img/itb/input# du -sh rootfs.cpio.gz 
8.8M    rootfs.cpio.gz

root@ubuntu-1804:/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/output# du -sh atf-tee-dm-kernel-fdt.bin 
28M     atf-tee-dm-kernel-fdt.bin

Meanwhile,the configuration of atf-tee-dm-kernel-fdt.its is as follows

/dts-v1/;

/ {
	description = "Configuration to load ATF and SPL";
	#address-cells = <1>;

	images {
		atf {
			description = "ARM Trusted Firmware";
			data = /incbin/("/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/prebuilt-images/bl31.bin.signed");
			type = "firmware";
			arch = "arm64";
			compression = "none";
			os = "arm-trusted-firmware";
			load = <0x9e780000>;		/* This load/entry address pair is for use with AM62x */
			entry = <0x9e780000>;
		};
		tee {
			description = "OPTEE";
			data = /incbin/("/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/prebuilt-images/bl32.bin.signed");
			type = "tee";
			arch = "arm64";
			compression = "none";
			os = "tee";
			load = <0x9e800000>;		/* Needs to match BL32_BASE in ATF */
			entry = <0x9e800000>;
		};
		dm {
			description = "DM binary";
			data = /incbin/("/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/prebuilt-images/ipc_echo_testb_mcu1_0_release_strip.xer5f.signed");
			type = "firmware";
			arch = "arm32";
			compression = "none";
			os = "DM";
			load = <0x89000000>;
			entry = <0x89000000>;
		};
		kernel {
			description = "Linux Kernel (64-bit)";
			data = /incbin/("/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/linux-rt-5.10.168+gitAUTOINC+c1a1291911-gc1a1291911/linux.bin.sec");
			type = "kernel";
			os = "linux";
			arch = "arm64";
			compression = "none";
			load = <0x80080000>;		/* Needs to match PRELOADED_BL33_BASE in ATF */
			entry = <0x80080000>;
		};
		ramdisk {
			description = "ramdisk";
			data = /incbin/("/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/linux-rt-5.10.168+gitAUTOINC+c1a1291911-gc1a1291911/ramdisk.sec");
			type = "ramdisk";
			arch = "arm64";
			os = "linux";
			compression = "gzip";
			load = <0x81600000>;
			entry = <0x81600000>;
		};
		fdt {
			description = "k3-am62x-sk.dtb.sec";
			data = /incbin/("/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/linux-rt-5.10.168+gitAUTOINC+c1a1291911-gc1a1291911/arch/arm64/boot/dts/ti/k3-am62x-sk.dtb.sec");
			type = "flat_dt";
			arch = "arm";
			compression = "none";
			load = <0x82000000>;		/* Needs to match K3_HW_CONFIG_BASE in ATF */
		};
	};
	configurations {
		default = "k3-am62x-sk.dtb.sec";

		k3-am62x-sk.dtb.sec {
			description = "k3-am62x-sk.dtb.sec";
			firmware = "atf";
			loadables = "tee", "dm", "kernel", "ramdisk", "fdt";
		};
	};
};

If Falcon Mode is not used, loading images directly with uboot will be faster.

I would like to ask how to improve the loading speed of the image in Falcon Mode when use emmc backup startup?

Regards,

Li

  • Hello,

    Could you please share the UART logs with timestamps to get a better idea about the time taken to load the Falcon image.

    Please also share the R5 U-Boot defconfig file you are using.

    Regards,

    Prashant

  • hello,

    UART logs with timestamps are asfollows:

    =~=~=~=~=~=~=~=~=~=~=~= MobaXterm log 2024.05.29 01:20:48 =~=~=~=~=~=~=~=~=~=~=~=
    
    [2024-05-29 01:20:48]  U-Boot SPL 2021.01-00003-gf4dc0be4cb-dirty (May 29 2024 - 01:16:15 +0000)
    [2024-05-29 01:20:48]  SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [2024-05-29 01:20:48]  TLB table from bfffc000 to c0000000
    [2024-05-29 01:20:48]  SPL initial stack usage: 13424 bytes
    [2024-05-29 01:20:48]  SPL malloc() before relocation used 0x6c20 bytes (27 KB)
    [2024-05-29 01:20:48]  >>SPL: board_init_r()
    [2024-05-29 01:20:48]  spl_init
    [2024-05-29 01:20:48]  WDT:   Not found!
    [2024-05-29 01:20:48]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:48]  spl_ll_find_loader:506 loader:MMC1 device:9
    [2024-05-29 01:20:48]  spl_ll_find_loader:508 loader:MMC1 device:9
    [2024-05-29 01:20:48]  Trying to boot from MMC1
    [2024-05-29 01:20:48]  spl: mmc boot mode: fs
    [2024-05-29 01:20:48]  spl_mmc_load:422 fit:atf-tee-dm-kernel-fdt.bin
    [2024-05-29 01:20:48]  spl_mmc_do_fs_boot:269
    [2024-05-29 01:20:48]  spl_load_image_fat:64 filename:atf-tee-dm-kernel-fdt.bin partition:1
    [2024-05-29 01:20:48]  spl_load_image_fat:91
    [2024-05-29 01:20:48]  Found FIT
    [2024-05-29 01:20:48]  fit read sector 0, sectors=1552, dst=82fff9c0, count=1552, size=0x610
    [2024-05-29 01:20:48]  firmware: 'atf'
    [2024-05-29 01:20:48]  spl_load_simple_fit:650
    [2024-05-29 01:20:48]  spl_load_fit_image:281
    [2024-05-29 01:20:48]  External data: dst=9e780000, offset=610, size=b27e
    [2024-05-29 01:20:48]  spl_load_fit_image:339
    [2024-05-29 01:20:48]  board_fit_image_post_process: processing image: addr=9e780000, size=45694, os=arm-trusted-firmware
    [2024-05-29 01:20:48]  board_fit_image_post_process: matched image for ID 0
    [2024-05-29 01:20:48]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 01:20:48]  Authenticating image of size 45694 bytes
    [2024-05-29 01:20:48]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:48]  Authentication passed
    [2024-05-29 01:20:48]  
    [2024-05-29 01:20:48]  spl_load_fit_image:353
    [2024-05-29 01:20:48]  spl_load_fit_image:363
    [2024-05-29 01:20:48]  spl_load_fit_image:365
    [2024-05-29 01:20:48]  spl_load_fit_image:373
    [2024-05-29 01:20:48]  Image OS is ARM Trusted Firmware
    [2024-05-29 01:20:48]  loadables: 'tee'
    [2024-05-29 01:20:48]  spl_load_fit_image:281
    [2024-05-29 01:20:48]  External data: dst=9e800000, offset=b890, size=68ee6
    [2024-05-29 01:20:48]  spl_load_fit_image:339
    [2024-05-29 01:20:48]  board_fit_image_post_process: processing image: addr=9e800000, size=429798, os=tee
    [2024-05-29 01:20:48]  board_fit_image_post_process: matched image for ID 1
    [2024-05-29 01:20:48]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 01:20:48]  Authenticating image of size 429798 bytes
    [2024-05-29 01:20:48]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:48]  Authentication passed
    [2024-05-29 01:20:48]  
    [2024-05-29 01:20:48]  spl_load_fit_image:353
    [2024-05-29 01:20:48]  spl_load_fit_image:363
    [2024-05-29 01:20:48]  spl_load_fit_image:365
    [2024-05-29 01:20:48]  spl_load_fit_image:373
    [2024-05-29 01:20:48]  Loadable is Trusted Execution Environment
    [2024-05-29 01:20:48]  loadables: 'dm'
    [2024-05-29 01:20:48]  spl_load_fit_image:281
    [2024-05-29 01:20:48]  External data: dst=89000000, offset=74778, size=2352e
    [2024-05-29 01:20:48]  spl_load_fit_image:339
    [2024-05-29 01:20:48]  board_fit_image_post_process: processing image: addr=89000000, size=144686, os=DM
    [2024-05-29 01:20:48]  board_fit_image_post_process: matched image for ID 3
    [2024-05-29 01:20:48]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 01:20:48]  Authenticating image of size 144686 bytes
    [2024-05-29 01:20:48]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:48]  Authentication passed
    [2024-05-29 01:20:48]  
    [2024-05-29 01:20:48]  spl_load_fit_image:353
    [2024-05-29 01:20:48]  spl_load_fit_image:363
    [2024-05-29 01:20:48]  spl_load_fit_image:365
    [2024-05-29 01:20:48]  spl_load_fit_image:373
    [2024-05-29 01:20:48]  Loadable is Unknown OS
    [2024-05-29 01:20:48]  loadables: 'kernel'
    [2024-05-29 01:20:48]  spl_load_fit_image:281
    [2024-05-29 01:20:48]  External data: dst=80080000, offset=97ca8, size=121e067
    [2024-05-29 01:20:55]  spl_load_fit_image:339
    [2024-05-29 01:20:55]  board_fit_image_post_process: processing image: addr=80080000, size=18997351, os=linux
    [2024-05-29 01:20:55]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 01:20:55]  Authenticating image of size 18997351 bytes
    [2024-05-29 01:20:55]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:55]  Authentication passed
    [2024-05-29 01:20:55]  
    [2024-05-29 01:20:55]  spl_load_fit_image:353
    [2024-05-29 01:20:55]  spl_load_fit_image:363
    [2024-05-29 01:20:55]  spl_load_fit_image:365
    [2024-05-29 01:20:55]  spl_load_fit_image:373
    [2024-05-29 01:20:55]  Loadable is Linux
    [2024-05-29 01:20:55]  loadables: 'ramdisk'
    [2024-05-29 01:20:55]  spl_load_fit_image:281
    [2024-05-29 01:20:55]  External data: dst=81600000, offset=12b5d10, size=8bb56b
    [2024-05-29 01:20:58]  spl_load_fit_image:339
    [2024-05-29 01:20:58]  board_fit_image_post_process: processing image: addr=81600000, size=9155947, os=linux
    [2024-05-29 01:20:58]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 01:20:58]  Authenticating image of size 9155947 bytes
    [2024-05-29 01:20:58]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:58]  Authentication passed
    [2024-05-29 01:20:58]  
    [2024-05-29 01:20:58]  spl_load_fit_image:353
    [2024-05-29 01:20:58]  spl_load_fit_image:363
    [2024-05-29 01:20:58]  spl_load_fit_image:365
    [2024-05-29 01:20:58]  spl_load_fit_image:373
    [2024-05-29 01:20:58]  Loadable is Linux
    [2024-05-29 01:20:58]  loadables: 'fdt'
    [2024-05-29 01:20:58]  spl_load_fit_image:281
    [2024-05-29 01:20:58]  External data: dst=82000000, offset=1b7127c, size=11c60
    [2024-05-29 01:20:58]  spl_load_fit_image:339
    [2024-05-29 01:20:58]  board_fit_image_post_process: processing image: addr=ffffffff, size=72800, os=
    [2024-05-29 01:20:58]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 01:20:58]  Authenticating image of size 72800 bytes
    [2024-05-29 01:20:58]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:58]  Authentication passed
    [2024-05-29 01:20:58]  
    [2024-05-29 01:20:58]  spl_load_fit_image:353
    [2024-05-29 01:20:58]  spl_load_fit_image:363
    [2024-05-29 01:20:58]  spl_load_fit_image:368
    [2024-05-29 01:20:58]  spl_load_fit_image:373
    [2024-05-29 01:20:58]  no string for index 5
    [2024-05-29 01:20:58]  spl_load_simple_fit:691
    [2024-05-29 01:20:58]  spl_mmc_do_fs_boot:274
    [2024-05-29 01:20:58]  Unsupported OS image.. Jumping nevertheless..
    [2024-05-29 01:20:58]  loaded - jumping to U-Boot...
    [2024-05-29 01:20:58]  Loading Environment from MMC... MMC: block number 0x3500 exceeds max(0x2000)
    [2024-05-29 01:20:58]  *** Warning - !read failed, using default environment
    [2024-05-29 01:20:58]  
    [2024-05-29 01:20:58]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:59]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 01:20:59]  init_env from device 9 not supported!
    [2024-05-29 01:20:59]  jump_to_image_no_args:245
    [2024-05-29 01:20:59]  jump_to_image_no_args:248
    [2024-05-29 01:20:59]  Loading phdr 0 to 0x41010040 (4784 bytes)
    [2024-05-29 01:20:59]  Loading phdr 1 to 0x410112f0 (432 bytes)
    [2024-05-29 01:20:59]  Loading phdr 2 to 0x410114a0 (408 bytes)
    [2024-05-29 01:20:59]  Loading phdr 3 to 0x41011a40 (4424 bytes)
    [2024-05-29 01:20:59]  Loading phdr 4 to 0x9db00000 (4096 bytes)
    [2024-05-29 01:20:59]  Loading phdr 5 to 0x9dc00000 (0 bytes)
    [2024-05-29 01:20:59]  Loading phdr 6 to 0x9dc00680 (0 bytes)
    [2024-05-29 01:20:59]  Loading phdr 7 to 0x9dc18f00 (88304 bytes)
    [2024-05-29 01:20:59]  Loading phdr 8 to 0x9dc2e7f0 (0 bytes)
    [2024-05-29 01:20:59]  Loading phdr 9 to 0x9dc3e7f0 (27672 bytes)
    [2024-05-29 01:20:59]  Loading phdr 10 to 0x9dc45480 (5376 bytes)
    [2024-05-29 01:20:59]  Loading phdr 11 to 0x9dc46980 (1922 bytes)
    [2024-05-29 01:20:59]  Loading phdr 12 to 0x9e6f6c00 (0 bytes)
    [2024-05-29 01:20:59]  Loading phdr 13 to 0x9e6f8000 (0 bytes)
    [2024-05-29 01:20:59]  jump_to_image_no_args: jumping to address 9dc2d320
    [2024-05-29 01:20:59]  Starting ATF on ARM64 core...
    [2024-05-29 01:20:59]  
    [2024-05-29 01:20:59]  NOTICE:  BL31: v2.8(release):v2.8-226-g2fcd408bb
    [2024-05-29 01:20:59]  NOTICE:  BL31: Built : 09:18:17, May 23 2024
    [2024-05-29 01:20:59]  I/TC: 
    [2024-05-29 01:20:59]  I/TC: OP-TEE version: Unknown_3.20 (gcc version 9.2.1 20191025 (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10))) #1 Thu May 23 01:18:46 UTC 2024 aarch64
    [2024-05-29 01:20:59]  I/TC: WARNING: This OP-TEE configuration might be insecure!
    [2024-05-29 01:20:59]  I/TC: WARNING: Please check https://optee.readthedocs.io/en/latest/architecture/porting_guidelines.html
    [2024-05-29 01:20:59]  I/TC: Primary CPU initializing
    [2024-05-29 01:20:59]  I/TC: SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [2024-05-29 01:20:59]  I/TC: HUK Initialized
    [2024-05-29 01:20:59]  I/TC: Activated SA2UL device
    [2024-05-29 01:20:59]  I/TC: Enabled firewalls for SA2UL TRNG device
    [2024-05-29 01:20:59]  I/TC: SA2UL TRNG initialized
    [2024-05-29 01:20:59]  I/TC: SA2UL Drivers initialized
    [2024-05-29 01:20:59]  I/TC: Primary CPU switching to normal world boot
    [2024-05-29 01:20:59]  I/TC: Secondary CPU 1 initializing
    [2024-05-29 01:20:59]  I/TC: Secondary CPU 1 switching to normal world boot
    [2024-05-29 01:20:59]  I/TC: Reserved shared memory is enabled
    [2024-05-29 01:20:59]  I/TC: Dynamic shared memory is enabled
    [2024-05-29 01:20:59]  I/TC: Normal World virtualization support is disabled
    [2024-05-29 01:20:59]  I/TC: Asynchronous notifications are disabled
    [2024-05-29 01:20:59]  [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
    [2024-05-29 01:21:00]  [    0.000000] Linux version 5.10.168-rt83-gc1a1291911 (root@ubuntu-1804) (aarch64-none-linux-gnu-gcc (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 9.2.1 20191025, GNU ld (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 2.33.1.20191209) #13 SMP PREEMPT_RT Tue May 28 05:05:00 UTC 2024
    [2024-05-29 01:21:00]  [    0.000000] Machine model: ZHIYUAN Electronics AM62x
    [2024-05-29 01:21:00]  [    0.000000] efi: UEFI not found.
    [2024-05-29 01:21:00]  [    0.000000] [Firmware Bug]: Kernel image misaligned at boot, please fix your bootloader!
    [2024-05-29 01:21:00]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009c800000, size 3 MiB
    [2024-05-29 01:21:00]  [    0.000000] OF: reserved mem: initialized node ipc-memories@9c800000, compatible id shared-dma-pool
    [2024-05-29 01:21:00]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009cb00000, size 1 MiB
    [2024-05-29 01:21:00]  [    0.000000] OF: reserved mem: initialized node m4f-dma-memory@9cb00000, compatible id shared-dma-pool
    [2024-05-29 01:21:00]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009cc00000, size 14 MiB
    [2024-05-29 01:21:00]  [    0.000000] OF: reserved mem: initialized node m4f-memory@9cc00000, compatible id shared-dma-pool
    [2024-05-29 01:21:00]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009da00000, size 1 MiB
    [2024-05-29 01:21:00]  [    0.000000] OF: reserved mem: initialized node r5f-dma-memory@9da00000, compatible id shared-dma-pool
    [2024-05-29 01:21:00]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009db00000, size 12 MiB
    [2024-05-29 01:21:00]  [    0.000000] OF: reserved mem: initialized node r5f-memory@9db00000, compatible id shared-dma-pool
    [2024-05-29 01:21:00]  [    0.000000] Zone ranges:
    [2024-05-29 01:21:00]  [    0.000000]   DMA      [mem 0x0000000080000000-0x00000000bfffffff]
    [2024-05-29 01:21:00]  [    0.000000]   DMA32    empty
    [2024-05-29 01:21:00]  [    0.000000]   Normal   empty
    [2024-05-29 01:21:00]  [    0.000000] Movable zone start for each node
    [2024-05-29 01:21:00]  [    0.000000] Early memory node ranges
    [2024-05-29 01:21:00]  [    0.000000]   node   0: [mem 0x0000000080000000-0x000000009c7fffff]
    [2024-05-29 01:21:00]  [    0.000000]   node   0: [mem 0x000000009c800000-0x000000009e6fffff]
    [2024-05-29 01:21:00]  [    0.000000]   node   0: [mem 0x000000009e700000-0x000000009e77ffff]
    [2024-05-29 01:21:00]  [    0.000000]   node   0: [mem 0x000000009e780000-0x000000009fffffff]
    [2024-05-29 01:21:00]  [    0.000000]   node   0: [mem 0x00000000a0000000-0x00000000bfffffff]
    [2024-05-29 01:21:00]  [    0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000000bfffffff]
    [2024-05-29 01:21:00]  [    0.000000] cma: Failed to reserve 512 MiB
    [2024-05-29 01:21:00]  [    0.000000] psci: probing for conduit method from DT.
    [2024-05-29 01:21:00]  [    0.000000] psci: PSCIv1.1 detected in firmware.
    [2024-05-29 01:21:00]  [    0.000000] psci: Using standard PSCI v0.2 function IDs
    [2024-05-29 01:21:00]  [    0.000000] psci: Trusted OS migration not required
    [2024-05-29 01:21:00]  [    0.000000] psci: SMC Calling Convention v1.2
    [2024-05-29 01:21:00]  [    0.000000] percpu: Embedded 18 pages/cpu s35392 r8192 d30144 u73728
    [2024-05-29 01:21:00]  [    0.000000] Detected VIPT I-cache on CPU0
    [2024-05-29 01:21:00]  [    0.000000] CPU features: detected: ARM erratum 845719
    [2024-05-29 01:21:00]  [    0.000000] CPU features: detected: GIC system register CPU interface
    [2024-05-29 01:21:00]  [    0.000000] CPU features: kernel page table isolation forced ON by KASLR
    [2024-05-29 01:21:00]  [    0.000000] CPU features: detected: Kernel page table isolation (KPTI)
    [2024-05-29 01:21:00]  [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 258048
    [2024-05-29 01:21:00]  [    0.000000] Kernel command line: console=ttyS2,115200n8 fbcon=logo-pos:center fbcon=logo-count:1 rw rootwait root=/dev/mmcblk0p2 break
    [2024-05-29 01:21:00]  [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
    [2024-05-29 01:21:00]  [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
    [2024-05-29 01:21:00]  [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
    [2024-05-29 01:21:00]  [    0.000000] Memory: 941544K/1048576K available (11392K kernel code, 1142K rwdata, 4124K rodata, 1792K init, 438K bss, 107032K reserved, 0K cma-reserved)
    [2024-05-29 01:21:00]  [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
    [2024-05-29 01:21:00]  [    0.000000] rcu: Preemptible hierarchical RCU implementation.
    [2024-05-29 01:21:00]  [    0.000000] rcu: RCU event tracing is enabled.
    [2024-05-29 01:21:00]  [    0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=2.
    [2024-05-29 01:21:00]  [    0.000000] rcu: RCU priority boosting: priority 1 delay 500 ms.
    [2024-05-29 01:21:00]  [    0.000000] rcu: RCU_SOFTIRQ processing moved to rcuc kthreads.
    [2024-05-29 01:21:00]  [    0.000000] No expedited grace period (rcu_normal_after_boot).
    [2024-05-29 01:21:00]  [    0.000000] Trampoline variant of Tasks RCU enabled.
    [2024-05-29 01:21:00]  [    0.000000] Tracing variant of Tasks RCU enabled.
    [2024-05-29 01:21:00]  [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
    [2024-05-29 01:21:00]  [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
    [2024-05-29 01:21:00]  [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
    [2024-05-29 01:21:00]  [    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
    [2024-05-29 01:21:00]  [    0.000000] GICv3: 256 SPIs implemented
    [2024-05-29 01:21:00]  [    0.000000] GICv3: 0 Extended SPIs implemented
    [2024-05-29 01:21:00]  [    0.000000] GICv3: Distributor has no Range Selector support
    [2024-05-29 01:21:00]  [    0.000000] GICv3: 16 PPIs implemented
    [2024-05-29 01:21:00]  [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001880000
    [2024-05-29 01:21:00]  [    0.000000] ITS [mem 0x01820000-0x0182ffff]
    [2024-05-29 01:21:00]  [    0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS
    [2024-05-29 01:21:00]  [    0.000000] ITS@0x0000000001820000: Devices Table too large, reduce ids 20->19
    [2024-05-29 01:21:00]  [    0.000000] ITS@0x0000000001820000: allocated 524288 Devices @82c00000 (flat, esz 8, psz 64K, shr 0)
    [2024-05-29 01:21:00]  [    0.000000] ITS: using cache flushing for cmd queue
    [2024-05-29 01:21:00]  [    0.000000] GICv3: using LPI property table @0x0000000082430000
    [2024-05-29 01:21:00]  [    0.000000] GIC: using cache flushing for LPI property table
    [2024-05-29 01:21:00]  [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000082440000
    [2024-05-29 01:21:00]  [    0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys).
    [2024-05-29 01:21:00]  [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns
    [2024-05-29 01:21:00]  [    0.000001] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
    [2024-05-29 01:21:00]  [    0.000346] Console: colour dummy device 80x25
    [2024-05-29 01:21:00]  [    0.000401] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=200000)
    [2024-05-29 01:21:00]  [    0.000415] pid_max: default: 32768 minimum: 301
    [2024-05-29 01:21:00]  [    0.000525] LSM: Security Framework initializing
    [2024-05-29 01:21:00]  [    0.000599] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
    [2024-05-29 01:21:00]  [    0.000615] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
    [2024-05-29 01:21:00]  [    0.002628] rcu: Hierarchical SRCU implementation.
    [2024-05-29 01:21:00]  [    0.003225] Platform MSI: msi-controller@1820000 domain created
    [2024-05-29 01:21:00]  [    0.003516] PCI/MSI: /bus@f0000/interrupt-controller@1800000/msi-controller@1820000 domain created
    [2024-05-29 01:21:00]  [    0.003627] EFI services will not be available.
    [2024-05-29 01:21:00]  [    0.003849] smp: Bringing up secondary CPUs ...
    [2024-05-29 01:21:00]  [    0.028212] Detected VIPT I-cache on CPU1
    [2024-05-29 01:21:00]  [    0.028254] GICv3: CPU1: found redistributor 1 region 0:0x00000000018a0000
    [2024-05-29 01:21:00]  [    0.028272] GICv3: CPU1: using allocated LPI pending table @0x0000000082450000
    [2024-05-29 01:21:00]  [    0.028336] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
    [2024-05-29 01:21:00]  [    0.028493] smp: Brought up 1 node, 2 CPUs
    [2024-05-29 01:21:00]  [    0.028500] SMP: Total of 2 processors activated.
    [2024-05-29 01:21:00]  [    0.028505] CPU features: detected: 32-bit EL0 Support
    [2024-05-29 01:21:00]  [    0.028510] CPU features: detected: CRC32 instructions
    [2024-05-29 01:21:00]  [    0.036023] CPU: All CPU(s) started at EL2
    [2024-05-29 01:21:00]  [    0.036043] alternatives: patching kernel code
    [2024-05-29 01:21:00]  [    0.037232] devtmpfs: initialized
    [2024-05-29 01:21:00]  [    0.047050] KASLR disabled due to lack of seed
    [2024-05-29 01:21:00]  [    0.047230] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
    [2024-05-29 01:21:00]  [    0.047250] futex hash table entries: 512 (order: 4, 65536 bytes, linear)
    [2024-05-29 01:21:00]  [    0.047547] pinctrl core: initialized pinctrl subsystem
    [2024-05-29 01:21:00]  [    0.048046] DMI not present or invalid.
    [2024-05-29 01:21:00]  [    0.048722] NET: Registered protocol family 16
    [2024-05-29 01:21:00]  [    0.049277] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
    [2024-05-29 01:21:00]  [    0.049311] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
    [2024-05-29 01:21:00]  [    0.049340] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
    [2024-05-29 01:21:00]  [    0.049915] thermal_sys: Registered thermal governor 'step_wise'
    [2024-05-29 01:21:00]  [    0.050631] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
    [2024-05-29 01:21:00]  [    0.050692] ASID allocator initialised with 32768 entries
    [2024-05-29 01:21:00]  [    0.085871] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
    [2024-05-29 01:21:01]  [    0.085886] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
    [2024-05-29 01:21:01]  [    0.085890] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
    [2024-05-29 01:21:01]  [    0.085894] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
    [2024-05-29 01:21:01]  [    0.087016] cryptd: max_cpu_qlen set to 1000
    [2024-05-29 01:21:01]  [    0.090504] k3-chipinfo 43000014.chipid: Family:AM62X rev:SR1.0 JTAGID[0x0bb7e02f] Detected
    [2024-05-29 01:21:01]  [    0.091541] vcc_5v0: supplied by vmain_pd
    [2024-05-29 01:21:01]  [    0.091983] vcc_3v3_sys: supplied by vmain_pd
    [2024-05-29 01:21:01]  [    0.092386] vdd_mmc1: supplied by vcc_3v3_sys
    [2024-05-29 01:21:01]  [    0.092853] wlan_en: supplied by vcc_3v3_sys
    [2024-05-29 01:21:01]  [    0.093330] vdd_io: supplied by vcc_3v3_sys
    [2024-05-29 01:21:01]  [    0.093609] vcc_1v8: supplied by vcc_3v3_sys
    [2024-05-29 01:21:01]  [    0.094521] iommu: Default domain type: Translated 
    [2024-05-29 01:21:01]  [    0.094831] SCSI subsystem initialized
    [2024-05-29 01:21:01]  [    0.095063] usbcore: registered new interface driver usbfs
    [2024-05-29 01:21:01]  [    0.095105] usbcore: registered new interface driver hub
    [2024-05-29 01:21:01]  [    0.095135] usbcore: registered new device driver usb
    [2024-05-29 01:21:01]  [    0.095723] mc: Linux media interface: v0.10
    [2024-05-29 01:21:01]  [    0.095750] videodev: Linux video capture interface: v2.00
    [2024-05-29 01:21:01]  [    0.095787] pps_core: LinuxPPS API ver. 1 registered
    [2024-05-29 01:21:01]  [    0.095790] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [2024-05-29 01:21:01]  [    0.095804] PTP clock support registered
    [2024-05-29 01:21:01]  [    0.095836] EDAC MC: Ver: 3.0.0
    [2024-05-29 01:21:01]  [    0.096681] omap-mailbox 29000000.mailbox: omap mailbox rev 0x66fc9100
    [2024-05-29 01:21:01]  [    0.097362] FPGA manager framework
    [2024-05-29 01:21:01]  [    0.097466] Advanced Linux Sound Architecture Driver Initialized.
    [2024-05-29 01:21:01]  [    0.098461] clocksource: Switched to clocksource arch_sys_counter
    [2024-05-29 01:21:01]  [    0.098678] VFS: Disk quotas dquot_6.6.0
    [2024-05-29 01:21:01]  [    0.098729] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
    [2024-05-29 01:21:01]  [    0.105033] NET: Registered protocol family 2
    [2024-05-29 01:21:01]  [    0.105247] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
    [2024-05-29 01:21:01]  [    0.106354] tcp_listen_portaddr_hash hash table entries: 512 (order: 3, 32768 bytes, linear)
    [2024-05-29 01:21:01]  [    0.106470] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
    [2024-05-29 01:21:01]  [    0.106547] TCP bind hash table entries: 8192 (order: 6, 458752 bytes, linear)
    [2024-05-29 01:21:01]  [    0.106956] TCP: Hash tables configured (established 8192 bind 8192)
    [2024-05-29 01:21:01]  [    0.107179] UDP hash table entries: 512 (order: 4, 65536 bytes, linear)
    [2024-05-29 01:21:01]  [    0.107278] UDP-Lite hash table entries: 512 (order: 4, 65536 bytes, linear)
    [2024-05-29 01:21:01]  [    0.107593] NET: Registered protocol family 1
    [2024-05-29 01:21:01]  [    0.108225] RPC: Registered named UNIX socket transport module.
    [2024-05-29 01:21:01]  [    0.108232] RPC: Registered udp transport module.
    [2024-05-29 01:21:01]  [    0.108236] RPC: Registered tcp transport module.
    [2024-05-29 01:21:01]  [    0.108238] RPC: Registered tcp NFSv4.1 backchannel transport module.
    [2024-05-29 01:21:01]  [    0.108247] NET: Registered protocol family 44
    [2024-05-29 01:21:01]  [    0.108265] PCI: CLS 0 bytes, default 64
    [2024-05-29 01:21:01]  [    0.108596] Trying to unpack rootfs image as initramfs...
    [2024-05-29 01:21:01]  [    0.461949] rootfs image is not initramfs (invalid magic at start of compressed archive); looks like an initrd
    [2024-05-29 01:21:01]  [    0.493236] Freeing initrd memory: 10240K
    [2024-05-29 01:21:01]  [    0.493966] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available
    [2024-05-29 01:21:01]  [    0.498395] Initialise system trusted keyrings
    [2024-05-29 01:21:01]  [    0.498821] workingset: timestamp_bits=46 max_order=18 bucket_order=0
    [2024-05-29 01:21:01]  [    0.504096] squashfs: version 4.0 (2009/01/31) Phillip Lougher
    [2024-05-29 01:21:01]  [    0.504796] NFS: Registering the id_resolver key type
    [2024-05-29 01:21:01]  [    0.504836] Key type id_resolver registered
    [2024-05-29 01:21:01]  [    0.504840] Key type id_legacy registered
    [2024-05-29 01:21:01]  [    0.504907] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
    [2024-05-29 01:21:01]  [    0.504912] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
    [2024-05-29 01:21:01]  [    0.505235] 9p: Installing v9fs 9p2000 file system support
    [2024-05-29 01:21:01]  [    0.540444] Key type asymmetric registered
    [2024-05-29 01:21:01]  [    0.540484] Asymmetric key parser 'x509' registered
    [2024-05-29 01:21:01]  [    0.540538] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)
    [2024-05-29 01:21:01]  [    0.540545] io scheduler mq-deadline registered
    [2024-05-29 01:21:01]  [    0.540550] io scheduler kyber registered
    [2024-05-29 01:21:01]  [    0.543205] pinctrl-single 4084000.pinctrl: 34 pins, size 136
    [2024-05-29 01:21:01]  [    0.543748] pinctrl-single f4000.pinctrl: 171 pins, size 684
    [2024-05-29 01:21:01]  [    0.544806] pinctrl-single a40000.pinctrl: 512 pins, size 2048
    [2024-05-29 01:21:01]  [    0.553752] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
    [2024-05-29 01:21:01]  [    0.567266] brd: module loaded
    [2024-05-29 01:21:01]  [    0.575831] loop: module loaded
    [2024-05-29 01:21:01]  [    0.579335] tun: Universal TUN/TAP device driver, 1.6
    [2024-05-29 01:21:01]  [    0.579631] CAN device driver interface
    [2024-05-29 01:21:01]  [    0.581229] PPP generic driver version 2.4.2
    [2024-05-29 01:21:01]  [    0.581398] PPP BSD Compression module registered
    [2024-05-29 01:21:01]  [    0.581402] PPP Deflate Compression module registered
    [2024-05-29 01:21:01]  [    0.581431] PPP MPPE Compression module registered
    [2024-05-29 01:21:01]  [    0.581435] NET: Registered protocol family 24
    [2024-05-29 01:21:01]  [    0.581658] VFIO - User Level meta-driver version: 0.3
    [2024-05-29 01:21:01]  [    0.583488] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    [2024-05-29 01:21:01]  [    0.583497] ehci-pci: EHCI PCI platform driver
    [2024-05-29 01:21:01]  [    0.583536] ehci-platform: EHCI generic platform driver
    [2024-05-29 01:21:01]  [    0.583713] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    [2024-05-29 01:21:01]  [    0.583749] ohci-pci: OHCI PCI platform driver
    [2024-05-29 01:21:01]  [    0.583780] ohci-platform: OHCI generic platform driver
    [2024-05-29 01:21:01]  [    0.584398] usbcore: registered new interface driver usb-storage
    [2024-05-29 01:21:01]  [    0.584496] udc-core: couldn't find an available UDC - added [g_mass_storage] to list of pending drivers
    [2024-05-29 01:21:01]  [    0.584952] i2c /dev entries driver
    [2024-05-29 01:21:01]  [    0.586179] sdhci: Secure Digital Host Controller Interface driver
    [2024-05-29 01:21:01]  [    0.586183] sdhci: Copyright(c) Pierre Ossman
    [2024-05-29 01:21:01]  [    0.586809] sdhci-pltfm: SDHCI platform and OF driver helper
    [2024-05-29 01:21:01]  [    0.588616] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
    [2024-05-29 01:21:01]  [    0.590077] optee: probing for conduit method.
    [2024-05-29 01:21:01]  [    0.590112] optee: revision 3.20
    [2024-05-29 01:21:01]  [    0.606805] optee: dynamic shared memory is enabled
    [2024-05-29 01:21:01]  [    0.607207] optee: initialized driver
    [2024-05-29 01:21:01]  [    0.608372] <<-GTP-INFO->> GTP driver installing...
    [2024-05-29 01:21:01]  [    0.609253] Device tree node 'switch_reset' not found
    [2024-05-29 01:21:01]  [    0.609292] IP179 Switch: register major 200
    [2024-05-29 01:21:01]  [    0.609300] IP179 Switch: driver loaded! 
    [2024-05-29 01:21:01]  [    0.611074] NET: Registered protocol family 17
    [2024-05-29 01:21:01]  [    0.611100] can: controller area network core
    [2024-05-29 01:21:01]  [    0.611205] NET: Registered protocol family 29
    [2024-05-29 01:21:01]  [    0.611211] can: raw protocol
    [2024-05-29 01:21:01]  [    0.611216] can: broadcast manager protocol
    [2024-05-29 01:21:01]  [    0.611226] can: netlink gateway - max_hops=1
    [2024-05-29 01:21:01]  Loading, please wait...
    [2024-05-29 01:21:01]  [    0.611438] 9pnet: Installing 9P2000 support
    [2024-05-29 01:21:01]  [    0.611571] Key type dns_resolver registered
    [2024-05-29 01:21:01]  [    0.611839] Loading compiled-in X.509 certificates
    [2024-05-29 01:21:01]  [    0.629324] ti-sci 44043000.system-controller: lpm region is required for suspend but not provided.
    [2024-05-29 01:21:01]  [    0.629366] ti-sci 44043000.system-controller: ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [2024-05-29 01:21:01]  [    0.771284] davinci-mcasp 2b10000.mcasp: IRQ common not found
    [2024-05-29 01:21:01]  [    0.775510] omap-gpmc 3b000000.memory-controller: GPMC revision 6.0
    [2024-05-29 01:21:01]  [    0.775526] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000
    [2024-05-29 01:21:01]  [    0.777898] omap_i2c 4900000.i2c: bus 4 rev0.12 at 400 kHz
    [2024-05-29 01:21:01]  Starting version 245.4-4ubuntu3.23
    [2024-05-29 01:21:01]  [    0.779148] omap_i2c 2b200000.i2c: bus 5 rev0.12 at 400 kHz
    [2024-05-29 01:21:01]  [    0.780322] omap_i2c 20000000.i2c: bus 0 rev0.12 at 400 kHz
    [2024-05-29 01:21:01]  [    0.797723] rtc-pcf85063 1-0051: registered as rtc0
    [2024-05-29 01:21:01]  [    0.798747] rtc-pcf85063 1-0051: setting system clock to 2023-10-23T07:19:44 UTC (1698045584)
    [2024-05-29 01:21:01]  [    0.799592] omap_i2c 20010000.i2c: bus 1 rev0.12 at 100 kHz
    [2024-05-29 01:21:01]  [    0.801740] omap_i2c 20020000.i2c: bus 2 rev0.12 at 400 kHz
    [2024-05-29 01:21:01]  [    0.802677] ti-sci-intr 4210000.interrupt-controller: Interrupt Router 5 domain created
    [2024-05-29 01:21:01]  [    0.803261] ti-sci-intr bus@f0000:interrupt-controller@a00000: Interrupt Router 3 domain created
    [2024-05-29 01:21:01]  [    0.804346] ti-sci-inta 48000000.interrupt-controller: Interrupt Aggregator domain 28 created
    [2024-05-29 01:21:01]  [    0.807032] ti-udma 485c0100.dma-controller: Number of rings: 82
    [2024-05-29 01:21:01]  [    0.810959] ti-udma 485c0100.dma-controller: Channels: 48 (bchan: 18, tchan: 12, rchan: 18)
    [2024-05-29 01:21:01]  [    0.813826] ti-udma 485c0000.dma-controller: Number of rings: 150
    [2024-05-29 01:21:01]  [    0.825514] ti-udma 485c0000.dma-controller: Channels: 35 (tchan: 20, rchan: 15)
    [2024-05-29 01:21:01]  [    0.828574] 4a00000.serial: ttyS7 at MMIO 0x4a00000 (irq = 15, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.829949] 2b300000.serial: ttyS8 at MMIO 0x2b300000 (irq = 17, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.831276] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 29, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.831572] printk: console [ttyS2]: printing thread started
    [2024-05-29 01:21:01]  [    0.831584] printk: console [ttyS2] enabled
    [2024-05-29 01:21:01]  [    0.838884] 2810000.serial: ttyS1 at MMIO 0x2810000 (irq = 30, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.868636] 2820000.serial: ttyS0 at MMIO 0x2820000 (irq = 31, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.874625] 2830000.serial: ttyS3 at MMIO 0x2830000 (irq = 32, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.878778] 2840000.serial: ttyS4 at MMIO 0x2840000 (irq = 33, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.887861] 2850000.serial: ttyS5 at MMIO 0x2850000 (irq = 34, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.896686] 2860000.serial: ttyS6 at MMIO 0x2860000 (irq = 35, base_baud = 3000000) is a 8250
    [2024-05-29 01:21:01]  [    0.965965] spi spi5.0: setup: ignoring unsupported mode bits 200
    [2024-05-29 01:21:01]  [    0.980393] spi-nor spi5.0: is25lp064 (8192 Kbytes)
    [2024-05-29 01:21:01]  [    0.980437] 5 fixed-partitions partitions found on MTD device fc40000.spi.0
    [2024-05-29 01:21:01]  [    0.980442] Creating 5 MTD partitions on "fc40000.spi.0":
    [2024-05-29 01:21:01]  [    0.980457] 0x000000000000-0x000000080000 : "ospi.tiboot3"
    [2024-05-29 01:21:01]  [    0.993626] 0x000000080000-0x000000280000 : "ospi.tispl"
    [2024-05-29 01:21:01]  [    1.008822] 0x000000280000-0x000000680000 : "ospi.u-boot"
    [2024-05-29 01:21:01]  [    1.028678] 0x000000680000-0x0000006c0000 : "ospi.env"
    [2024-05-29 01:21:01]  [    1.047222] 0x0000006c0000-0x000000700000 : "ospi.env.backup"
    [2024-05-29 01:21:01]  [    1.069323] davinci_mdio 8000f00.mdio: Configuring MDIO in manual mode
    [2024-05-29 01:21:01]  [    1.103474] davinci_mdio 8000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
    [2024-05-29 01:21:01]  [    1.120826] davinci_mdio 8000f00.mdio: phy[5]: device 8000f00.mdio:05, driver YT8531S Gigabit Ethernet
    [2024-05-29 01:21:01]  [    1.120844] davinci_mdio 8000f00.mdio: phy[7]: device 8000f00.mdio:07, driver YT8531S Gigabit Ethernet
    [2024-05-29 01:21:01]  [    1.121015] am65-cpsw-nuss 8000000.ethernet: initializing am65 cpsw nuss version 0x6BA01103, cpsw version 0x6BA81103 Ports: 3 quirks:00000006
    [2024-05-29 01:21:01]  [    1.121537] am65-cpsw-nuss 8000000.ethernet: Use random MAC address
    [2024-05-29 01:21:01]  [    1.121549] am65-cpsw-nuss 8000000.ethernet: initialized cpsw ale version 1.5
    [2024-05-29 01:21:01]  [    1.121555] am65-cpsw-nuss 8000000.ethernet: ALE Table size 512
    [2024-05-29 01:21:01]  [    1.122602] pps pps0: new PPS source ptp0
    [2024-05-29 01:21:01]  [    1.122918] am65-cpsw-nuss 8000000.ethernet: CPTS ver 0x4e8a010c, freq:500000000, add_val:1 pps:1
    [2024-05-29 01:21:01]  [    1.155995] am65-cpsw-nuss 8000000.ethernet: set new flow-id-base 19
    [2024-05-29 01:21:01]  [    1.182957] dwc3-am62 f900000.dwc3-usb: lockup ldo_en wa
    [2024-05-29 01:21:01]  [    1.184556] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
    [2024-05-29 01:21:01]  [    1.184586] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
    [2024-05-29 01:21:01]  [    1.184745] xhci-hcd xhci-hcd.0.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000000000010010
    [2024-05-29 01:21:01]  [    1.185057] xhci-hcd xhci-hcd.0.auto: irq 269, io mem 0x31000000
    [2024-05-29 01:21:01]  [    1.185239] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
    [2024-05-29 01:21:01]  [    1.185257] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
    [2024-05-29 01:21:02]  [    1.185271] xhci-hcd xhci-hcd.0.auto: Host supports USB 3.0 SuperSpeed
    [2024-05-29 01:21:02]  [    1.185464] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
    [2024-05-29 01:21:02]  [    1.185473] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 01:21:02]  [    1.185480] usb usb1: Product: xHCI Host Controller
    [2024-05-29 01:21:02]  [    1.185484] usb usb1: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 01:21:02]  [    1.185490] usb usb1: SerialNumber: xhci-hcd.0.auto
    [2024-05-29 01:21:02]  [    1.186016] hub 1-0:1.0: USB hub found
    [2024-05-29 01:21:02]  [    1.186048] hub 1-0:1.0: 1 port detected
    [2024-05-29 01:21:02]  [    1.186399] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
    [2024-05-29 01:21:02]  [    1.186570] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
    [2024-05-29 01:21:02]  [    1.186578] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 01:21:02]  [    1.186585] usb usb2: Product: xHCI Host Controller
    [2024-05-29 01:21:02]  [    1.186589] usb usb2: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 01:21:02]  [    1.186595] usb usb2: SerialNumber: xhci-hcd.0.auto
    [2024-05-29 01:21:02]  [    1.186970] hub 2-0:1.0: USB hub found
    [2024-05-29 01:21:02]  [    1.187003] hub 2-0:1.0: config failed, hub doesn't have any ports! (err -19)
    [2024-05-29 01:21:02]  [    1.188669] dwc3-am62 f910000.dwc3-usb: lockup ldo_en wa
    [2024-05-29 01:21:02]  [    1.189770] dwc3 31100000.usb: Configuration mismatch. dr_mode forced to host
    [2024-05-29 01:21:02]  [    1.190100] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
    [2024-05-29 01:21:02]  [    1.190122] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 3
    [2024-05-29 01:21:02]  [    1.190288] xhci-hcd xhci-hcd.1.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000000000010010
    [2024-05-29 01:21:02]  [    1.190601] xhci-hcd xhci-hcd.1.auto: irq 270, io mem 0x31100000
    [2024-05-29 01:21:02]  [    1.190779] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
    [2024-05-29 01:21:02]  [    1.190792] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 4
    [2024-05-29 01:21:02]  [    1.190805] xhci-hcd xhci-hcd.1.auto: Host supports USB 3.0 SuperSpeed
    [2024-05-29 01:21:02]  [    1.190972] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
    [2024-05-29 01:21:02]  [    1.190981] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 01:21:02]  [    1.190987] usb usb3: Product: xHCI Host Controller
    [2024-05-29 01:21:02]  [    1.190992] usb usb3: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 01:21:02]  [    1.190997] usb usb3: SerialNumber: xhci-hcd.1.auto
    [2024-05-29 01:21:02]  [    1.191481] hub 3-0:1.0: USB hub found
    [2024-05-29 01:21:02]  [    1.191515] hub 3-0:1.0: 1 port detected
    [2024-05-29 01:21:02]  [    1.191854] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
    [2024-05-29 01:21:02]  [    1.191966] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
    [2024-05-29 01:21:02]  [    1.191974] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 01:21:02]  [    1.191980] usb usb4: Product: xHCI Host Controller
    [2024-05-29 01:21:02]  [    1.191984] usb usb4: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 01:21:02]  [    1.191990] usb usb4: SerialNumber: xhci-hcd.1.auto
    [2024-05-29 01:21:02]  [    1.192357] hub 4-0:1.0: USB hub found
    [2024-05-29 01:21:02]  [    1.192387] hub 4-0:1.0: config failed, hub doesn't have any ports! (err -19)
    [2024-05-29 01:21:02]  [    1.194436] input: pwm-beeper as /devices/platform/buzzer/input/input0
    [2024-05-29 01:21:02]  [    1.298069] mmc0: CQHCI version 5.10
    [2024-05-29 01:21:02]  [    1.299774] davinci-mcasp 2b10000.mcasp: IRQ common not found
    [2024-05-29 01:21:02]  [    1.348140] mmc1: CQHCI version 5.10
    [2024-05-29 01:21:02]  [    1.350432] mmc0: SDHCI controller on fa10000.mmc [fa10000.mmc] using ADMA 64-bit
    [2024-05-29 01:21:02]  [    1.360160] sdhci-am654 fa20000.mmc: parsing dt failed (-517)
    [2024-05-29 01:21:02]  [    1.381502] mmc1: SDHCI controller on fa00000.mmc [fa00000.mmc] using ADMA 64-bit
    [2024-05-29 01:21:02]  [    1.447674] mmc0: Command Queue Engine enabled
    [2024-05-29 01:21:02]  [    1.447691] mmc0: new HS200 MMC card at address 0001
    [2024-05-29 01:21:02]  [    1.448389] mmcblk0: mmc0:0001 S40004 3.64 GiB 
    [2024-05-29 01:21:02]  [    1.448624] mmcblk0boot0: mmc0:0001 S40004 partition 1 4.00 MiB
    [2024-05-29 01:21:02]  [    1.448829] mmcblk0boot1: mmc0:0001 S40004 partition 2 4.00 MiB
    [2024-05-29 01:21:02]  [    1.449046] mmcblk0rpmb: mmc0:0001 S40004 partition 3 4.00 MiB, chardev (238:0)
    [2024-05-29 01:21:02]  [    1.450579]  mmcblk0: p1 p2
    [2024-05-29 01:21:02]  [    1.523032] mmc1: new high speed SDHC card at address aaaa
    [2024-05-29 01:21:02]  [    1.523782] mmcblk1: mmc1:aaaa SC16G 14.8 GiB 
    [2024-05-29 01:21:02]  [    1.527022]  mmcblk1: p1 p2
    [2024-05-29 01:21:02]  [    1.684134] <<-GTP-INFO->> GTP Driver Version: V2.4<2014/11/28>
    [2024-05-29 01:21:02]  [    1.684147] <<-GTP-INFO->> GTP I2C Address: 0x14
    [2024-05-29 01:21:02]  [    1.770993] <<-GTP-INFO->> IC Version: 911_1060
    [2024-05-29 01:21:02]  [    1.773128] <<-GTP-INFO->> Sensor_ID: 2
    [2024-05-29 01:21:02]  [    1.773136] <<-GTP-INFO->> Config group2 used,length: 186
    [2024-05-29 01:21:02]  [    1.774203] <<-GTP-INFO->> Driver send config.
    [2024-05-29 01:21:02]  [    1.796124] <<-GTP-INFO->> X_MAX: 1280, Y_MAX: 800, TRIGGER: 0x03
    [2024-05-29 01:21:02]  [    1.807635] input: goodix-ts as /devices/virtual/input/input1
    [2024-05-29 01:21:02]  [    1.808000] genirq: Setting trigger mode 4 for irq 340 failed (gpio_irq_type+0x0/0x18)
    [2024-05-29 01:21:02]  [    1.808056] <<-GTP-INFO->> GTP works in polling mode.
    [2024-05-29 01:21:02]  [    1.808548] <<-GTP-INFO->> GTP Driver Version: V2.4<2014/11/28>
    [2024-05-29 01:21:02]  [    1.808552] <<-GTP-INFO->> GTP I2C Address: 0x14
    [2024-05-29 01:21:02]  [    1.906895] <<-GTP-INFO->> IC Version: 911_1060
    [2024-05-29 01:21:02]  [    1.907525] <<-GTP-INFO->> Sensor_ID: 2
    [2024-05-29 01:21:02]  [    1.907532] <<-GTP-INFO->> Config group2 used,length: 186
    [2024-05-29 01:21:02]  [    1.907846] <<-GTP-INFO->> Driver send config.
    [2024-05-29 01:21:02]  [    1.913344] <<-GTP-INFO->> X_MAX: 1280, Y_MAX: 800, TRIGGER: 0x03
    [2024-05-29 01:21:02]  [    1.924624] input: goodix-ts as /devices/virtual/input/input2
    [2024-05-29 01:21:02]  [    1.924904] genirq: Setting trigger mode 4 for irq 367 failed (gpio_irq_type+0x0/0x18)
    [2024-05-29 01:21:02]  [    1.924948] <<-GTP-INFO->> GTP works in polling mode.
    [2024-05-29 01:21:02]  [    1.925434] pwm-backlight backlight: supply power not found, using dummy regulator
    [2024-05-29 01:21:02]  [    1.932527] [drm] Initialized tidss 1.0.0 20180215 for 30200000.dss on minor 0
    [2024-05-29 01:21:02]  [    1.974243] Console: switching to colour frame buffer device 160x50
    [2024-05-29 01:21:02]  [    1.991913] tidss 30200000.dss: [drm] fb0: tidssdrmfb frame buffer device
    [2024-05-29 01:21:02]  [    2.004645] sdhci-am654 fa20000.mmc: allocated mmc-pwrseq
    [2024-05-29 01:21:02]  [    2.006359] mmc2: CQHCI version 5.10
    [2024-05-29 01:21:02]  [    2.021088] debugfs: Directory 'pd:53' with parent 'pm_genpd' already present!
    [2024-05-29 01:21:02]  [    2.021150] debugfs: Directory 'pd:52' with parent 'pm_genpd' already present!
    [2024-05-29 01:21:02]  [    2.021190] debugfs: Directory 'pd:51' with parent 'pm_genpd' already present!
    [2024-05-29 01:21:02]  [    2.021742] debugfs: Directory 'pd:182' with parent 'pm_genpd' already present!
    [2024-05-29 01:21:02]  [    2.027060] of_cfs_init
    [2024-05-29 01:21:02]  [    2.027119] of_cfs_init: OK
    [2024-05-29 01:21:02]  [    2.030252] pd-gpio powerdown: driver probe success!
    [2024-05-29 01:21:02]  [    2.044538] mmc2: SDHCI controller on fa20000.mmc [fa20000.mmc] using ADMA 64-bit
    [2024-05-29 01:21:02]  [    2.072245] mmc2: queuing unknown CIS tuple 0x80 (2 bytes)
    [2024-05-29 01:21:02]  [    2.073747] mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
    [2024-05-29 01:21:02]  [    2.074400] ALSA device list:
    [2024-05-29 01:21:02]  [    2.074404]   No soundcards found.
    [2024-05-29 01:21:02]  [    2.076606] mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
    [2024-05-29 01:21:02]  [    2.080339] mmc2: queuing unknown CIS tuple 0x80 (7 bytes)
    [2024-05-29 01:21:02]  [    2.081243] mmc2: queuing unknown CIS tuple 0x81 (1 bytes)
    [2024-05-29 01:21:02]  [    2.117779] Freeing unused kernel memory: 1792K
    [2024-05-29 01:21:02]  [    2.117908] Run /init as init process
    [2024-05-29 01:21:02]  [    2.179709] mmc2: new high speed SDIO card at address 0001
    [2024-05-29 01:21:02]  [    2.461032] usb 3-1: new high-speed USB device number 2 using xhci-hcd
    [2024-05-29 01:21:02]  [    2.513913] usb 1-1: new high-speed USB device number 2 using xhci-hcd
    [2024-05-29 01:21:02]  [    2.595477] usb 3-1: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.00
    [2024-05-29 01:21:02]  [    2.595502] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    [2024-05-29 01:21:02]  [    2.595510] usb 3-1: Product: Cruzer Blade
    [2024-05-29 01:21:02]  [    2.595515] usb 3-1: Manufacturer: SanDisk
    [2024-05-29 01:21:02]  [    2.595519] usb 3-1: SerialNumber: 4C530000291216110465
    [2024-05-29 01:21:02]  [    2.597805] usb-storage 3-1:1.0: USB Mass Storage device detected
    [2024-05-29 01:21:02]  [    2.612393] scsi host0: usb-storage 3-1:1.0
    [2024-05-29 01:21:02]  [    2.643632] usb 1-1: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.00
    [2024-05-29 01:21:02]  [    2.643656] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    [2024-05-29 01:21:02]  [    2.643663] usb 1-1: Product: Cruzer Blade
    [2024-05-29 01:21:02]  [    2.643668] usb 1-1: Manufacturer: SanDisk
    [2024-05-29 01:21:02]  [    2.643673] usb 1-1: SerialNumber: 03025431092423133207
    [2024-05-29 01:21:02]  [    2.900907] usb-storage 1-1:1.0: USB Mass Storage device detected
    [2024-05-29 01:21:02]  [    2.950498] scsi host1: usb-storage 1-1:1.0
    [2024-05-29 01:21:02]  Begin: Loading essential drivers ... done.
    [2024-05-29 01:21:02]  Spawning shell within the initramfs
    [2024-05-29 01:21:02]  
    [2024-05-29 01:21:02]  
    [2024-05-29 01:21:02]  BusyBox v1.30.1 (Ubuntu 1:1.30.1-4ubuntu6.4) built-in shell (ash)
    [2024-05-29 01:21:02]  Enter 'help' for a list of built-in commands.
    [2024-05-29 01:21:02]  
    [2024-05-29 01:21:02]  (initramfs) [    3.888636] scsi 0:0:0:0: Direct-Access     SanDisk  Cruzer Blade     1.00 PQ: 0 ANSI: 6
    [2024-05-29 01:21:03]  [    3.896764] sd 0:0:0:0: [sda] 15630336 512-byte logical blocks: (8.00 GB/7.45 GiB)
    [2024-05-29 01:21:03]  [    3.897812] sd 0:0:0:0: [sda] Write Protect is off
    [2024-05-29 01:21:03]  [    3.898117] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
    [2024-05-29 01:21:03]  [    3.923061]  sda: sda1
    [2024-05-29 01:21:03]  [    3.928665] sd 0:0:0:0: [sda] Attached SCSI removable disk
    [2024-05-29 01:21:03]  [    3.952609] scsi 1:0:0:0: Direct-Access     SanDisk  Cruzer Blade     1.00 PQ: 0 ANSI: 6
    [2024-05-29 01:21:03]  [    3.958990] sd 1:0:0:0: [sdb] 60088320 512-byte logical blocks: (30.8 GB/28.7 GiB)
    [2024-05-29 01:21:03]  [    3.959756] sd 1:0:0:0: [sdb] Write Protect is off
    [2024-05-29 01:21:03]  [    3.960105] sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
    [2024-05-29 01:21:03]  [    4.005256]  sdb: sdb1
    [2024-05-29 01:21:03]  [    4.012077] sd 1:0:0:0: [sdb] Attached SCSI removable disk
    [2024-05-29 01:21:03]  
    [2024-05-29 01:21:04]  (initramfs) 
    [2024-05-29 01:21:05]  (initramfs) [   17.277475] random: crng init done
    [2024-05-29 01:21:16]  

     R5 U-Boot defconfig file:

    CONFIG_ARM=y
    CONFIG_ARCH_K3=y
    CONFIG_TI_SECURE_DEVICE=y
    CONFIG_SYS_TEXT_BASE=0x83000000
    CONFIG_SPL_LIBCOMMON_SUPPORT=y
    CONFIG_SPL_LIBGENERIC_SUPPORT=y
    CONFIG_SYS_MALLOC_F_LEN=0x7000
    CONFIG_NR_DRAM_BANKS=2
    CONFIG_SOC_K3_AM625=y
    CONFIG_TARGET_AM625_R5_EVM=y
    CONFIG_ENV_SIZE=0x20000
    CONFIG_ENV_OFFSET=0x680000
    CONFIG_SYS_SPI_U_BOOT_OFFS=0x80000
    CONFIG_DM_GPIO=y
    CONFIG_SPL_DM_GPIO=y
    CONFIG_DA8XX_GPIO=y
    CONFIG_SPL_GPIO_SUPPORT=y
    # CONFIG_CMD_GPIO is not set
    # CONFIG_WATCHDOG is not set
    CONFIG_SPL_WATCHDOG_SUPPORT=y
    CONFIG_SPL_DM_SPI=y
    CONFIG_SPL_TEXT_BASE=0x43c00000
    CONFIG_SPL_MMC_SUPPORT=y
    CONFIG_SPL_SERIAL_SUPPORT=y
    CONFIG_SPL_DRIVERS_MISC_SUPPORT=y
    CONFIG_SPL_STACK_R_ADDR=0x89000000
    CONFIG_SPL_SIZE_LIMIT=0x3A7F0
    CONFIG_SPL_SIZE_LIMIT_SUBTRACT_MALLOC=y
    CONFIG_SPL_SIZE_LIMIT_SUBTRACT_GD=y
    CONFIG_SPL_SIZE_LIMIT_PROVIDE_STACK=0x3500
    CONFIG_SPL_FS_FAT=y
    CONFIG_SPL_LIBDISK_SUPPORT=y
    CONFIG_SPL_SPI_FLASH_SUPPORT=y
    CONFIG_SPL_SPI_SUPPORT=y
    CONFIG_DEFAULT_DEVICE_TREE="k3-am625-r5-sk"
    CONFIG_SPL_LOAD_FIT=y
    CONFIG_SPL_LOAD_FIT_ADDRESS=0x84000000
    CONFIG_SPL_FIT_IMAGE_POST_PROCESS=y
    # CONFIG_DISPLAY_CPUINFO is not set
    CONFIG_SPL_SYS_REPORT_STACK_F_USAGE=y
    CONFIG_SPL_SYS_MALLOC_SIMPLE=y
    CONFIG_SPL_STACK_R=y
    CONFIG_SPL_SEPARATE_BSS=y
    CONFIG_SPL_EARLY_BSS=y
    CONFIG_SYS_MMCSD_RAW_MODE_U_BOOT_USE_SECTOR=y
    CONFIG_SYS_MMCSD_RAW_MODE_U_BOOT_SECTOR=0x400
    CONFIG_SPL_DMA=y
    CONFIG_SPL_ENV_SUPPORT=y
    CONFIG_SPL_I2C_SUPPORT=y
    CONFIG_SPL_DM_MAILBOX=y
    CONFIG_SPL_DM_SPI_FLASH=y
    CONFIG_SPL_DM_RESET=y
    CONFIG_SPL_POWER_DOMAIN=y
    CONFIG_SPL_RAM_SUPPORT=y
    CONFIG_SPL_RAM_DEVICE=y
    CONFIG_SPL_REMOTEPROC=y
    # CONFIG_SPL_SPI_FLASH_TINY is not set
    CONFIG_SPL_SPI_FLASH_SFDP_SUPPORT=y
    CONFIG_SPL_SPI_LOAD=y
    CONFIG_SPL_THERMAL=y
    CONFIG_SPL_YMODEM_SUPPORT=y
    CONFIG_HUSH_PARSER=y
    CONFIG_CMD_ASKENV=y
    CONFIG_CMD_DFU=y
    CONFIG_CMD_GPT=y
    CONFIG_CMD_MMC=y
    CONFIG_CMD_REMOTEPROC=y
    # CONFIG_CMD_SETEXPR is not set
    CONFIG_CMD_TIME=y
    CONFIG_CMD_FAT=y
    CONFIG_OF_CONTROL=y
    CONFIG_SPL_OF_CONTROL=y
    CONFIG_SPL_MULTI_DTB_FIT=y
    CONFIG_SPL_MULTI_DTB_FIT_NO_COMPRESSION=y
    CONFIG_ENV_IS_IN_MMC=y
    CONFIG_SYS_RELOC_GD_ENV_ADDR=y
    CONFIG_SYS_MMC_ENV_PART=2
    CONFIG_DM=y
    CONFIG_SPL_DM=y
    CONFIG_SPL_DM_SEQ_ALIAS=y
    CONFIG_REGMAP=y
    CONFIG_SPL_REGMAP=y
    CONFIG_SPL_OF_TRANSLATE=y
    CONFIG_CLK=y
    CONFIG_SPL_CLK=y
    CONFIG_SPL_CLK_CCF=y
    CONFIG_SPL_CLK_K3=y
    CONFIG_SPL_CLK_K3_PLL=y
    CONFIG_DMA_CHANNELS=y
    CONFIG_TI_K3_NAVSS_UDMA=y
    CONFIG_TI_SCI_PROTOCOL=y
    CONFIG_DM_I2C=y
    CONFIG_SYS_I2C_OMAP24XX=y
    CONFIG_DM_MAILBOX=y
    CONFIG_K3_SEC_PROXY=y
    CONFIG_DM_MMC=y
    CONFIG_SPL_MMC_HS200_SUPPORT=y
    CONFIG_MMC_SDHCI=y
    CONFIG_MMC_SDHCI_ADMA=y
    CONFIG_SPL_MMC_SDHCI_ADMA=y
    CONFIG_MMC_SDHCI_AM654=y
    CONFIG_DM_SPI_FLASH=y
    CONFIG_SF_DEFAULT_MODE=0
    CONFIG_SPI_FLASH_ISSI=y
    CONFIG_SPI_FLASH_SFDP_SUPPORT=y
    CONFIG_SPI_FLASH_SOFT_RESET=y
    CONFIG_SPI_FLASH_SOFT_RESET_ON_BOOT=y
    CONFIG_SPI_FLASH_SPANSION=n
    CONFIG_SPI_FLASH_S28HS512T=n
    CONFIG_SPI_FLASH_STMICRO=n
    CONFIG_SPI_FLASH_MT35XU=n
    CONFIG_PINCTRL=y
    # CONFIG_PINCTRL_GENERIC is not set
    CONFIG_SPL_PINCTRL=y
    # CONFIG_SPL_PINCTRL_GENERIC is not set
    CONFIG_PINCTRL_SINGLE=y
    CONFIG_POWER_DOMAIN=y
    CONFIG_TI_POWER_DOMAIN=y
    CONFIG_K3_SYSTEM_CONTROLLER=y
    CONFIG_REMOTEPROC_TI_K3_ARM64=y
    CONFIG_DM_RESET=y
    CONFIG_RESET_TI_SCI=y
    CONFIG_SPECIFY_CONSOLE_INDEX=y
    CONFIG_DM_SERIAL=y
    CONFIG_SOC_DEVICE=y
    CONFIG_SOC_DEVICE_TI_K3=y
    CONFIG_SOC_TI=y
    CONFIG_SPI=y
    CONFIG_DM_SPI=y
    CONFIG_CADENCE_QSPI=y
    CONFIG_CADENCE_QSPI_PHY=y
    CONFIG_DM_THERMAL=y
    CONFIG_TIMER=y
    CONFIG_SPL_TIMER=y
    CONFIG_OMAP_TIMER=y
    CONFIG_LIB_RATIONAL=y
    CONFIG_SPL_LIB_RATIONAL=y
    CONFIG_SPL_BOARD_INIT=y
    CONFIG_ESM_K3=y
    CONFIG_BOOTDELAY=1
    CONFIG_ZY_SECURITY=n
    CONFIG_SYS_MMCSD_FS_BOOT_PARTITION=1


    Regards,

    Li

  • Hello,

    Thank you for sharing the logs.

    [2024-05-29 01:20:48] loadables: 'kernel'
    [2024-05-29 01:20:48] spl_load_fit_image:281
    [2024-05-29 01:20:48] External data: dst=80080000, offset=97ca8, size=121e067
    [2024-05-29 01:20:55] spl_load_fit_image:339

    So, the issue here is the ~7s time taken to load the ~18MB Kernel image. Is this correct?

    Regards,

    Prashant

  • Hello,
    Yes, you're right

    Regards,

    Li

  • Hello,

    I recently supported a similar issue for AM62A which was root caused to eMMC DMA not enabled in the R5 U-Boot defconfig

    https://e2e.ti.com/support/processors-group/processors/f/processors-forum/1355370/sk-am62a-lp-load-speed-problem-with-emmc-in-falcon-boot-mode-sdk-version-09_02_00_05

    This is already enabled in your defconfig so the issue is coming from somewhere else.

    Can you please enable MMC debug logs like suggested here

    https://e2e.ti.com/support/processors-group/processors/f/processors-forum/1316879/sk-am62a-lp-load-speed-problem-with-emmc-in-falcon-boot-mode/5007636#5007636

    Regards,

    Prashant

  • Hello,

    After opening the debugging of mmc.c, the output log after power on is as follows:

    =~=~=~=~=~=~=~=~=~=~=~= MobaXterm log 2024.05.29 06:45:10 =~=~=~=~=~=~=~=~=~=~=~=
    
    [2024-05-29 06:45:10]  U-Boot SPL 2021.01-00003-gf4dc0be4cb-dirty (May 29 2024 - 06:35:05 +0000)
    [2024-05-29 06:45:10]  SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [2024-05-29 06:45:10]  TLB table from bfffc000 to c0000000
    [2024-05-29 06:45:10]  SPL initial stack usage: 13424 bytes
    [2024-05-29 06:45:10]  SPL malloc() before relocation used 0x6aa0 bytes (26 KB)
    [2024-05-29 06:45:10]  >>SPL: board_init_r()
    [2024-05-29 06:45:10]  spl_init
    [2024-05-29 06:45:10]  WDT:   Not found!
    [2024-05-29 06:45:10]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:10]  spl_ll_find_loader:506 loader:MMC1 device:9
    [2024-05-29 06:45:10]  spl_ll_find_loader:508 loader:MMC1 device:9
    [2024-05-29 06:45:10]  Trying to boot from MMC1
    [2024-05-29 06:45:10]  clock is disabled (0Hz)
    [2024-05-29 06:45:10]  clock is enabled (400000Hz)
    [2024-05-29 06:45:10]  clock is enabled (25000000Hz)
    [2024-05-29 06:45:10]  clock is enabled (25000000Hz)
    [2024-05-29 06:45:10]  clock is enabled (25000000Hz)
    [2024-05-29 06:45:10]  clock is enabled (25000000Hz)
    [2024-05-29 06:45:10]  clock is enabled (25000000Hz)
    [2024-05-29 06:45:10]  clock is enabled (25000000Hz)
    [2024-05-29 06:45:10]  spl: mmc boot mode: fs
    [2024-05-29 06:45:10]  spl_mmc_load:422 fit:atf-tee-dm-kernel-fdt.bin
    [2024-05-29 06:45:10]  spl_mmc_do_fs_boot:269
    [2024-05-29 06:45:10]  spl_load_image_fat:64 filename:atf-tee-dm-kernel-fdt.bin partition:1
    [2024-05-29 06:45:10]  spl_load_image_fat:91
    [2024-05-29 06:45:10]  Found FIT
    [2024-05-29 06:45:10]  fit read sector 0, sectors=1552, dst=82fff9c0, count=1552, size=0x610
    [2024-05-29 06:45:10]  firmware: 'atf'
    [2024-05-29 06:45:10]  spl_load_simple_fit:650
    [2024-05-29 06:45:10]  spl_load_fit_image:281
    [2024-05-29 06:45:10]  External data: dst=9e780000, offset=610, size=b27e
    [2024-05-29 06:45:10]  spl_load_fit_image:339
    [2024-05-29 06:45:10]  board_fit_image_post_process: processing image: addr=9e780000, size=45694, os=arm-trusted-firmware
    [2024-05-29 06:45:10]  board_fit_image_post_process: matched image for ID 0
    [2024-05-29 06:45:10]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 06:45:10]  Authenticating image of size 45694 bytes
    [2024-05-29 06:45:10]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:10]  Authentication passed
    [2024-05-29 06:45:10]  
    [2024-05-29 06:45:10]  spl_load_fit_image:353
    [2024-05-29 06:45:10]  spl_load_fit_image:363
    [2024-05-29 06:45:10]  spl_load_fit_image:365
    [2024-05-29 06:45:10]  spl_load_fit_image:373
    [2024-05-29 06:45:10]  Image OS is ARM Trusted Firmware
    [2024-05-29 06:45:10]  loadables: 'tee'
    [2024-05-29 06:45:10]  spl_load_fit_image:281
    [2024-05-29 06:45:10]  External data: dst=9e800000, offset=b890, size=68ee6
    [2024-05-29 06:45:10]  spl_load_fit_image:339
    [2024-05-29 06:45:10]  board_fit_image_post_process: processing image: addr=9e800000, size=429798, os=tee
    [2024-05-29 06:45:10]  board_fit_image_post_process: matched image for ID 1
    [2024-05-29 06:45:10]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 06:45:10]  Authenticating image of size 429798 bytes
    [2024-05-29 06:45:10]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:10]  Authentication passed
    [2024-05-29 06:45:10]  
    [2024-05-29 06:45:10]  spl_load_fit_image:353
    [2024-05-29 06:45:10]  spl_load_fit_image:363
    [2024-05-29 06:45:10]  spl_load_fit_image:365
    [2024-05-29 06:45:10]  spl_load_fit_image:373
    [2024-05-29 06:45:10]  Loadable is Trusted Execution Environment
    [2024-05-29 06:45:10]  loadables: 'dm'
    [2024-05-29 06:45:10]  spl_load_fit_image:281
    [2024-05-29 06:45:10]  External data: dst=89000000, offset=74778, size=2352e
    [2024-05-29 06:45:10]  spl_load_fit_image:339
    [2024-05-29 06:45:10]  board_fit_image_post_process: processing image: addr=89000000, size=144686, os=DM
    [2024-05-29 06:45:10]  board_fit_image_post_process: matched image for ID 3
    [2024-05-29 06:45:10]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 06:45:10]  Authenticating image of size 144686 bytes
    [2024-05-29 06:45:10]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:10]  Authentication passed
    [2024-05-29 06:45:10]  
    [2024-05-29 06:45:10]  spl_load_fit_image:353
    [2024-05-29 06:45:10]  spl_load_fit_image:363
    [2024-05-29 06:45:10]  spl_load_fit_image:365
    [2024-05-29 06:45:10]  spl_load_fit_image:373
    [2024-05-29 06:45:10]  Loadable is Unknown OS
    [2024-05-29 06:45:10]  loadables: 'kernel'
    [2024-05-29 06:45:10]  spl_load_fit_image:281
    [2024-05-29 06:45:10]  External data: dst=80080000, offset=97ca8, size=121e067
    [2024-05-29 06:45:17]  spl_load_fit_image:339
    [2024-05-29 06:45:17]  board_fit_image_post_process: processing image: addr=80080000, size=18997351, os=linux
    [2024-05-29 06:45:17]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 06:45:17]  Authenticating image of size 18997351 bytes
    [2024-05-29 06:45:17]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:17]  Authentication passed
    [2024-05-29 06:45:17]  
    [2024-05-29 06:45:17]  spl_load_fit_image:353
    [2024-05-29 06:45:17]  spl_load_fit_image:363
    [2024-05-29 06:45:17]  spl_load_fit_image:365
    [2024-05-29 06:45:17]  spl_load_fit_image:373
    [2024-05-29 06:45:17]  Loadable is Linux
    [2024-05-29 06:45:17]  loadables: 'ramdisk'
    [2024-05-29 06:45:17]  spl_load_fit_image:281
    [2024-05-29 06:45:17]  External data: dst=81600000, offset=12b5d10, size=8bb7c1
    [2024-05-29 06:45:20]  spl_load_fit_image:339
    [2024-05-29 06:45:20]  board_fit_image_post_process: processing image: addr=81600000, size=9156545, os=linux
    [2024-05-29 06:45:20]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 06:45:20]  Authenticating image of size 9156545 bytes
    [2024-05-29 06:45:20]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:20]  Authentication passed
    [2024-05-29 06:45:20]  
    [2024-05-29 06:45:20]  spl_load_fit_image:353
    [2024-05-29 06:45:20]  spl_load_fit_image:363
    [2024-05-29 06:45:20]  spl_load_fit_image:365
    [2024-05-29 06:45:20]  spl_load_fit_image:373
    [2024-05-29 06:45:20]  Loadable is Linux
    [2024-05-29 06:45:20]  loadables: 'fdt'
    [2024-05-29 06:45:20]  spl_load_fit_image:281
    [2024-05-29 06:45:20]  External data: dst=82000000, offset=1b714d4, size=11c60
    [2024-05-29 06:45:20]  spl_load_fit_image:339
    [2024-05-29 06:45:20]  board_fit_image_post_process: processing image: addr=ffffffff, size=72800, os=
    [2024-05-29 06:45:20]  Authenticating image at address 0x0000000000000000x
    [2024-05-29 06:45:20]  Authenticating image of size 72800 bytes
    [2024-05-29 06:45:20]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:20]  Authentication passed
    [2024-05-29 06:45:20]  
    [2024-05-29 06:45:20]  spl_load_fit_image:353
    [2024-05-29 06:45:20]  spl_load_fit_image:363
    [2024-05-29 06:45:20]  spl_load_fit_image:368
    [2024-05-29 06:45:20]  spl_load_fit_image:373
    [2024-05-29 06:45:20]  no string for index 5
    [2024-05-29 06:45:20]  spl_load_simple_fit:691
    [2024-05-29 06:45:20]  spl_mmc_do_fs_boot:274
    [2024-05-29 06:45:20]  Unsupported OS image.. Jumping nevertheless..
    [2024-05-29 06:45:20]  loaded - jumping to U-Boot...
    [2024-05-29 06:45:20]  Loading Environment from MMC... MMC: block number 0x3500 exceeds max(0x2000)
    [2024-05-29 06:45:20]  *** Warning - !read failed, using default environment
    [2024-05-29 06:45:20]  
    [2024-05-29 06:45:20]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:21]  am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    [2024-05-29 06:45:21]  init_env from device 9 not supported!
    [2024-05-29 06:45:21]  jump_to_image_no_args:245
    [2024-05-29 06:45:21]  jump_to_image_no_args:248
    [2024-05-29 06:45:21]  Loading phdr 0 to 0x41010040 (4784 bytes)
    [2024-05-29 06:45:21]  Loading phdr 1 to 0x410112f0 (432 bytes)
    [2024-05-29 06:45:21]  Loading phdr 2 to 0x410114a0 (408 bytes)
    [2024-05-29 06:45:21]  Loading phdr 3 to 0x41011a40 (4424 bytes)
    [2024-05-29 06:45:21]  Loading phdr 4 to 0x9db00000 (4096 bytes)
    [2024-05-29 06:45:21]  Loading phdr 5 to 0x9dc00000 (0 bytes)
    [2024-05-29 06:45:21]  Loading phdr 6 to 0x9dc00680 (0 bytes)
    [2024-05-29 06:45:21]  Loading phdr 7 to 0x9dc18f00 (88304 bytes)
    [2024-05-29 06:45:21]  Loading phdr 8 to 0x9dc2e7f0 (0 bytes)
    [2024-05-29 06:45:21]  Loading phdr 9 to 0x9dc3e7f0 (27672 bytes)
    [2024-05-29 06:45:21]  Loading phdr 10 to 0x9dc45480 (5376 bytes)
    [2024-05-29 06:45:21]  Loading phdr 11 to 0x9dc46980 (1922 bytes)
    [2024-05-29 06:45:21]  Loading phdr 12 to 0x9e6f6c00 (0 bytes)
    [2024-05-29 06:45:21]  Loading phdr 13 to 0x9e6f8000 (0 bytes)
    [2024-05-29 06:45:21]  jump_to_image_no_args: jumping to address 9dc2d320
    [2024-05-29 06:45:21]  Starting ATF on ARM64 core...
    [2024-05-29 06:45:21]  
    [2024-05-29 06:45:21]  NOTICE:  BL31: v2.8(release):v2.8-226-g2fcd408bb
    [2024-05-29 06:45:21]  NOTICE:  BL31: Built : 09:18:17, May 23 2024
    [2024-05-29 06:45:21]  I/TC: 
    [2024-05-29 06:45:21]  I/TC: OP-TEE version: Unknown_3.20 (gcc version 9.2.1 20191025 (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10))) #1 Thu May 23 01:18:46 UTC 2024 aarch64
    [2024-05-29 06:45:21]  I/TC: WARNING: This OP-TEE configuration might be insecure!
    [2024-05-29 06:45:21]  I/TC: WARNING: Please check https://optee.readthedocs.io/en/latest/architecture/porting_guidelines.html
    [2024-05-29 06:45:21]  I/TC: Primary CPU initializing
    [2024-05-29 06:45:21]  I/TC: SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [2024-05-29 06:45:21]  I/TC: HUK Initialized
    [2024-05-29 06:45:21]  I/TC: Activated SA2UL device
    [2024-05-29 06:45:21]  I/TC: Enabled firewalls for SA2UL TRNG device
    [2024-05-29 06:45:21]  I/TC: SA2UL TRNG initialized
    [2024-05-29 06:45:21]  I/TC: SA2UL Drivers initialized
    [2024-05-29 06:45:21]  I/TC: Primary CPU switching to normal world boot
    [2024-05-29 06:45:21]  I/TC: Secondary CPU 1 initializing
    [2024-05-29 06:45:21]  I/TC: Secondary CPU 1 switching to normal world boot
    [2024-05-29 06:45:21]  I/TC: Reserved shared memory is enabled
    [2024-05-29 06:45:21]  I/TC: Dynamic shared memory is enabled
    [2024-05-29 06:45:21]  I/TC: Normal World virtualization support is disabled
    [2024-05-29 06:45:21]  I/TC: Asynchronous notifications are disabled
    [2024-05-29 06:45:21]  [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
    [2024-05-29 06:45:22]  [    0.000000] Linux version 5.10.168-rt83-gc1a1291911 (root@ubuntu-1804) (aarch64-none-linux-gnu-gcc (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 9.2.1 20191025, GNU ld (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10)) 2.33.1.20191209) #13 SMP PREEMPT_RT Tue May 28 05:05:00 UTC 2024
    [2024-05-29 06:45:22]  [    0.000000] Machine model: ZHIYUAN Electronics AM62x
    [2024-05-29 06:45:22]  [    0.000000] efi: UEFI not found.
    [2024-05-29 06:45:22]  [    0.000000] [Firmware Bug]: Kernel image misaligned at boot, please fix your bootloader!
    [2024-05-29 06:45:22]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009c800000, size 3 MiB
    [2024-05-29 06:45:22]  [    0.000000] OF: reserved mem: initialized node ipc-memories@9c800000, compatible id shared-dma-pool
    [2024-05-29 06:45:22]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009cb00000, size 1 MiB
    [2024-05-29 06:45:22]  [    0.000000] OF: reserved mem: initialized node m4f-dma-memory@9cb00000, compatible id shared-dma-pool
    [2024-05-29 06:45:22]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009cc00000, size 14 MiB
    [2024-05-29 06:45:22]  [    0.000000] OF: reserved mem: initialized node m4f-memory@9cc00000, compatible id shared-dma-pool
    [2024-05-29 06:45:22]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009da00000, size 1 MiB
    [2024-05-29 06:45:22]  [    0.000000] OF: reserved mem: initialized node r5f-dma-memory@9da00000, compatible id shared-dma-pool
    [2024-05-29 06:45:22]  [    0.000000] Reserved memory: created DMA memory pool at 0x000000009db00000, size 12 MiB
    [2024-05-29 06:45:22]  [    0.000000] OF: reserved mem: initialized node r5f-memory@9db00000, compatible id shared-dma-pool
    [2024-05-29 06:45:22]  [    0.000000] Zone ranges:
    [2024-05-29 06:45:22]  [    0.000000]   DMA      [mem 0x0000000080000000-0x00000000bfffffff]
    [2024-05-29 06:45:22]  [    0.000000]   DMA32    empty
    [2024-05-29 06:45:22]  [    0.000000]   Normal   empty
    [2024-05-29 06:45:22]  [    0.000000] Movable zone start for each node
    [2024-05-29 06:45:22]  [    0.000000] Early memory node ranges
    [2024-05-29 06:45:22]  [    0.000000]   node   0: [mem 0x0000000080000000-0x000000009c7fffff]
    [2024-05-29 06:45:22]  [    0.000000]   node   0: [mem 0x000000009c800000-0x000000009e6fffff]
    [2024-05-29 06:45:22]  [    0.000000]   node   0: [mem 0x000000009e700000-0x000000009e77ffff]
    [2024-05-29 06:45:22]  [    0.000000]   node   0: [mem 0x000000009e780000-0x000000009fffffff]
    [2024-05-29 06:45:22]  [    0.000000]   node   0: [mem 0x00000000a0000000-0x00000000bfffffff]
    [2024-05-29 06:45:22]  [    0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000000bfffffff]
    [2024-05-29 06:45:22]  [    0.000000] cma: Failed to reserve 512 MiB
    [2024-05-29 06:45:22]  [    0.000000] psci: probing for conduit method from DT.
    [2024-05-29 06:45:22]  [    0.000000] psci: PSCIv1.1 detected in firmware.
    [2024-05-29 06:45:22]  [    0.000000] psci: Using standard PSCI v0.2 function IDs
    [2024-05-29 06:45:22]  [    0.000000] psci: Trusted OS migration not required
    [2024-05-29 06:45:22]  [    0.000000] psci: SMC Calling Convention v1.2
    [2024-05-29 06:45:22]  [    0.000000] percpu: Embedded 18 pages/cpu s35392 r8192 d30144 u73728
    [2024-05-29 06:45:22]  [    0.000000] Detected VIPT I-cache on CPU0
    [2024-05-29 06:45:22]  [    0.000000] CPU features: detected: ARM erratum 845719
    [2024-05-29 06:45:22]  [    0.000000] CPU features: detected: GIC system register CPU interface
    [2024-05-29 06:45:22]  [    0.000000] CPU features: kernel page table isolation forced ON by KASLR
    [2024-05-29 06:45:22]  [    0.000000] CPU features: detected: Kernel page table isolation (KPTI)
    [2024-05-29 06:45:22]  [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 258048
    [2024-05-29 06:45:22]  [    0.000000] Kernel command line: console=ttyS2,115200n8 fbcon=logo-pos:center fbcon=logo-count:1 rw rootwait root=/dev/mmcblk0p2 break
    [2024-05-29 06:45:22]  [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
    [2024-05-29 06:45:22]  [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
    [2024-05-29 06:45:22]  [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
    [2024-05-29 06:45:22]  [    0.000000] Memory: 941544K/1048576K available (11392K kernel code, 1142K rwdata, 4124K rodata, 1792K init, 438K bss, 107032K reserved, 0K cma-reserved)
    [2024-05-29 06:45:22]  [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
    [2024-05-29 06:45:22]  [    0.000000] rcu: Preemptible hierarchical RCU implementation.
    [2024-05-29 06:45:22]  [    0.000000] rcu: RCU event tracing is enabled.
    [2024-05-29 06:45:22]  [    0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=2.
    [2024-05-29 06:45:22]  [    0.000000] rcu: RCU priority boosting: priority 1 delay 500 ms.
    [2024-05-29 06:45:22]  [    0.000000] rcu: RCU_SOFTIRQ processing moved to rcuc kthreads.
    [2024-05-29 06:45:22]  [    0.000000] No expedited grace period (rcu_normal_after_boot).
    [2024-05-29 06:45:22]  [    0.000000] Trampoline variant of Tasks RCU enabled.
    [2024-05-29 06:45:22]  [    0.000000] Tracing variant of Tasks RCU enabled.
    [2024-05-29 06:45:22]  [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
    [2024-05-29 06:45:22]  [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
    [2024-05-29 06:45:22]  [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
    [2024-05-29 06:45:22]  [    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
    [2024-05-29 06:45:22]  [    0.000000] GICv3: 256 SPIs implemented
    [2024-05-29 06:45:22]  [    0.000000] GICv3: 0 Extended SPIs implemented
    [2024-05-29 06:45:22]  [    0.000000] GICv3: Distributor has no Range Selector support
    [2024-05-29 06:45:22]  [    0.000000] GICv3: 16 PPIs implemented
    [2024-05-29 06:45:22]  [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001880000
    [2024-05-29 06:45:22]  [    0.000000] ITS [mem 0x01820000-0x0182ffff]
    [2024-05-29 06:45:22]  [    0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS
    [2024-05-29 06:45:22]  [    0.000000] ITS@0x0000000001820000: Devices Table too large, reduce ids 20->19
    [2024-05-29 06:45:22]  [    0.000000] ITS@0x0000000001820000: allocated 524288 Devices @82c00000 (flat, esz 8, psz 64K, shr 0)
    [2024-05-29 06:45:22]  [    0.000000] ITS: using cache flushing for cmd queue
    [2024-05-29 06:45:22]  [    0.000000] GICv3: using LPI property table @0x0000000082430000
    [2024-05-29 06:45:22]  [    0.000000] GIC: using cache flushing for LPI property table
    [2024-05-29 06:45:22]  [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000082440000
    [2024-05-29 06:45:22]  [    0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys).
    [2024-05-29 06:45:22]  [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns
    [2024-05-29 06:45:22]  [    0.000001] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
    [2024-05-29 06:45:22]  [    0.000349] Console: colour dummy device 80x25
    [2024-05-29 06:45:22]  [    0.000403] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=200000)
    [2024-05-29 06:45:22]  [    0.000416] pid_max: default: 32768 minimum: 301
    [2024-05-29 06:45:22]  [    0.000528] LSM: Security Framework initializing
    [2024-05-29 06:45:22]  [    0.000601] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
    [2024-05-29 06:45:22]  [    0.000618] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
    [2024-05-29 06:45:22]  [    0.002640] rcu: Hierarchical SRCU implementation.
    [2024-05-29 06:45:22]  [    0.003220] Platform MSI: msi-controller@1820000 domain created
    [2024-05-29 06:45:22]  [    0.003526] PCI/MSI: /bus@f0000/interrupt-controller@1800000/msi-controller@1820000 domain created
    [2024-05-29 06:45:22]  [    0.003638] EFI services will not be available.
    [2024-05-29 06:45:22]  [    0.003859] smp: Bringing up secondary CPUs ...
    [2024-05-29 06:45:22]  [    0.028263] Detected VIPT I-cache on CPU1
    [2024-05-29 06:45:22]  [    0.028305] GICv3: CPU1: found redistributor 1 region 0:0x00000000018a0000
    [2024-05-29 06:45:22]  [    0.028324] GICv3: CPU1: using allocated LPI pending table @0x0000000082450000
    [2024-05-29 06:45:22]  [    0.028386] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
    [2024-05-29 06:45:22]  [    0.028543] smp: Brought up 1 node, 2 CPUs
    [2024-05-29 06:45:22]  [    0.028549] SMP: Total of 2 processors activated.
    [2024-05-29 06:45:22]  [    0.028554] CPU features: detected: 32-bit EL0 Support
    [2024-05-29 06:45:22]  [    0.028560] CPU features: detected: CRC32 instructions
    [2024-05-29 06:45:22]  [    0.036072] CPU: All CPU(s) started at EL2
    [2024-05-29 06:45:22]  [    0.036092] alternatives: patching kernel code
    [2024-05-29 06:45:22]  [    0.037280] devtmpfs: initialized
    [2024-05-29 06:45:22]  [    0.047099] KASLR disabled due to lack of seed
    [2024-05-29 06:45:22]  [    0.047278] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
    [2024-05-29 06:45:22]  [    0.047299] futex hash table entries: 512 (order: 4, 65536 bytes, linear)
    [2024-05-29 06:45:22]  [    0.047598] pinctrl core: initialized pinctrl subsystem
    [2024-05-29 06:45:22]  [    0.048095] DMI not present or invalid.
    [2024-05-29 06:45:22]  [    0.048770] NET: Registered protocol family 16
    [2024-05-29 06:45:22]  [    0.049332] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
    [2024-05-29 06:45:22]  [    0.049366] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
    [2024-05-29 06:45:22]  [    0.049395] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
    [2024-05-29 06:45:22]  [    0.049972] thermal_sys: Registered thermal governor 'step_wise'
    [2024-05-29 06:45:22]  [    0.050690] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
    [2024-05-29 06:45:22]  [    0.050752] ASID allocator initialised with 32768 entries
    [2024-05-29 06:45:22]  [    0.085902] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
    [2024-05-29 06:45:22]  [    0.085917] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
    [2024-05-29 06:45:22]  [    0.085922] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
    [2024-05-29 06:45:22]  [    0.085926] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
    [2024-05-29 06:45:22]  [    0.087072] cryptd: max_cpu_qlen set to 1000
    [2024-05-29 06:45:22]  [    0.090557] k3-chipinfo 43000014.chipid: Family:AM62X rev:SR1.0 JTAGID[0x0bb7e02f] Detected
    [2024-05-29 06:45:22]  [    0.091425] vcc_5v0: supplied by vmain_pd
    [2024-05-29 06:45:22]  [    0.091854] vcc_3v3_sys: supplied by vmain_pd
    [2024-05-29 06:45:22]  [    0.092294] vdd_mmc1: supplied by vcc_3v3_sys
    [2024-05-29 06:45:22]  [    0.092594] wlan_en: supplied by vcc_3v3_sys
    [2024-05-29 06:45:22]  [    0.092855] vdd_io: supplied by vcc_3v3_sys
    [2024-05-29 06:45:22]  [    0.093549] vcc_1v8: supplied by vcc_3v3_sys
    [2024-05-29 06:45:22]  [    0.094451] iommu: Default domain type: Translated 
    [2024-05-29 06:45:22]  [    0.094806] SCSI subsystem initialized
    [2024-05-29 06:45:22]  [    0.094995] usbcore: registered new interface driver usbfs
    [2024-05-29 06:45:22]  [    0.095032] usbcore: registered new interface driver hub
    [2024-05-29 06:45:22]  [    0.095062] usbcore: registered new device driver usb
    [2024-05-29 06:45:22]  [    0.095661] mc: Linux media interface: v0.10
    [2024-05-29 06:45:22]  [    0.095688] videodev: Linux video capture interface: v2.00
    [2024-05-29 06:45:22]  [    0.095743] pps_core: LinuxPPS API ver. 1 registered
    [2024-05-29 06:45:22]  [    0.095747] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [2024-05-29 06:45:22]  [    0.095761] PTP clock support registered
    [2024-05-29 06:45:22]  [    0.095793] EDAC MC: Ver: 3.0.0
    [2024-05-29 06:45:22]  [    0.096595] omap-mailbox 29000000.mailbox: omap mailbox rev 0x66fc9100
    [2024-05-29 06:45:22]  [    0.097201] FPGA manager framework
    [2024-05-29 06:45:22]  [    0.097309] Advanced Linux Sound Architecture Driver Initialized.
    [2024-05-29 06:45:22]  [    0.098316] clocksource: Switched to clocksource arch_sys_counter
    [2024-05-29 06:45:22]  [    0.098526] VFS: Disk quotas dquot_6.6.0
    [2024-05-29 06:45:22]  [    0.098577] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
    [2024-05-29 06:45:22]  [    0.104915] NET: Registered protocol family 2
    [2024-05-29 06:45:22]  [    0.105129] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
    [2024-05-29 06:45:22]  [    0.106179] tcp_listen_portaddr_hash hash table entries: 512 (order: 3, 32768 bytes, linear)
    [2024-05-29 06:45:22]  [    0.106235] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
    [2024-05-29 06:45:22]  [    0.106350] TCP bind hash table entries: 8192 (order: 6, 458752 bytes, linear)
    [2024-05-29 06:45:22]  [    0.106768] TCP: Hash tables configured (established 8192 bind 8192)
    [2024-05-29 06:45:22]  [    0.106987] UDP hash table entries: 512 (order: 4, 65536 bytes, linear)
    [2024-05-29 06:45:22]  [    0.107076] UDP-Lite hash table entries: 512 (order: 4, 65536 bytes, linear)
    [2024-05-29 06:45:22]  [    0.107404] NET: Registered protocol family 1
    [2024-05-29 06:45:22]  [    0.108002] RPC: Registered named UNIX socket transport module.
    [2024-05-29 06:45:22]  [    0.108009] RPC: Registered udp transport module.
    [2024-05-29 06:45:22]  [    0.108013] RPC: Registered tcp transport module.
    [2024-05-29 06:45:22]  [    0.108016] RPC: Registered tcp NFSv4.1 backchannel transport module.
    [2024-05-29 06:45:22]  [    0.108024] NET: Registered protocol family 44
    [2024-05-29 06:45:23]  [    0.108044] PCI: CLS 0 bytes, default 64
    [2024-05-29 06:45:23]  [    0.108269] Trying to unpack rootfs image as initramfs...
    [2024-05-29 06:45:23]  [    0.461779] rootfs image is not initramfs (invalid magic at start of compressed archive); looks like an initrd
    [2024-05-29 06:45:23]  [    0.492974] Freeing initrd memory: 10240K
    [2024-05-29 06:45:23]  [    0.493698] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available
    [2024-05-29 06:45:23]  [    0.498230] Initialise system trusted keyrings
    [2024-05-29 06:45:23]  [    0.498695] workingset: timestamp_bits=46 max_order=18 bucket_order=0
    [2024-05-29 06:45:23]  [    0.503932] squashfs: version 4.0 (2009/01/31) Phillip Lougher
    [2024-05-29 06:45:23]  [    0.504647] NFS: Registering the id_resolver key type
    [2024-05-29 06:45:23]  [    0.504686] Key type id_resolver registered
    [2024-05-29 06:45:23]  [    0.504689] Key type id_legacy registered
    [2024-05-29 06:45:23]  [    0.504762] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
    [2024-05-29 06:45:23]  [    0.504767] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
    [2024-05-29 06:45:23]  [    0.505061] 9p: Installing v9fs 9p2000 file system support
    [2024-05-29 06:45:23]  [    0.539569] Key type asymmetric registered
    [2024-05-29 06:45:23]  [    0.539577] Asymmetric key parser 'x509' registered
    [2024-05-29 06:45:23]  [    0.539626] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)
    [2024-05-29 06:45:23]  [    0.539632] io scheduler mq-deadline registered
    [2024-05-29 06:45:23]  [    0.539637] io scheduler kyber registered
    [2024-05-29 06:45:23]  [    0.542365] pinctrl-single 4084000.pinctrl: 34 pins, size 136
    [2024-05-29 06:45:23]  [    0.542868] pinctrl-single f4000.pinctrl: 171 pins, size 684
    [2024-05-29 06:45:23]  [    0.543884] pinctrl-single a40000.pinctrl: 512 pins, size 2048
    [2024-05-29 06:45:23]  [    0.552802] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
    [2024-05-29 06:45:23]  [    0.566611] brd: module loaded
    [2024-05-29 06:45:23]  [    0.575071] loop: module loaded
    [2024-05-29 06:45:23]  [    0.578685] tun: Universal TUN/TAP device driver, 1.6
    [2024-05-29 06:45:23]  [    0.578921] CAN device driver interface
    [2024-05-29 06:45:23]  [    0.580568] PPP generic driver version 2.4.2
    [2024-05-29 06:45:23]  [    0.580743] PPP BSD Compression module registered
    [2024-05-29 06:45:23]  [    0.580748] PPP Deflate Compression module registered
    [2024-05-29 06:45:23]  [    0.580776] PPP MPPE Compression module registered
    [2024-05-29 06:45:23]  [    0.580781] NET: Registered protocol family 24
    [2024-05-29 06:45:23]  [    0.580958] VFIO - User Level meta-driver version: 0.3
    [2024-05-29 06:45:23]  [    0.582762] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    [2024-05-29 06:45:23]  [    0.582771] ehci-pci: EHCI PCI platform driver
    [2024-05-29 06:45:23]  [    0.582807] ehci-platform: EHCI generic platform driver
    [2024-05-29 06:45:23]  [    0.582977] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    [2024-05-29 06:45:23]  [    0.583013] ohci-pci: OHCI PCI platform driver
    [2024-05-29 06:45:23]  [    0.583044] ohci-platform: OHCI generic platform driver
    [2024-05-29 06:45:23]  [    0.583707] usbcore: registered new interface driver usb-storage
    [2024-05-29 06:45:23]  [    0.583766] udc-core: couldn't find an available UDC - added [g_mass_storage] to list of pending drivers
    [2024-05-29 06:45:23]  [    0.584213] i2c /dev entries driver
    [2024-05-29 06:45:23]      0.585506] sdhci: Secure Digital Host Controller Interface driver
    [2024-05-29 06:45:23]  [    0.585511] sdhci: Copyright(c) Pierre Ossman
    [2024-05-29 06:45:23]  [    0.585818] sdhci-pltfm: SDHCI platform and OF driver helper
    [2024-05-29 06:45:23]  [    0.587551] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
    [2024-05-29 06:45:23]  [    0.589028] optee: probing for conduit method.
    [2024-05-29 06:45:23]  [    0.589065] optee: revision 3.20
    [2024-05-29 06:45:23]  [    0.605751] optee: dynamic shared memory is enabled
    [2024-05-29 06:45:23]  [    0.606151] optee: initialized driver
    [2024-05-29 06:45:23]  [    0.607295] <<-GTP-INFO->> GTP driver installing...
    [2024-05-29 06:45:23]  [    0.608239] Device tree node 'switch_reset' not found
    [2024-05-29 06:45:23]  [    0.608277] IP179 Switch: register major 200
    [2024-05-29 06:45:23]  [    0.608284] IP179 Switch: driver loaded! 
    [2024-05-29 06:45:23]  [    0.609989] NET: Registered protocol family 17
    [2024-05-29 06:45:23]  [    0.610015] can: controller area network core
    [2024-05-29 06:45:23]  [    0.610102] NET: Registered protocol family 29
    [2024-05-29 06:45:23]  [    0.610108] can: raw protocol
    [2024-05-29 06:45:23]  [    0.610114] can: broadcast manager protocol
    [2024-05-29 06:45:23]  [    0.610123] can: netlink gateway - max_hops=1
    [2024-05-29 06:45:23]  [    0.610375] 9pnet: Installing 9P2000 support
    [2024-05-29 06:45:23]  [    0.610469] Key type dns_resolver registered
    [2024-05-29 06:45:23]  [    0.610728] Loading compiled-in X.509 certificates
    [2024-05-29 06:45:23]  [    0.628359] ti-sci 44043000.system-controller: lpm region is required for suspend but not provided.
    [2024-05-29 06:45:23]  Loading, please wait...[    0.628402] ti-sci 44043000.system-controller: ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [2024-05-29 06:45:23]  
    [2024-05-29 06:45:23]  [    0.768512] davinci-mcasp 2b10000.mcasp: IRQ common not found
    [2024-05-29 06:45:23]  [    0.772651] omap-gpmc 3b000000.memory-controller: GPMC revision 6.0
    [2024-05-29 06:45:23]  [    0.772667] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000
    [2024-05-29 06:45:23]  [    0.774849] omap_i2c 4900000.i2c: bus 4 rev0.12 at 400 kHz
    [2024-05-29 06:45:23]  [    0.776046] omap_i2c 2b200000.i2c: bus 5 rev0.12 at 400 kHz
    [2024-05-29 06:45:23]  [    0.777256] omap_i2c 20000000.i2c: bus 0 rev0.12 at 400 kHz
    [2024-05-29 06:45:23]  [    0.794551] rtc-pcf85063 1-0051: registered as rtc0
    [2024-05-29 06:45:23]  [    0.795578] rtc-pcf85063 1-0051: setting system clock to 2023-10-23T12:44:07 UTC (1698065047)
    [2024-05-29 06:45:23]  Starting version 245.4-4ubuntu3.23
    [2024-05-29 06:45:23]  [    0.796425] omap_i2c 20010000.i2c: bus 1 rev0.12 at 100 kHz
    [2024-05-29 06:45:23]  [    0.798541] omap_i2c 20020000.i2c: bus 2 rev0.12 at 400 kHz
    [2024-05-29 06:45:23]  [    0.799477] ti-sci-intr 4210000.interrupt-controller: Interrupt Router 5 domain created
    [2024-05-29 06:45:23]  [    0.800053] ti-sci-intr bus@f0000:interrupt-controller@a00000: Interrupt Router 3 domain created
    [2024-05-29 06:45:23]  [    0.801140] ti-sci-inta 48000000.interrupt-controller: Interrupt Aggregator domain 28 created
    [2024-05-29 06:45:23]  [    0.803836] ti-udma 485c0100.dma-controller: Number of rings: 82
    [2024-05-29 06:45:23]  [    0.807740] ti-udma 485c0100.dma-controller: Channels: 48 (bchan: 18, tchan: 12, rchan: 18)
    [2024-05-29 06:45:23]  [    0.810622] ti-udma 485c0000.dma-controller: Number of rings: 150
    [2024-05-29 06:45:23]  [    0.822241] ti-udma 485c0000.dma-controller: Channels: 35 (tchan: 20, rchan: 15)
    [2024-05-29 06:45:23]  [    0.825200] 4a00000.serial: ttyS7 at MMIO 0x4a00000 (irq = 15, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.826678] 2b300000.serial: ttyS8 at MMIO 0x2b300000 (irq = 17, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.828018] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 29, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.828263] printk: console [ttyS2]: printing thread started
    [2024-05-29 06:45:23]  [    0.828275] printk: console [ttyS2] enabled
    [2024-05-29 06:45:23]  [    0.835598] 2810000.serial: ttyS1 at MMIO 0x2810000 (irq = 30, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.865469] 2820000.serial: ttyS0 at MMIO 0x2820000 (irq = 31, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.871452] 2830000.serial: ttyS3 at MMIO 0x2830000 (irq = 32, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.883514] 2840000.serial: ttyS4 at MMIO 0x2840000 (irq = 33, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.893462] 2850000.serial: ttyS5 at MMIO 0x2850000 (irq = 34, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    0.902455] 2860000.serial: ttyS6 at MMIO 0x2860000 (irq = 35, base_baud = 3000000) is a 8250
    [2024-05-29 06:45:23]  [    1.030232] spi spi5.0: setup: ignoring unsupported mode bits 200
    [2024-05-29 06:45:23]  [    1.030833] spi-nor spi5.0: is25lp064 (8192 Kbytes)
    [2024-05-29 06:45:23]  [    1.030880] 5 fixed-partitions partitions found on MTD device fc40000.spi.0
    [2024-05-29 06:45:23]  [    1.030885] Creating 5 MTD partitions on "fc40000.spi.0":
    [2024-05-29 06:45:23]  [    1.030892] 0x000000000000-0x000000080000 : "ospi.tiboot3"
    [2024-05-29 06:45:23]  [    1.032270] 0x000000080000-0x000000280000 : "ospi.tispl"
    [2024-05-29 06:45:23]  [    1.033409] 0x000000280000-0x000000680000 : "ospi.u-boot"
    [2024-05-29 06:45:23]  [    1.034551] 0x000000680000-0x0000006c0000 : "ospi.env"
    [2024-05-29 06:45:23]  [    1.035660] 0x0000006c0000-0x000000700000 : "ospi.env.backup"
    [2024-05-29 06:45:23]  [    1.042958] davinci_mdio 8000f00.mdio: Configuring MDIO in manual mode
    [2024-05-29 06:45:23]  [    1.077334] davinci_mdio 8000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
    [2024-05-29 06:45:23]  [    1.094570] davinci_mdio 8000f00.mdio: phy[5]: device 8000f00.mdio:05, driver YT8531S Gigabit Ethernet
    [2024-05-29 06:45:23]  [    1.094588] davinci_mdio 8000f00.mdio: phy[7]: device 8000f00.mdio:07, driver YT8531S Gigabit Ethernet
    [2024-05-29 06:45:23]  [    1.094755] am65-cpsw-nuss 8000000.ethernet: initializing am65 cpsw nuss version 0x6BA01103, cpsw version 0x6BA81103 Ports: 3 quirks:00000006
    [2024-05-29 06:45:23]  [    1.095293] am65-cpsw-nuss 8000000.ethernet: Use random MAC address
    [2024-05-29 06:45:23]  [    1.095322] am65-cpsw-nuss 8000000.ethernet: initialized cpsw ale version 1.5
    [2024-05-29 06:45:23]  [    1.095329] am65-cpsw-nuss 8000000.ethernet: ALE Table size 512
    [2024-05-29 06:45:23]  [    1.096335] pps pps0: new PPS source ptp0
    [2024-05-29 06:45:23]  [    1.096683] am65-cpsw-nuss 8000000.ethernet: CPTS ver 0x4e8a010c, freq:500000000, add_val:1 pps:1
    [2024-05-29 06:45:23]  [    1.129727] am65-cpsw-nuss 8000000.ethernet: set new flow-id-base 19
    [2024-05-29 06:45:23]  [    1.156643] dwc3-am62 f900000.dwc3-usb: lockup ldo_en wa
    [2024-05-29 06:45:23]  [    1.158236] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
    [2024-05-29 06:45:23]  [    1.158278] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
    [2024-05-29 06:45:23]  [    1.158444] xhci-hcd xhci-hcd.0.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000000000010010
    [2024-05-29 06:45:23]  [    1.158752] xhci-hcd xhci-hcd.0.auto: irq 269, io mem 0x31000000
    [2024-05-29 06:45:23]  [    1.158935] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
    [2024-05-29 06:45:23]  [    1.158950] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
    [2024-05-29 06:45:23]  [    1.158966] xhci-hcd xhci-hcd.0.auto: Host supports USB 3.0 SuperSpeed
    [2024-05-29 06:45:23]  [    1.159143] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
    [2024-05-29 06:45:23]  [    1.159152] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 06:45:23]  [    1.159158] usb usb1: Product: xHCI Host Controller
    [2024-05-29 06:45:23]  [    1.159163] usb usb1: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 06:45:23]  [    1.159169] usb usb1: SerialNumber: xhci-hcd.0.auto
    [2024-05-29 06:45:23]  [    1.159695] hub 1-0:1.0: USB hub found
    [2024-05-29 06:45:23]  [    1.159726] hub 1-0:1.0: 1 port detected
    [2024-05-29 06:45:23]  [    1.160082] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
    [2024-05-29 06:45:23]  [    1.160183] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
    [2024-05-29 06:45:23]  [    1.160191] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 06:45:23]  [    1.160198] usb usb2: Product: xHCI Host Controller
    [2024-05-29 06:45:23]  [    1.160202] usb usb2: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 06:45:23]  [    1.160208] usb usb2: SerialNumber: xhci-hcd.0.auto
    [2024-05-29 06:45:23]  [    1.160653] hub 2-0:1.0: USB hub found
    [2024-05-29 06:45:23]  [    1.160681] hub 2-0:1.0: config failed, hub doesn't have any ports! (err -19)
    [2024-05-29 06:45:23]  [    1.162374] dwc3-am62 f910000.dwc3-usb: lockup ldo_en wa
    [2024-05-29 06:45:23]  [    1.163483] dwc3 31100000.usb: Configuration mismatch. dr_mode forced to host
    [2024-05-29 06:45:24]  [    1.163802] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
    [2024-05-29 06:45:24]  [    1.163825] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 3
    [2024-05-29 06:45:24]  [    1.163988] xhci-hcd xhci-hcd.1.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000000000010010
    [2024-05-29 06:45:24]  [    1.164283] xhci-hcd xhci-hcd.1.auto: irq 270, io mem 0x31100000
    [2024-05-29 06:45:24]  [    1.164482] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
    [2024-05-29 06:45:24]  [    1.164498] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 4
    [2024-05-29 06:45:24]  [    1.164513] xhci-hcd xhci-hcd.1.auto: Host supports USB 3.0 SuperSpeed
    [2024-05-29 06:45:24]  [    1.164678] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
    [2024-05-29 06:45:24]  [    1.164687] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 06:45:24]  [    1.164694] usb usb3: Product: xHCI Host Controller
    [2024-05-29 06:45:24]  [    1.164699] usb usb3: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 06:45:24]  [    1.164705] usb usb3: SerialNumber: xhci-hcd.1.auto
    [2024-05-29 06:45:24]  [    1.165183] hub 3-0:1.0: USB hub found
    [2024-05-29 06:45:24]  [    1.165219] hub 3-0:1.0: 1 port detected
    [2024-05-29 06:45:24]  [    1.165596] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
    [2024-05-29 06:45:24]  [    1.165700] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
    [2024-05-29 06:45:24]  [    1.165708] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [2024-05-29 06:45:24]  [    1.165714] usb usb4: Product: xHCI Host Controller
    [2024-05-29 06:45:24]  [    1.165719] usb usb4: Manufacturer: Linux 5.10.168-rt83-gc1a1291911 xhci-hcd
    [2024-05-29 06:45:24]  [    1.165724] usb usb4: SerialNumber: xhci-hcd.1.auto
    [2024-05-29 06:45:24]  [    1.166087] hub 4-0:1.0: USB hub found
    [2024-05-29 06:45:24]  [    1.166112] hub 4-0:1.0: config failed, hub doesn't have any ports! (err -19)
    [2024-05-29 06:45:24]  [    1.168151] input: pwm-beeper as /devices/platform/buzzer/input/input0
    [2024-05-29 06:45:24]  [    1.271930] mmc0: CQHCI version 5.10
    [2024-05-29 06:45:24]  [    1.273699] davinci-mcasp 2b10000.mcasp: IRQ common not found
    [2024-05-29 06:45:24]  [    1.314255] mmc0: SDHCI controller on fa10000.mmc [fa10000.mmc] using ADMA 64-bit
    [2024-05-29 06:45:24]  [    1.317933] mmc1: CQHCI version 5.10
    [2024-05-29 06:45:24]  [    1.329906] sdhci-am654 fa20000.mmc: parsing dt failed (-517)
    [2024-05-29 06:45:24]  [    1.359683] mmc1: SDHCI controller on fa00000.mmc [fa00000.mmc] using ADMA 64-bit
    [2024-05-29 06:45:24]  [    1.410597] mmc0: Command Queue Engine enabled
    [2024-05-29 06:45:24]  [    1.410616] mmc0: new HS200 MMC card at address 0001
    [2024-05-29 06:45:24]  [    1.411361] mmcblk0: mmc0:0001 S40004 3.64 GiB 
    [2024-05-29 06:45:24]  [    1.411567] mmcblk0boot0: mmc0:0001 S40004 partition 1 4.00 MiB
    [2024-05-29 06:45:24]  [    1.411764] mmcblk0boot1: mmc0:0001 S40004 partition 2 4.00 MiB
    [2024-05-29 06:45:24]  [    1.412071] mmcblk0rpmb: mmc0:0001 S40004 partition 3 4.00 MiB, chardev (238:0)
    [2024-05-29 06:45:24]  [    1.413598]  mmcblk0: p1 p2
    [2024-05-29 06:45:24]  [    1.505313] mmc1: new high speed SDHC card at address aaaa
    [2024-05-29 06:45:24]  [    1.506126] mmcblk1: mmc1:aaaa SC16G 14.8 GiB 
    [2024-05-29 06:45:24]  [    1.509978]  mmcblk1: p1 p2
    [2024-05-29 06:45:24]  [    1.653937] <<-GTP-INFO->> GTP Driver Version: V2.4<2014/11/28>
    [2024-05-29 06:45:24]  [    1.653951] <<-GTP-INFO->> GTP I2C Address: 0x14
    [2024-05-29 06:45:24]  [    1.740851] <<-GTP-INFO->> IC Version: 911_1060
    [2024-05-29 06:45:24]  [    1.742976] <<-GTP-INFO->> Sensor_ID: 2
    [2024-05-29 06:45:24]  [    1.742984] <<-GTP-INFO->> Config group2 used,length: 186
    [2024-05-29 06:45:24]  [    1.744047] <<-GTP-INFO->> Driver send config.
    [2024-05-29 06:45:24]  [    1.765967] <<-GTP-INFO->> X_MAX: 1280, Y_MAX: 800, TRIGGER: 0x03
    [2024-05-29 06:45:24]  [    1.777488] input: goodix-ts as /devices/virtual/input/input1
    [2024-05-29 06:45:24]  [    1.777845] genirq: Setting trigger mode 4 for irq 340 failed (gpio_irq_type+0x0/0x18)
    [2024-05-29 06:45:24]  [    1.777901] <<-GTP-INFO->> GTP works in polling mode.
    [2024-05-29 06:45:24]  [    1.778393] <<-GTP-INFO->> GTP Driver Version: V2.4<2014/11/28>
    [2024-05-29 06:45:24]  [    1.778397] <<-GTP-INFO->> GTP I2C Address: 0x14
    [2024-05-29 06:45:24]  [    1.876750] <<-GTP-INFO->> IC Version: 911_1060
    [2024-05-29 06:45:24]  [    1.877392] <<-GTP-INFO->> Sensor_ID: 2
    [2024-05-29 06:45:24]  [    1.877399] <<-GTP-INFO->> Config group2 used,length: 186
    [2024-05-29 06:45:24]  [    1.877722] <<-GTP-INFO->> Driver send config.
    [2024-05-29 06:45:24]  [    1.883220] <<-GTP-INFO->> X_MAX: 1280, Y_MAX: 800, TRIGGER: 0x03
    [2024-05-29 06:45:24]  [    1.894469] input: goodix-ts as /devices/virtual/input/input2
    [2024-05-29 06:45:24]  [    1.894742] genirq: Setting trigger mode 4 for irq 367 failed (gpio_irq_type+0x0/0x18)
    [2024-05-29 06:45:24]  [    1.894784] <<-GTP-INFO->> GTP works in polling mode.
    [2024-05-29 06:45:24]  [    1.895294] pwm-backlight backlight: supply power not found, using dummy regulator
    [2024-05-29 06:45:24]  [    1.902364] [drm] Initialized tidss 1.0.0 20180215 for 30200000.dss on minor 0
    [2024-05-29 06:45:24]  [    1.945758] Console: switching to colour frame buffer device 160x50
    [2024-05-29 06:45:24]  [    1.963420] tidss 30200000.dss: [drm] fb0: tidssdrmfb frame buffer device
    [2024-05-29 06:45:24]  [    1.975096] sdhci-am654 fa20000.mmc: allocated mmc-pwrseq
    [2024-05-29 06:45:24]  [    1.976801] mmc2: CQHCI version 5.10
    [2024-05-29 06:45:24]  [    1.986333] debugfs: Directory 'pd:53' with parent 'pm_genpd' already present!
    [2024-05-29 06:45:24]  [    1.986389] debugfs: Directory 'pd:52' with parent 'pm_genpd' already present!
    [2024-05-29 06:45:24]  [    1.986435] debugfs: Directory 'pd:51' with parent 'pm_genpd' already present!
    [2024-05-29 06:45:24]  [    1.986900] debugfs: Directory 'pd:182' with parent 'pm_genpd' already present!
    [2024-05-29 06:45:24]  [    1.992653] of_cfs_init
    [2024-05-29 06:45:24]  [    1.992714] of_cfs_init: OK
    [2024-05-29 06:45:24]  [    1.996027] pd-gpio powerdown: driver probe success!
    [2024-05-29 06:45:24]  [    2.013778] mmc2: SDHCI controller on fa20000.mmc [fa20000.mmc] using ADMA 64-bit
    [2024-05-29 06:45:24]  [    2.040872] ALSA device list:
    [2024-05-29 06:45:24]  [    2.040882]   No soundcards found.
    [2024-05-29 06:45:24]  [    2.042643] mmc2: queuing unknown CIS tuple 0x80 (2 bytes)
    [2024-05-29 06:45:24]  [    2.044567] mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
    [2024-05-29 06:45:24]  [    2.046072] mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
    [2024-05-29 06:45:24]  [    2.048772] mmc2: queuing unknown CIS tuple 0x80 (7 bytes)
    [2024-05-29 06:45:24]  [    2.049754] mmc2: queuing unknown CIS tuple 0x81 (1 bytes)
    [2024-05-29 06:45:24]  [    2.121784] Freeing unused kernel memory: 1792K
    [2024-05-29 06:45:24]  [    2.121901] Run /init as init process
    [2024-05-29 06:45:24]  [    2.138551] mmc2: new high speed SDIO card at address 0001
    [2024-05-29 06:45:24]  [    2.433370] usb 3-1: new high-speed USB device number 2 using xhci-hcd
    [2024-05-29 06:45:24]  [    2.497676] usb 1-1: new high-speed USB device number 2 using xhci-hcd
    [2024-05-29 06:45:24]  [    2.559919] usb 3-1: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.00
    [2024-05-29 06:45:24]  [    2.559940] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    [2024-05-29 06:45:24]  [    2.559947] usb 3-1: Product: Cruzer Blade
    [2024-05-29 06:45:24]  [    2.559951] usb 3-1: Manufacturer: SanDisk
    [2024-05-29 06:45:24]  [    2.559956] usb 3-1: SerialNumber: 4C530000291216110465
    [2024-05-29 06:45:24]  [    2.566248] usb-storage 3-1:1.0: USB Mass Storage device detected
    [2024-05-29 06:45:24]  [    2.586501] scsi host0: usb-storage 3-1:1.0
    [2024-05-29 06:45:24]  [    2.623887] usb 1-1: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.00
    [2024-05-29 06:45:24]  [    2.623917] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    [2024-05-29 06:45:24]  [    2.623924] usb 1-1: Product: Cruzer Blade
    [2024-05-29 06:45:24]  [    2.623929] usb 1-1: Manufacturer: SanDisk
    [2024-05-29 06:45:24]  [    2.623933] usb 1-1: SerialNumber: 03025431092423133207
    [2024-05-29 06:45:24]  [    2.625142] usb-storage 1-1:1.0: USB Mass Storage device detected
    [2024-05-29 06:45:24]  [    2.641470] scsi host1: usb-storage 1-1:1.0
    [2024-05-29 06:45:24]  [    3.632819] scsi 0:0:0:0: Direct-Access     SanDisk  Cruzer Blade     1.00 PQ: 0 ANSI: 6
    [2024-05-29 06:45:24]  [    3.637779] sd 0:0:0:0: [sda] 15630336 512-byte logical blocks: (8.00 GB/7.45 GiB)
    [2024-05-29 06:45:24]  [    3.638813] sd 0:0:0:0: [sda] Write Protect is off
    [2024-05-29 06:45:24]  [    3.639371] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
    [2024-05-29 06:45:24]  Begin: Loading essential drivers ... [    3.670458]  sda: sda1
    [2024-05-29 06:45:24]  done.
    [2024-05-29 06:45:24]  Spawning shell within the initramfs
    [2024-05-29 06:45:24]  [    3.678630] sd 0:0:0:0: [sda] Attached SCSI removable disk
    [2024-05-29 06:45:24]  
    [2024-05-29 06:45:24]  
    [2024-05-29 06:45:24]  BusyBox v1.30.1 (Ubuntu 1:1.30.1-4ubuntu6.4) built-in shell (ash)
    [2024-05-29 06:45:24]  Enter 'help' for a list of built-in commands.
    [2024-05-29 06:45:24]  
    [2024-05-29 06:45:24]  (initramfs) [    3.696274] scsi 1:0:0:0: Direct-Access     SanDisk  Cruzer Blade     1.00 PQ: 0 ANSI: 6
    [2024-05-29 06:45:24]  [    3.712276] sd 1:0:0:0: [sdb] 60088320 512-byte logical blocks: (30.8 GB/28.7 GiB)
    [2024-05-29 06:45:24]  [    3.715259] sd 1:0:0:0: [sdb] Write Protect is off
    [2024-05-29 06:45:24]  [    3.715809] sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
    [2024-05-29 06:45:24]  [    3.766832]  sdb: sdb1
    [2024-05-29 06:45:24]  [    3.774974] sd 1:0:0:0: [sdb] Attached SCSI removable disk
    [2024-05-29 06:45:24]  [   18.139332] random: crng init done
    [2024-05-29 06:45:39]  
    [2024-05-29 06:46:03]  (initramfs) &
    [2024-05-29 06:46:06]  J

    The relevant information of mmc is as follows:

    Regards,

    LI

  • Hello,

    It seems like the clock is only 25MHz which may be the root cause.

    Can you please try the suggested patch in the below response to switch the clock source for having 200MHz

    https://e2e.ti.com/support/processors-group/processors/f/processors-forum/1316879/sk-am62a-lp-load-speed-problem-with-emmc-in-falcon-boot-mode/5010012#5010012

    Regards,

    Prashant

  • Hello,

    I made the following modifications:

    root@ubuntu-1804:/home/liweiyu/am62x/debug/ti-processor-sdk-linux-rt-am62xx-evm-08.06.00.42/board-support/u-boot-2021.01+gitAUTOINC+2ee8efd654-g2ee8efd654# git diff arch/arm/dts/k3-am62-main.dtsi
    diff --git a/arch/arm/dts/k3-am62-main.dtsi b/arch/arm/dts/k3-am62-main.dtsi
    index a22f029c0a..6f5c98f8ec 100644
    --- a/arch/arm/dts/k3-am62-main.dtsi
    +++ b/arch/arm/dts/k3-am62-main.dtsi
    @@ -341,7 +341,7 @@
                    clocks = <&k3_clks 57 5>, <&k3_clks 57 6>;
                    clock-names = "clk_ahb", "clk_xin";
                    assigned-clocks = <&k3_clks 57 6>;
    -               assigned-clock-parents = <&k3_clks 57 8>;
    +               assigned-clock-parents = <&k3_clks 57 7>;
                    mmc-ddr-1_8v;
                    mmc-hs200-1_8v;
                    ti,trm-icp = <0x2>;

    After referring to the link you provided for modification, there was an error during startup, as shown below:

    U-Boot SPL 2021.01-00003-gf4dc0be4cb-dirty (May 29 2024 - 08:22:33 +0000)
    SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    TLB table from bfffc000 to c0000000
    SPL initial stack usage: 13424 bytes
    SPL malloc() before relocation used 0x6aa0 bytes (26 KB)
    >>SPL: board_init_r()
    spl_init
    WDT:   Not found!
    am625_init: spl_boot_device: devstat = 0xd703 bootmedia = 0x9 bootindex = 1
    spl_ll_find_loader:506 loader:MMC1 device:9
    spl_ll_find_loader:508 loader:MMC1 device:9
    Trying to boot from MMC1
    clock is disabled (0Hz)
    clock is enabled (400000Hz)
    clock is enabled (25000000Hz)
    clock is enabled (200000000Hz)
    clock is enabled (200000000Hz)
    unable to select a mode : -70
    spl: mmc init failed with error: -524
    SPL: failed to boot from all boot devices
    ### ERROR ### Please RESET the board ###

    Regards,

    LI

  • Hello,

    Let's stick to the previous working setup then.

    So, I have reproduced the issue when booting from the eMMC backup bootmode:

    [11:55:04] U-Boot SPL 2021.01-dirty (May 30 2024 - 11:54:13 +0530)
    [11:55:04] SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [11:55:04] SPL initial stack usage: 13424 bytes
    [11:55:04] am625_init: spl_boot_device: devstat = 0x1403 bootmedia = 0x9 bootindex = 1
    [11:55:04] Trying to boot from MMC1
    [11:55:04] clock is disabled (0Hz)
    [11:55:04] clock is enabled (400000Hz)
    [11:55:04] clock is enabled (25000000Hz)
    [11:55:04] clock is enabled (25000000Hz)
    [11:55:04] clock is enabled (25000000Hz)
    [11:55:04] clock is enabled (25000000Hz)
    [11:55:04] clock is enabled (25000000Hz)
    [11:55:04] clock is enabled (25000000Hz)
    [11:55:04] spl: mmc boot mode: fs
    [11:55:04] fit read sector 0, sectors=1336, dst=82fffac0, count=1336, size=0x538
    [11:55:04] firmware: 'atf'
    [11:55:04] External data: dst=9e780000, offset=538, size=b2e9
    [11:55:04] am625_init: spl_boot_device: devstat = 0x1403 bootmedia = 0x9 bootindex = 1
    [11:55:04] Authentication passed
    [11:55:04] Image OS is ARM Trusted Firmware
    [11:55:04] loadables: 'tee'
    [11:55:04] External data: dst=9e800000, offset=b824, size=66ee1
    [11:55:04] am625_init: spl_boot_device: devstat = 0x1403 bootmedia = 0x9 bootindex = 1
    [11:55:04] Authentication passed
    [11:55:04] Loadable is Trusted Execution Environment
    [11:55:04] loadables: 'dm'
    [11:55:04] External data: dst=89000000, offset=72708, size=25a39
    [11:55:04] am625_init: spl_boot_device: devstat = 0x1403 bootmedia = 0x9 bootindex = 1
    [11:55:04] Authentication passed
    [11:55:04] Loadable is Unknown OS
    [11:55:04] loadables: 'kernel'
    [11:55:11] External data: dst=80080000, offset=98144, size=1242a00

    But I did not see the issue when using eMMC primary bootmode. Could you please confirm if you also see the same?

    Regards,

    Prashant

  • Hello,

    Our hardware currently only supports eMMC backup bootmode mode and does not support eMMC primary bootmode.
    We also hope that TI can solve the problem of long kernel loading time during eMMC backup bootmode startup。


    Regards,
    LI

  • Hello,

    In that case, let me work on this and get back to you.

    Regards,

    Prashant

  • Hello,

    Is there any progress? Our client is quite anxious about this issue.
    Regards,
    Li

  • Hello,

    I have been debugging and it seems like the eMMC tuning is failing for eMMC backup boot causing degradation in the R/W performance. I think I am close to finding the root cause and the fix as well.

    Please allow me a day or two to get back to you.

    Thanks for your patience.

  • Hello,

    I tested and found that the first time the board was powered on, the speed of loading atf-tee-dm-kernel-fdt.bin was very slow. When the system started up to the shell terminal console, entering the reboot command to perform a hot start reset, the board loaded atf-tee-dm-kernel-fdt.bin very quickly

  • Hello,

    I did observe this behaviour. The eMMC backup boot is quick if happens through warm reset but not through cold reset.

    I think I may have identified the possible cause of this issue. Apparently, in eMMC backup boot, the ROM only uses the BUS_WIDTH of 1 and so accordingly configures the eMMC controller and the eMMC card.

    With the leftover eMMC configurations from ROM, the U-Boot seems to have trouble configuring the eMMC in the highest mode possible. It tries configuring the eMMC in BUS_WIDTH of 8 but fails ultimately settling on BUS_WIDTH of 1 only resulting in the R/W speed degradation.

    Attaching the U-Boot debug logs for reference

    [18:05:36]
    [18:05:37] U-Boot SPL 2021.01-dirty (Jun 04 2024 - 17:40:08 +0530)
    [18:05:37] SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (Chill Capybar')
    [18:05:37] SPL initial stack usage: 13424 bytes
    [18:05:37] am625_init: spl_boot_device: devstat = 0x1403 bootmedia = 0x9 bootindex = 1
    [18:05:37] Trying to boot from MMC1
    [18:05:37] sdhci_setup_cfg, caps: 0x3decc801
    [18:05:37] sdhci_setup_cfg, caps_1: 0x18000407
    [18:05:37] clock is disabled (0Hz)
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x0
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x0
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x0
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x0
    [18:05:37] clock is enabled (400000Hz)
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x0
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x0
    [18:05:37] CMD_SEND:0
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              MMC_RSP_NONE
    [18:05:37] CMD_SEND:8
    [18:05:37]              ARG                      0x000001aa
    [18:05:37]              RET                      -110
    [18:05:37] CMD_SEND:55
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -110
    [18:05:37] CMD_SEND:0
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              MMC_RSP_NONE
    [18:05:37] CMD_SEND:1
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              MMC_RSP_R3,4             0x00ff8080
    [18:05:37] CMD_SEND:1
    [18:05:37]              ARG                      0x40300080
    [18:05:37]              MMC_RSP_R3,4             0x00ff8080
    [18:05:37] CMD_SEND:1
    [18:05:37]              ARG                      0x40300080
    [18:05:37]              MMC_RSP_R3,4             0xc0ff8080
    [18:05:37] CMD_SEND:2
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              MMC_RSP_R2               0x13014e53
    [18:05:37]                                       0x304a3536
    [18:05:37]                                       0x58101ff1
    [18:05:37]                                       0x34e49700
    
    [18:05:37]                                      DUMPING DATA
    [18:05:37]                                      000 - 13 01 4e 53
    [18:05:37]                                      004 - 30 4a 35 36
    [18:05:37]                                      008 - 58 10 1f f1
    [18:05:37]                                      012 - 34 e4 97 00
    [18:05:37] CMD_SEND:3
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000500
    [18:05:37] CMD_SEND:9
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R2               0xd07f0132
    [18:05:37]                                       0x8f5903ff
    [18:05:37]                                       0xc003ffef
    [18:05:37]                                       0x86400000
    
    [18:05:37]                                      DUMPING DATA
    [18:05:37]                                      000 - d0 7f 01 32
    [18:05:37]                                      004 - 8f 59 03 ff
    [18:05:37]                                      008 - c0 03 ff ef
    [18:05:37]                                      012 - 86 40 00 00
    [18:05:37] CMD_SEND:7
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000700
    [18:05:37] CMD_SEND:8
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:37] clock is enabled (25000000Hz)
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b70200
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:37] CURR STATE:4
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x30
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b90200
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:37] CURR STATE:4
    [18:05:37] clock is enabled (25000000Hz)
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x30
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x34
    [18:05:37] sdhci_execute_tuning
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:8
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b70000
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000980
    [18:05:37] CURR STATE:4
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x34
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b70100
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:37] CURR STATE:4
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x12
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b90200
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:37] CURR STATE:4
    [18:05:37] clock is enabled (25000000Hz)
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x12
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x16
    [18:05:37] sdhci_execute_tuning
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:21
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:8
    [18:05:37]              ARG                      0x00000000
    [18:05:37]              RET                      -70
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b70000
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000980
    [18:05:37] CURR STATE:4
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x16
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b70200
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:37] CURR STATE:4
    [18:05:37] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:37] >>> sdhci_set_ios: 672: write ctrl: 0x30
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b90100
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:37] CMD_SEND:13
    [18:05:37]              ARG                      0x00010000
    [18:05:37]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:37] CURR STATE:4
    [18:05:37] CMD_SEND:6
    [18:05:37]              ARG                      0x03b70600
    [18:05:37]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] clock is enabled (25000000Hz)
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x30
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x34
    [18:05:38] CMD_SEND:8
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              RET                      -70
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70000
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x34
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70100
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x12
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b90100
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70500
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] clock is enabled (25000000Hz)
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x12
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x16
    [18:05:38] CMD_SEND:8
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              RET                      -70
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70000
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x16
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70200
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x30
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b90100
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] CMD_SEND:8
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              RET                      -70
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70000
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x30
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70100
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x12
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b90100
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] CMD_SEND:8
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              RET                      -70
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70000
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x12
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b70000
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:38] CMD_SEND:6
    [18:05:38]              ARG                      0x03b90100
    [18:05:38]              MMC_RSP_R1b              0x00000800
    [18:05:38] CMD_SEND:13
    [18:05:38]              ARG                      0x00010000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CURR STATE:4
    [18:05:38] CMD_SEND:8
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] clock is enabled (25000000Hz)
    [18:05:38] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:05:38] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:05:38] CMD_SEND:8
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] spl: mmc boot mode: fs
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x00000800
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x00000800
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x00000a04
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x0000bd80
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x00000800
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x00000a04
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x0000bd80
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x0000bd81
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] fit read sector 0, sectors=600, dst=82fffd80, count=600, size=0x258
    [18:05:38] cannot find property 'firmware': -1
    [18:05:38] could not find firmware image, trying loadables...
    [18:05:38] loadables: 'kernel'
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:17
    [18:05:38]              ARG                      0x00000800
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x00000a04
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x0000bd80
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x0000082e
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x00000834
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x0000083a
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x00000840
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x00000846
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x0000084c
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x00000852
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:12
    [18:05:38]              ARG                      0x00000000
    [18:05:38]              MMC_RSP_R1b              0x00000b00
    [18:05:38] CMD_SEND:16
    [18:05:38]              ARG                      0x00000200
    [18:05:38]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:38] CMD_SEND:18
    [18:05:38]              ARG                      0x0000bd84
    [18:05:44]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:44] CMD_SEND:12
    [18:05:44]              ARG                      0x00000000
    [18:05:44]              MMC_RSP_R1b              0x00000b00
    [18:05:44] CMD_SEND:16
    [18:05:44]              ARG                      0x00000200
    [18:05:44]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:44] CMD_SEND:17
    [18:05:44]              ARG                      0x00014f96
    [18:05:44]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:44] External data: dst=80080000, offset=258, size=1242a00
    [18:05:44] Warning: Did not detect image signing certificate. Skipping authentication to prevent boot failure. This will fail on Security Enforcing(HS-SE) devices
    [18:05:45] Image OS is Linux
    [18:05:45] no string for index 1
    [18:05:45] Loading Environment from MMC... CMD_SEND:16
    [18:05:45]              ARG                      0x00000200
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CMD_SEND:17
    [18:05:45]              ARG                      0x00000000
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CMD_SEND:16
    [18:05:45]              ARG                      0x00000200
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CMD_SEND:17
    [18:05:45]              ARG                      0x00000000
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CMD_SEND:6
    [18:05:45]              ARG                      0x03b34900
    [18:05:45]              MMC_RSP_R1b              0x00000800
    [18:05:45] CMD_SEND:13
    [18:05:45]              ARG                      0x00010000
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CURR STATE:4
    [18:05:45] CMD_SEND:16
    [18:05:45]              ARG                      0x00000200
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CMD_SEND:18
    [18:05:45]              ARG                      0x00003400
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CMD_SEND:12
    [18:05:45]              ARG                      0x00000000
    [18:05:45]              MMC_RSP_R1b              0x00000b00
    [18:05:45] CMD_SEND:6
    [18:05:45]              ARG                      0x03b34800
    [18:05:45]              MMC_RSP_R1b              0x00000800
    [18:05:45] CMD_SEND:13
    [18:05:45]              ARG                      0x00010000
    [18:05:45]              MMC_RSP_R1,5,6,7         0x00000900
    [18:05:45] CURR STATE:4
    [18:05:45] OK
    [18:05:45] am625_init: spl_boot_device: devstat = 0x1403 bootmedia = 0x9 bootindex = 1
    [18:05:45] am625_init: spl_boot_device: devstat = 0x1403 bootmedia = 0x9 bootindex = 1
    [18:05:45] init_env from device 9 not supported!
    

    Please allow me some more time to try some things out and get back to you possibly with a fix.

    Thanks for your patience.

    Regards,

    Prashant

  • Hello,

    We have identified the root cause of the issue and the fix as well.

    Apparently, the pinmuxing configuration for mmc0 was missing in the R5 DTB falling back to the pinmuxing done by ROM. Since, in eMMC backup boot, ROM uses only one data line, the other seven are left unconfigured resulting in the issue. Everything works fine in primary bootmode since ROM configures all the eight data lines.

    PFA the patch that should enable the mmc0 pinmuxing.

    diff --git a/arch/arm/dts/k3-am62x-sk-common-u-boot.dtsi b/arch/arm/dts/k3-am62x-sk-common-u-boot.dtsi
    index b57d9563d87..52637fc3de4 100644
    --- a/arch/arm/dts/k3-am62x-sk-common-u-boot.dtsi
    +++ b/arch/arm/dts/k3-am62x-sk-common-u-boot.dtsi
    @@ -112,6 +112,10 @@
     	u-boot,dm-spl;
     };
     
    +&main_mmc0_pins_default {
    +    u-boot,dm-spl;
    +};
    +
     &main_mmc1_pins_default {
     	u-boot,dm-spl;
     };
    

    I have tested the patch successfully. Attaching the logs for reference

    [18:00:50.270] U-Boot SPL 2021.01-dirty (Jun 06 2024 - 18:00:15 +0530)
    [18:00:50.301] SYSFW ABI: 3.1 (firmware rev 0x0008 '8.6.4--v08.06.04 (
    Chill Capybar')
    [18:00:50.333] SPL initial stack usage: 13424 bytes
    [18:00:50.365] am625_init: spl_boot_device: devstat = 0x1403 bootmedia
     = 0x9 bootindex = 1
    [18:00:50.375] Trying to boot from MMC1
    [18:00:50.376] sdhci_setup_cfg, caps: 0x3decc801
    [18:00:50.377] sdhci_setup_cfg, caps_1: 0x18000407
    [18:00:50.382] >>> mmc_init: 2936
    [18:00:50.384] >>> mmc_power_cycle: 2756
    [18:00:50.385] clock is disabled (0Hz)
    [18:00:50.387] >>> sdhci_set_ios: 635: read ctrl: 0x0
    [18:00:50.390] >>> sdhci_set_ios: 672: write ctrl: 0x0
    [18:00:50.400] >>> sdhci_set_ios: 635: read ctrl: 0x0
    [18:00:50.402] >>> sdhci_set_ios: 672: write ctrl: 0x0
    [18:00:50.405] clock is enabled (400000Hz)
    [18:00:50.407] >>> sdhci_set_ios: 635: read ctrl: 0x0
    [18:00:50.414] >>> sdhci_set_ios: 672: write ctrl: 0x0
    [18:00:50.429] clock is enabled (25000000Hz)
    [18:00:50.445] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:00:50.447] >>> sdhci_set_ios: 672: write ctrl: 0x10
    [18:00:50.449] >>> sdhci_set_ios: 635: read ctrl: 0x10
    [18:00:50.450] >>> sdhci_set_ios: 672: write ctrl: 0x30
    [18:00:50.461] clock is enabled (25000000Hz)
    [18:00:50.463] >>> sdhci_set_ios: 635: read ctrl: 0x30
    [18:00:50.464] >>> sdhci_set_ios: 672: write ctrl: 0x34
    [18:00:50.465] sdhci_execute_tuning
    [18:00:50.477] spl: mmc boot mode: fs
    [18:00:50.478] fit read sector 0, sectors=600, dst=82fffd80, count=600
    , size=0x258
    [18:00:50.493] cannot find property 'firmware': -1
    [18:00:50.494] could not find firmware image, trying loadables...
    [18:00:50.495] loadables: 'kernel'
    [18:00:51.373] External data: dst=80080000, offset=258, size=1242a00
    [18:00:51.382] Warning: Did not detect image signing certificate. Skip
    ping authentication to prevent boot failure. This will fail on Securit
    y Enforcing(HS-SE) devices
    [18:00:51.485] Image OS is Linux
    [18:00:51.489] no string for index 1
    [18:00:51.517] Loading Environment from MMC... >>> mmc_init: 2936
    [18:00:51.645] OK
    [18:00:51.646] am625_init: spl_boot_device: devstat = 0x1403 bootmedia
     = 0x9 bootindex = 1
    [18:00:51.662] am625_init: spl_boot_device: devstat = 0x1403 bootmedia
     = 0x9 bootindex = 1
    [18:00:51.666] init_env from device 9 not supported!

    Please let us know if this works out for you as well.

    Regards,

    Prashant

  • Hello,

    Thank you for your support. After merging the patch above, the startup speed has reached our requirements.

    Regards,
    Li