AM625: emmc boot error with kingstone

Hi,

can you please try adding the no-1-8-v; device tree property to the sdhci0 node in the k3-am62x-main.dtsi file and try again. This will disable all high speed modes, and it's always a good thing to test.

Also, how are your eMMC modules connected to the AM62x SoC?

Regards, Andreas

Hi,

I had add no-1-8-v;

and change bus-width = <8>; -to bus-width = <1>;

but it's the same situation.

Thanks.

Hi Fox,

Andreas is out of office today. Please expect delayed response.

Hi Fox Yang,

1. If this is TI AM62 SK board, what is the board revision? 

2. U-Boot SPL 2023.04-00001-gf5b119738d-dirty >> This commitsha doesnt match to a TI SDK drop, Are there any other changes in the baseline ? 

2.1 What is the TI SDK version this issue is seen on?

3. Provide part number for "kingston 32g" . Good to check if this part is following eMMC JEDEC spec.

Hi Praneeth,

1.No,it's custom board.

2.3

.I use processor SDK Linux for AM62X  09_00_00_03.

  And u-boot is base ti-processor-sdk-linux-am62xx-evm-09.00.00.03-Linux-x86-Install.bin

3.Kingston.EMMC32G-TX29-GA8A

thanks.

Can you share the schematic section that shows how the eMMC is connected to the AM62x, the power rails, and any reset signals that may be connected.

Also there's a chance that the eMMC may ship with a different factory configuration which may impact the behavior so you may need the below to setup the eMMC for raw booting from the boot0 partition, as per Linux SDK User's Guide at https://software-dl.ti.com/processor-sdk-linux/esd/AM64X/09_00_00_03/exports/docs/linux/Foundational_Components/U-Boot/UG-Memory.html#booting-tiboot3-bin-tispl-bin-and-u-boot-img-from-emmc-boot-partition-for-k3-class-of-socs

=> mmc partconf 0 1 1 1
=> mmc bootbus 0 2 0 0

Regards, Andreas

Hi,

This is our schematic about emmc.

And we need boot from UDA, then dont test boot0 part.

Thanks, will review tomorrow.

Hi,

Have any suggestions for direction?
Thanks.

Hi Fox,

I looked over the schematic extract I don't see any immediate issue but I've asked our HW expert to double-check.

In the meantime can you please try one more experiment with disabling the eMMC high-speed mode as shown below:

$ git diff
diff --git a/arch/arm/dts/k3-am62-main.dtsi b/arch/arm/dts/k3-am62-main.dtsi
index bdfda77586..0a2d6dcf68 100644
--- a/arch/arm/dts/k3-am62-main.dtsi
+++ b/arch/arm/dts/k3-am62-main.dtsi
@@ -502,14 +502,12 @@
                assigned-clocks = <&k3_clks 57 6>;
                assigned-clock-parents = <&k3_clks 57 8>;
                mmc-ddr-1_8v;
-               mmc-hs200-1_8v;
                ti,trm-icp = <0x2>;
                bus-width = <8>;
                ti,clkbuf-sel = <0x7>;
                ti,otap-del-sel-legacy = <0x0>;
                ti,otap-del-sel-mmc-hs = <0x0>;
                ti,otap-del-sel-ddr52 = <0x5>;
-               ti,otap-del-sel-hs200 = <0x5>;
                ti,itap-del-sel-legacy = <0xa>;
                ti,itap-del-sel-mmc-hs = <0x1>;
                status = "disabled";

(The experiment I suggested earlier with `no-1-8-v` was not really valid for eMMC use cases, it's more appropriate for SD cards which is not where your issue is.)

Regards, Andreas

Hi,

I had disabling the eMMC high-speed mode.

It's boot over u-boot stage,but durring boot in kernel stage will stuck random time.

I test many time,maybe boot finsh at 25s 135s 280s or not.

boot 73s

U-Boot SPL 2023.04-00001-gf5b119738d-dirty (Oct 12 2023 - 08:54:47 +0800)
SYSFW ABI: 3.1 (firmware rev 0x0009 '9.0.5--v09.00.05 (Kool Koala)')
SPL initial stack usage: 13376 bytes
Trying to boot from MMC1
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Starting ATF on ARM64 core...

NOTICE:  BL31: v2.8(release):v2.8-226-g2fcd408bb3-dirty
NOTICE:  BL31: Built : 00:42:57, Jan 13 2023

U-Boot SPL 2023.04-00001-gf5b119738d-dirty (Oct 12 2023 - 08:55:00 +0800)
SYSFW ABI: 3.1 (firmware rev 0x0009 '9.0.5--v09.00.05 (Kool Koala)')
SPL initial stack usage: 1856 bytes
MMC: no card present
** Bad device specification mmc 1 **
Couldn't find partition mmc 1:1
Error: could not access storage.
Trying to boot from MMC1
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted


U-Boot 2023.04-00001-gf5b119738d-dirty (Oct 12 2023 - 08:55:00 +0800)

SoC:   AM62X SR1.0 GP
Model: Texas Instruments AM625 SK
EEPROM not available at 80, trying to read at 81
Reading on-board EEPROM at 0x51 failed -1
DRAM:  2 GiB
Core:  71 devices, 31 uclasses, devicetree: separate
MMC:   mmc@fa10000: 0, mmc@fa00000: 1
Loading Environment from nowhere... OK
In:    serial
Out:   serial
Err:   serial
EEPROM not available at 80, trying to read at 81
Reading on-board EEPROM at 0x51 failed -1
Net:   Could not get PHY for ethernet@8000000port@1: addr 0
am65_cpsw_nuss_port ethernet@8000000port@1: phy_connect() failed
No ethernet found.

Hit any key to stop autoboot:  0
switch to partitions #0, OK
mmc0(part 0) is current device
SD/MMC found on device 0
AAEON special eMMC boot set start...
bootpart=0:2 mmc partconf 0 1 7 1
Set to BOOT_BUS_WIDTH = 0x2, RESET = 0x0, BOOT_MODE = 0x0
name_fdt= echo fdtfile= load mmc 0:2 0x90000000 /boot/fitImage
switch to partitions #0, OK
mmc0(part 0) is current device
SD/MMC found on device 0
8704306 bytes read in 112 ms (74.1 MiB/s)
Failed to load '/boot/dtb/'
Unknown command 'bootz' - try 'help'
AAEON special eMMC boot set end.
Failed to load 'boot.scr'
653 bytes read in 14 ms (44.9 KiB/s)
Loaded env from uEnv.txt
Importing environment from mmc0 ...
## Error: "main_cpsw0_qsgmii_phyinit" not defined
20593152 bytes read in 247 ms (79.5 MiB/s)
55311 bytes read in 15 ms (3.5 MiB/s)
Working FDT set to 88000000
4247 bytes read in 14 ms (295.9 KiB/s)
## Flattened Device Tree blob at 88000000
   Booting using the fdt blob at 0x88000000
Working FDT set to 88000000
ERROR: reserving fdt memory region failed (addr=ff700000 size=8ca000 flags=4)
   Loading Device Tree to 000000008feef000, end 000000008fffffff ... OK
Working FDT set to 8feef000

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 6.1.33 (root@andrew-GENESYS-CML5) (aarch64-none-linux-gnu-gcc (Arm GNU Toolchain 11.3.Rel1) 11.3.1 20220712, GNU ld (Arm GNU Toolchain 11.3.Rel1) 2.38.20220708) #3 SMP PREEMPT Thu Oct  5 13:13:17 CST 2023
[    0.000000] Machine model: Texas Instruments AM625 SK
[    0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002800000 (options '')
[    0.000000] printk: bootconsole [ns16550a0] enabled
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x00000000f7600000, size 128 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009c800000, size 3 MiB
[    0.000000] OF: reserved mem: initialized node ipc-memories@9c800000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009cb00000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node m4f-dma-memory@9cb00000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009cc00000, size 14 MiB
[    0.000000] OF: reserved mem: initialized node m4f-memory@9cc00000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009da00000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@9da00000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009db00000, size 12 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@9db00000, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000080000000-0x00000000ffffffff]
[    0.000000]   DMA32    empty
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000080000000-0x000000009c7fffff]
[    0.000000]   node   0: [mem 0x000000009c800000-0x000000009e6fffff]
[    0.000000]   node   0: [mem 0x000000009e700000-0x000000009e77ffff]
[    0.000000]   node   0: [mem 0x000000009e780000-0x000000009fffffff]
[    0.000000]   node   0: [mem 0x00000000a0000000-0x00000000ff6fffff]
[    0.000000]   node   0: [mem 0x00000000ff700000-0x00000000fffc9fff]
[    0.000000]   node   0: [mem 0x00000000fffca000-0x00000000ffffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000000ffffffff]
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: Trusted OS migration not required
[    0.000000] psci: SMC Calling Convention v1.2
[    0.000000] percpu: Embedded 19 pages/cpu s38376 r8192 d31256 u77824
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: detected: GIC system register CPU interface
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] alternatives: applying boot alternatives
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 516096
[    0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 mtdparts=spi-nand0:512k(ospi.tiboot3),2m(ospi.tispl),4m(ospi.u-boot),256k(ospi.env),256k(ospi.env.backup),98048k@32m(ospi.rootfs),256k@130816k(ospi.phypattern);omap2-nand.0:2m(NAND.tiboot3),2m(NAND.tispl),2m(NAND.tiboot3.backup),4m(NAND.u-boot),256k(NAND.u-boot-env),256k(NAND.u-boot-env.backup),-(NAND.file-system) root=PARTUUID=09a7d6ff-02 rw rootfstype=ext4 rootwait
[    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 1838100K/2097152K available (12480K kernel code, 1294K rwdata, 4048K rodata, 2176K init, 501K bss, 127980K reserved, 131072K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU event tracing is enabled.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
[    0.000000]  Trampoline variant of Tasks RCU enabled.
[    0.000000]  Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: 256 SPIs implemented
[    0.000000] GICv3: 0 Extended SPIs implemented
[    0.000000] Root IRQ handler: gic_handle_irq
[    0.000000] GICv3: GICv3 features: 16 PPIs
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001880000
[    0.000000] ITS [mem 0x01820000-0x0182ffff]
[    0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS
[    0.000000] ITS@0x0000000001820000: Devices Table too large, reduce ids 20->19
[    0.000000] ITS@0x0000000001820000: allocated 524288 Devices @80800000 (flat, esz 8, psz 64K, shr 0)
[    0.000000] ITS: using cache flushing for cmd queue
[    0.000000] GICv3: using LPI property table @0x0000000080040000
[    0.000000] GIC: using cache flushing for LPI property table
[    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000080050000
[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0x3ffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns
[    0.000001] sched_clock: 58 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
[    0.008531] Console: colour dummy device 80x25
[    0.013126] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
[    0.023808] pid_max: default: 32768 minimum: 301
[    0.028585] LSM: Security Framework initializing
[    0.033439] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.041023] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.050861] cblist_init_generic: Setting adjustable number of callback queues.
[    0.058322] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.064620] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.071019] rcu: Hierarchical SRCU implementation.
[    0.075926] rcu:     Max phase no-delay instances is 1000.
[    0.081542] Platform MSI: msi-controller@1820000 domain created
[    0.087848] PCI/MSI: /bus@f0000/interrupt-controller@1800000/msi-controller@1820000 domain created
[    0.097661] EFI services will not be available.
[    0.102586] smp: Bringing up secondary CPUs ...
[    0.107903] Detected VIPT I-cache on CPU1
[    0.108021] GICv3: CPU1: found redistributor 1 region 0:0x00000000018a0000
[    0.108040] GICv3: CPU1: using allocated LPI pending table @0x0000000080060000
[    0.108098] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.108806] Detected VIPT I-cache on CPU2
[    0.108889] GICv3: CPU2: found redistributor 2 region 0:0x00000000018c0000
[    0.108903] GICv3: CPU2: using allocated LPI pending table @0x0000000080070000
[    0.108938] CPU2: Booted secondary processor 0x0000000002 [0x410fd034]
[    0.109565] Detected VIPT I-cache on CPU3
[    0.109647] GICv3: CPU3: found redistributor 3 region 0:0x00000000018e0000
[    0.109663] GICv3: CPU3: using allocated LPI pending table @0x0000000080080000
[    0.109694] CPU3: Booted secondary processor 0x0000000003 [0x410fd034]
[    0.109763] smp: Brought up 1 node, 4 CPUs
[    0.189494] SMP: Total of 4 processors activated.
[    0.194307] CPU features: detected: 32-bit EL0 Support
[    0.199580] CPU features: detected: CRC32 instructions
[    0.204903] CPU: All CPU(s) started at EL2
[    0.209099] alternatives: applying system-wide alternatives
[    0.216682] devtmpfs: initialized
[    0.228376] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.238380] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.249948] pinctrl core: initialized pinctrl subsystem
[    0.255947] DMI not present or invalid.
[    0.260514] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.267802] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
[    0.275370] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.283485] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.291674] audit: initializing netlink subsys (disabled)
[    0.297371] audit: type=2000 audit(0.192:1): state=initialized audit_enabled=0 res=1
[    0.297889] thermal_sys: Registered thermal governor 'step_wise'
[    0.305303] thermal_sys: Registered thermal governor 'power_allocator'
[    0.311494] cpuidle: using governor menu
[    0.322368] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.329399] ASID allocator initialised with 65536 entries
[    0.346070] platform display: Fixed dependency cycle(s) with /bus@f0000/dss@30200000
[    0.357832] KASLR disabled due to lack of seed
[    0.369697] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
[    0.376671] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
[    0.383081] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
[    0.390021] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
[    0.396429] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
[    0.403368] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
[    0.409775] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
[    0.416714] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
[    0.424990] k3-chipinfo 43000014.chipid: Family:AM62X rev:SR1.0 JTAGID[0x0bb7e02f] Detected
[    0.435173] iommu: Default domain type: Translated
[    0.440191] iommu: DMA domain TLB invalidation policy: strict mode
[    0.446880] SCSI subsystem initialized
[    0.451105] usbcore: registered new interface driver usbfs
[    0.456753] usbcore: registered new interface driver hub
[    0.462208] usbcore: registered new device driver usb
[    0.467944] pps_core: LinuxPPS API ver. 1 registered
[    0.473029] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.482380] PTP clock support registered
[    0.486521] EDAC MC: Ver: 3.0.0
[    0.490706] omap-mailbox 29000000.mailbox: omap mailbox rev 0x66fc9100
[    0.497858] FPGA manager framework
[    0.501441] Advanced Linux Sound Architecture Driver Initialized.
[    0.508710] clocksource: Switched to clocksource arch_sys_counter
[    0.515222] VFS: Disk quotas dquot_6.6.0
[    0.519278] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.532408] NET: Registered PF_INET protocol family
[    0.537711] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.546950] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
[    0.555760] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.563699] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.571903] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
[    0.579905] TCP: Hash tables configured (established 16384 bind 16384)
[    0.586820] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.593745] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.601271] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.607568] RPC: Registered named UNIX socket transport module.
[    0.613649] RPC: Registered udp transport module.
[    0.618460] RPC: Registered tcp transport module.
[    0.623268] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.629860] NET: Registered PF_XDP protocol family
[    0.634773] PCI: CLS 0 bytes, default 64
[    0.639631] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available
[    0.649791] Initialise system trusted keyrings
[    0.654639] workingset: timestamp_bits=46 max_order=19 bucket_order=0
[    0.667243] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.673947] NFS: Registering the id_resolver key type
[    0.679186] Key type id_resolver registered
[    0.683463] Key type id_legacy registered
[    0.687643] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.694500] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    0.702268] 9p: Installing v9fs 9p2000 file system support
[    0.743133] Key type asymmetric registered
[    0.747325] Asymmetric key parser 'x509' registered
[    0.752366] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[    0.760112] io scheduler mq-deadline registered
[    0.764751] io scheduler kyber registered
[    0.772181] pinctrl-single 4084000.pinctrl: 34 pins, size 136
[    0.778780] pinctrl-single f4000.pinctrl: 171 pins, size 684
[    0.785641] pinctrl-single a40000.pinctrl: 512 pins, size 2048
[    0.799554] Serial: 8250/16550 driver, 7 ports, IRQ sharing enabled
[    0.815121] loop: module loaded
[    0.819721] megasas: 07.719.03.00-rc1
[    0.827725] tun: Universal TUN/TAP device driver, 1.6
[    0.833687] thunder_xcv, ver 1.0
[    0.837038] thunder_bgx, ver 1.0
[    0.840363] nicpf, ver 1.0
[    0.843551] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version
[    0.850938] hns3: Copyright (c) 2017 Huawei Corporation.
[    0.856430] hclge is initializing
[    0.859839] e1000: Intel(R) PRO/1000 Network Driver
[    0.864830] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    0.870736] e1000e: Intel(R) PRO/1000 Network Driver
[    0.875811] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    0.881893] igb: Intel(R) Gigabit Ethernet Network Driver
[    0.887412] igb: Copyright (c) 2007-2014 Intel Corporation.
[    0.893138] igbvf: Intel(R) Gigabit Virtual Function Network Driver
[    0.899546] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    0.905739] sky2: driver version 1.30
[    0.910252] VFIO - User Level meta-driver version: 0.3
[    0.916401] usbcore: registered new interface driver usb-storage
[    0.923504] i2c_dev: i2c /dev entries driver
[    0.930117] sdhci: Secure Digital Host Controller Interface driver
[    0.936482] sdhci: Copyright(c) Pierre Ossman
[    0.941445] Synopsys Designware Multimedia Card Interface Driver
[    0.948082] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.954820] ledtrig-cpu: registered to indicate activity on CPUs
[    0.961189] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
[    0.968082] hid: raw HID events driver (C) Jiri Kosina
[    0.973472] usbcore: registered new interface driver usbhid
[    0.979176] usbhid: USB HID core driver
[    0.984481] optee: probing for conduit method.
[    0.989085] optee: revision 3.20 (8e74d476)
[    0.989402] optee: dynamic shared memory is enabled
[    0.998942] optee: initialized driver
[    1.004543] Initializing XFRM netlink socket
[    1.008977] NET: Registered PF_PACKET protocol family
[    1.014374] 9pnet: Installing 9P2000 support
[    1.018835] Key type dns_resolver registered
[    1.023652] registered taskstats version 1
[    1.027880] Loading compiled-in X.509 certificates
[    1.041226] ti-sci 44043000.system-controller: ABI: 3.1 (firmware rev 0x0009 '9.0.5--v09.00.05 (Kool Koala)')
[    1.104930] omap-gpmc 3b000000.memory-controller: GPMC revision 6.0
[    1.111377] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000
[    1.119293] omap_i2c 20000000.i2c: bus 0 rev0.12 at 400 kHz
[    1.126480] omap_i2c 20010000.i2c: bus 1 rev0.12 at 100 kHz
[    1.132726] ti-sci-intr 4210000.interrupt-controller: Interrupt Router 5 domain created
[    1.141080] ti-sci-intr bus@f0000:interrupt-controller@a00000: Interrupt Router 3 domain created
[    1.150318] ti-sci-inta 48000000.interrupt-controller: Interrupt Aggregator domain 28 created
[    1.160295] ti-udma 485c0100.dma-controller: Number of rings: 82
[    1.168547] ti-udma 485c0100.dma-controller: Channels: 48 (bchan: 18, tchan: 12, rchan: 18)
[    1.179777] ti-udma 485c0000.dma-controller: Number of rings: 150
[    1.189949] ti-udma 485c0000.dma-controller: Channels: 35 (tchan: 20, rchan: 15)
[    1.200223] printk: console [ttyS2] disabled
[    1.204685] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 239, base_baud = 3000000) is a 8250
[    1.213599] printk: console [ttyS2] enabled
[    1.213599] printk: console [ttyS2] enabled
[    1.222051] printk: bootconsole [ns16550a0] disabled
[    1.222051] printk: bootconsole [ns16550a0] disabled
[    1.233331] 2810000.serial: ttyS1 at MMIO 0x2810000 (irq = 241, base_baud = 3000000) is a 8250
[    1.243105] 2840000.serial: ttyS4 at MMIO 0x2840000 (irq = 242, base_baud = 3000000) is a 8250
[    1.252818] 2850000.serial: ttyS5 at MMIO 0x2850000 (irq = 243, base_baud = 3000000) is a 8250
[    1.262472] 2860000.serial: ttyS6 at MMIO 0x2860000 (irq = 244, base_baud = 3000000) is a 8250
[    1.271966] am65-cpsw-nuss 8000000.ethernet: initializing am65 cpsw nuss version 0x6BA01103, cpsw version 0x6BA81103 Ports: 3 quirks:00000006
[    1.284896] am65-cpsw-nuss 8000000.ethernet: initialized cpsw ale version 1.5
[    1.292027] am65-cpsw-nuss 8000000.ethernet: ALE Table size 512
[    1.298678] am65-cpsw-nuss 8000000.ethernet: CPTS ver 0x4e8a010c, freq:500000000, add_val:1 pps:0
[    1.309435] am65-cpsw-nuss 8000000.ethernet: set new flow-id-base 19
[    1.318811] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    1.320419] mmc0: CQHCI version 5.10
[    1.326876] cpufreq: __target_index: Failed to change cpu frequency: -34
[    1.327105] pca953x 1-0022: supply vcc not found, using dummy regulator
[    1.327208] pca953x 1-0022: using AI
[    1.356566] debugfs: Directory 'pd:182' with parent 'pm_genpd' already present!
[    1.364017] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    1.364316] mmc1: CQHCI version 5.10
[    1.371382] mmc0: SDHCI controller on fa10000.mmc [fa10000.mmc] using ADMA 64-bit
[    1.372059] cpufreq: __target_index: Failed to change cpu frequency: -34
[    1.378159] ALSA device list:
[    1.386597] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    1.389817]   No soundcards found.
[    1.392767] cpufreq: __target_index: Failed to change cpu frequency: -34
[    1.436395] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    1.444444] cpufreq: __target_index: Failed to change cpu frequency: -34
[    1.444638] mmc0: Command Queue Engine enabled
[    1.456242] mmc0: new HS200 MMC card at address 0001
[    1.462708] mmcblk0: mmc0:0001 TX2932 29.1 GiB
[    1.469578]  mmcblk0: p1 p2 p3
[    1.473118] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    1.473514] mmcblk0boot0: mmc0:0001 TX2932 4.00 MiB
[    1.481137] cpufreq: __target_index: Failed to change cpu frequency: -34
[    1.487217] mmcblk0boot1: mmc0:0001 TX2932 4.00 MiB
[    1.498775] mmcblk0rpmb: mmc0:0001 TX2932 4.00 MiB, chardev (240:0)
[    2.889120] sdhci-am654 fa00000.mmc: Power on failed
[    2.925262] mmc1: SDHCI controller on fa00000.mmc [fa00000.mmc] using ADMA 64-bit
[    2.933511] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    2.941665] cpufreq: __target_index: Failed to change cpu frequency: -34
[    2.970656] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    2.978707] cpufreq: __target_index: Failed to change cpu frequency: -34
[    2.986271] EXT4-fs (mmcblk0p2): recovery complete
[    2.991411] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
[    3.000079] VFS: Mounted root (ext4 filesystem) on device 179:2.
[    3.008421] devtmpfs: mounted
[    3.011850] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.012910] Freeing unused kernel memory: 2176K
[    3.019874] cpufreq: __target_index: Failed to change cpu frequency: -34
[    3.024502] Run /sbin/init as init process
[    3.158505] mmc0: running CQE recovery
[    3.162821] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.164009] ------------[ cut here ]------------
[    3.170836] cpufreq: __target_index: Failed to change cpu frequency: -34
[    3.175421] mmc0: cqhci: spurious TCN for tag 12
[    3.175483] WARNING: CPU: 0 PID: 52 at drivers/mmc/host/cqhci-core.c:786 cqhci_irq+0x3b0/0x66c
[    3.195295] Modules linked in:
[    3.198347] CPU: 0 PID: 52 Comm: kworker/0:1H Not tainted 6.1.33 #3
[    3.204604] Hardware name: Texas Instruments AM625 SK (DT)
[    3.210079] Workqueue: kblockd blk_mq_run_work_fn
[    3.214784] pstate: 600000c5 (nZCv daIF -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[    3.221734] pc : cqhci_irq+0x3b0/0x66c
[    3.225477] lr : cqhci_irq+0x3b0/0x66c
[    3.229219] sp : ffff800008003dc0
[    3.232522] x29: ffff800008003dc0 x28: ffff000000e28e40 x27: ffff000001158580
[    3.239650] x26: 0000000000000001 x25: ffff000000272498 x24: ffff800008fa4bc8
[    3.246779] x23: ffff80000938e5b0 x22: ffff000001158000 x21: ffff000000272480
[    3.253907] x20: 0000000000000002 x19: 000000000000000c x18: ffffffffffffffff
[    3.261034] x17: ffff80006e1c3000 x16: ffff800008000000 x15: ffff8000093b5176
[    3.268162] x14: 0000000000000000 x13: ffff8000093b5172 x12: 204e43542073756f
[    3.275290] x11: ffff800009281540 x10: 000000000000000a x9 : 000000000000000c
[    3.282417] x8 : ffff8000092814f8 x7 : ffff800008003bd0 x6 : 000000000000000c
[    3.289544] x5 : 0000000000000000 x4 : 0000000000000000 x3 : 00000000ffffffff
[    3.296671] x2 : 0000000000000000 x1 : 0000000000000000 x0 : ffff000000e28e40
[    3.303800] Call trace:
[    3.306239]  cqhci_irq+0x3b0/0x66c
[    3.309635]  sdhci_am654_cqhci_irq+0x54/0x8c
[    3.313902]  sdhci_irq+0xb4/0xed0
[    3.317211]  __handle_irq_event_percpu+0x5c/0x164
[    3.321910]  handle_irq_event+0x4c/0xbc
[    3.325737]  handle_fasteoi_irq+0xa4/0x1f4
[    3.329828]  generic_handle_domain_irq+0x2c/0x44
[    3.334435]  gic_handle_irq+0x50/0x124
[    3.338179]  call_on_irq_stack+0x24/0x4c
[    3.342096]  do_interrupt_handler+0x80/0x84
[    3.346272]  el1_interrupt+0x34/0x70
[    3.349845]  el1h_64_irq_handler+0x18/0x2c
[    3.353933]  el1h_64_irq+0x64/0x68
[    3.357326]  _raw_spin_unlock_irqrestore+0x14/0x50
[    3.362109]  cqhci_request+0xd0/0x534
[    3.365765]  mmc_cqe_start_req+0x58/0x70
[    3.369683]  mmc_blk_mq_issue_rq+0x448/0x880
[    3.373946]  mmc_mq_queue_rq+0x118/0x2ac
[    3.377860]  blk_mq_dispatch_rq_list+0x1a4/0x8a4
[    3.382471]  __blk_mq_sched_dispatch_requests+0xb4/0x160
[    3.387777]  blk_mq_sched_dispatch_requests+0x3c/0x80
[    3.392823]  __blk_mq_run_hw_queue+0x80/0xbc
[    3.397084]  blk_mq_run_work_fn+0x20/0x30
[    3.401085]  process_one_work+0x1d0/0x320
[    3.405087]  worker_thread+0x14c/0x444
[    3.408827]  kthread+0x10c/0x110
[    3.412052]  ret_from_fork+0x10/0x20
[    3.415621] ---[ end trace 0000000000000000 ]---
[    3.420917] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.428925] cpufreq: __target_index: Failed to change cpu frequency: -34
[   64.661116] mmc0: cqhci: timeout for tag 7, qcnt 6
[   64.666098] mmc0: cqhci: ============ CQHCI REGISTER DUMP ===========
[   64.672626] mmc0: cqhci: Caps:      0x000030c8 | Version:  0x00000510
[   64.679137] mmc0: cqhci: Config:    0x00000101 | Control:  0x00000000
[   64.685642] mmc0: cqhci: Int stat:  0x00000000 | Int enab: 0x00000016
[   64.692196] mmc0: cqhci: Int sig:   0x00000016 | Int Coal: 0x00000000
[   64.698791] mmc0: cqhci: TDL base:  0x8158a000 | TDL up32: 0x00000000
[   64.705378] mmc0: cqhci: Doorbell:  0x000002f8 | TCN:      0x00000000
[   64.711894] mmc0: cqhci: Dev queue: 0x00000000 | Dev Pend: 0x00000000
[   64.718386] mmc0: cqhci: Task clr:  0x00000000 | SSC1:     0x00011000
[   64.724894] mmc0: cqhci: SSC2:      0x00000001 | DCMD rsp: 0x00000000
[   64.731396] mmc0: cqhci: RED mask:  0xfdf9a080 | TERRI:    0x8c2e0000
[   64.737875] mmc0: cqhci: Resp idx:  0x0000002e | Resp arg: 0x00000900
[   64.744342] mmc0: sdhci: ============ SDHCI REGISTER DUMP ===========
[   64.750819] mmc0: sdhci: Sys addr:  0x00000100 | Version:  0x00001004
[   64.757293] mmc0: sdhci: Blk size:  0x00007080 | Blk cnt:  0x00000000
[   64.763754] mmc0: sdhci: Argument:  0x00000000 | Trn mode: 0x00000013
[   64.770211] mmc0: sdhci: Present:   0x01ff00f0 | Host ctl: 0x0000003c
[   64.776674] mmc0: sdhci: Power:     0x0000000f | Blk gap:  0x00000080
[   64.783137] mmc0: sdhci: Wake-up:   0x00000000 | Clock:    0x00000007
[   64.789598] mmc0: sdhci: Timeout:   0x0000000e | Int stat: 0x00000000
[   64.796056] mmc0: sdhci: Int enab:  0x02ff4000 | Sig enab: 0x02ff4000
[   64.802509] mmc0: sdhci: ACmd stat: 0x00000000 | Slot int: 0x00000000
[   64.808957] mmc0: sdhci: Caps:      0x3decc801 | Caps_1:   0x18002407
[   64.815399] mmc0: sdhci: Cmd:       0x0000153a | Max curr: 0x00000000
[   64.821847] mmc0: sdhci: Resp[0]:   0x00000900 | Resp[1]:  0xffffffff
[   64.828288] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   64.836284] cpufreq: __target_index: Failed to change cpu frequency: -34
[   64.842990] mmc0: sdhci: Resp[2]:   0x328f5903 | Resp[3]:  0x00d04f01
[   64.849422] mmc0: sdhci: Host ctl2: 0x0000000b
[   64.853860] mmc0: sdhci: ADMA Err:  0x00000000 | ADMA Ptr: 0x000000008139920c
[   64.860985] mmc0: sdhci: ============================================
[   64.867423] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   64.875416] cpufreq: __target_index: Failed to change cpu frequency: -34
[   64.882149] mmc0: running CQE recovery
[   64.924484] systemd[1]: System time before build time, advancing clock.
[   64.960817] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   64.968876] cpufreq: __target_index: Failed to change cpu frequency: -34
[   64.977695] NET: Registered PF_INET6 protocol family
[   64.984293] Segment Routing with IPv6
[   64.988029] In-situ OAM (IOAM) with IPv6
[   65.030336] systemd[1]: Configuration file /etc/systemd/system.conf is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.046907] systemd[1]: systemd 252.6-1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[   65.078867] systemd[1]: Detected architecture arm64.

Welcome to Debian GNU/Linux 12 (bookworm)!

[   65.098497] systemd[1]: Hostname set to <am62xx>.
[   65.171295] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   65.179483] cpufreq: __target_index: Failed to change cpu frequency: -34
[   65.292886] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   65.301014] cpufreq: __target_index: Failed to change cpu frequency: -34
[   65.403622] systemd[1]: Configuration file /lib/systemd/system/graphical.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.430515] systemd[1]: Configuration file /lib/systemd/system/shutdown.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.446573] systemd[1]: Configuration file /lib/systemd/system/systemd-update-utmp-runlevel.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.473263] systemd[1]: Configuration file /lib/systemd/system/systemd-journald.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.497126] systemd[1]: Configuration file /lib/systemd/system/systemd-journald.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.517337] systemd[1]: Configuration file /lib/systemd/system/sysinit.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.537656] systemd[1]: Configuration file /lib/systemd/system/veritysetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.553505] systemd[1]: Configuration file /lib/systemd/system/systemd-udevd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.568868] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   65.571829] systemd[1]: Configuration file /lib/systemd/system/systemd-udevd-kernel.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.576898] cpufreq: __target_index: Failed to change cpu frequency: -34
[   65.601669] systemd[1]: Configuration file /lib/systemd/system/systemd-udevd-control.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.619364] systemd[1]: Configuration file /lib/systemd/system/systemd-udev-trigger.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.636948] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-setup.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.654850] systemd[1]: Configuration file /lib/systemd/system/initrd-switch-root.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.672312] systemd[1]: Configuration file /lib/systemd/system/initrd-cleanup.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.688874] systemd[1]: Configuration file /lib/systemd/system/initrd.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.705635] systemd[1]: Configuration file /lib/systemd/system/systemd-pcrphase-initrd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.723748] systemd[1]: Configuration file /lib/systemd/system/systemd-sysext.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.740633] systemd[1]: Configuration file /lib/systemd/system/cryptsetup-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.756948] systemd[1]: Configuration file /lib/systemd/system/initrd-parse-etc.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.774106] systemd[1]: Configuration file /lib/systemd/system/initrd-usr-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.790648] systemd[1]: Configuration file /lib/systemd/system/initrd-root-device.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.808810] systemd[1]: Configuration file /lib/systemd/system/remote-veritysetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.825647] systemd[1]: Configuration file /lib/systemd/system/veritysetup-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.842080] systemd[1]: Configuration file /lib/systemd/system/remote-fs-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.858541] systemd[1]: Configuration file /lib/systemd/system/remote-cryptsetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.875025] systemd[1]: Configuration file /lib/systemd/system/basic.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.890752] systemd[1]: Configuration file /lib/systemd/system/slices.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.906072] systemd[1]: Configuration file /lib/systemd/system/paths.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.921110] systemd[1]: Configuration file /lib/systemd/system/timers.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.938550] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-clean.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.956221] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-clean.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.974086] systemd[1]: Configuration file /lib/systemd/system/time-set.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   65.989804] systemd[1]: Configuration file /lib/systemd/system/man-db.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.009319] systemd[1]: Configuration file /lib/systemd/system/time-sync.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.025322] systemd[1]: Configuration file /lib/systemd/system/man-db.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.041466] systemd[1]: Configuration file /lib/systemd/system/logrotate.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.057160] systemd[1]: Configuration file /lib/systemd/system/logrotate.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.073242] systemd[1]: Configuration file /lib/systemd/system/fstrim.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.088683] systemd[1]: Configuration file /lib/systemd/system/fstrim.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.105365] systemd[1]: Configuration file /lib/systemd/system/e2scrub_all.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.121327] systemd[1]: Configuration file /lib/systemd/system/e2scrub_all.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.137308] systemd[1]: Configuration file /lib/systemd/system/dpkg-db-backup.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.153940] systemd[1]: Configuration file /lib/systemd/system/dpkg-db-backup.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.170529] systemd[1]: Configuration file /lib/systemd/system/apt-daily.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.186504] systemd[1]: Configuration file /lib/systemd/system/apt-daily.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.202731] systemd[1]: Configuration file /lib/systemd/system/NetworkManager.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.219363] systemd[1]: Configuration file /lib/systemd/system/dbus.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.234661] systemd[1]: Configuration file /lib/systemd/system/dbus.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.249949] systemd[1]: Configuration file /lib/systemd/system/network-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.265930] systemd[1]: Configuration file /lib/systemd/system/systemd-networkd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.284674] systemd[1]: Configuration file /lib/systemd/system/systemd-networkd.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.301580] systemd[1]: Configuration file /lib/systemd/system/network-online.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.318894] systemd[1]: Configuration file /lib/systemd/system/networking.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.335342] systemd[1]: Configuration file /lib/systemd/system/ifupdown-pre.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.351694] systemd[1]: Configuration file /lib/systemd/system/NetworkManager-wait-online.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.369988] systemd[1]: Configuration file /lib/systemd/system/network.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.385335] systemd[1]: Configuration file /lib/systemd/system/apt-daily-upgrade.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.402470] systemd[1]: Configuration file /lib/systemd/system/apt-daily-upgrade.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.419670] systemd[1]: Configuration file /lib/systemd/system/initrd-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.435558] systemd[1]: Configuration file /lib/systemd/system/initrd-root-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.453279] systemd[1]: Configuration file /lib/systemd/system/initrd-udevadm-cleanup-db.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.471909] systemd[1]: Configuration file /lib/systemd/system/systemd-udev-settle.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.489376] systemd[1]: Configuration file /lib/systemd/system/initrd-switch-root.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.506546] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-setup-dev.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.525204] systemd[1]: Configuration file /lib/systemd/system/local-fs-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.541586] systemd[1]: Configuration file /lib/systemd/system/systemd-timesyncd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.560968] systemd[1]: Configuration file /lib/systemd/system/systemd-remount-fs.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.578482] systemd[1]: Configuration file /lib/systemd/system/systemd-fsck-root.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.595783] systemd[1]: Configuration file /lib/systemd/system/systemd-fsckd.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.612229] systemd[1]: Configuration file /lib/systemd/system/systemd-fsckd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.628595] systemd[1]: Configuration file /lib/systemd/system/systemd-sysusers.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.645722] systemd[1]: Configuration file /lib/systemd/system/systemd-sysctl.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.662483] systemd[1]: Configuration file /lib/systemd/system/systemd-repart.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.679398] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.696185] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.711786] systemd[1]: Configuration file /lib/systemd/system/systemd-random-seed.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.730090] systemd[1]: Configuration file /lib/systemd/system/first-boot-complete.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.747117] systemd[1]: Configuration file /lib/systemd/system/systemd-pstore.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.763935] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.779621] systemd[1]: Configuration file /lib/systemd/system/systemd-pcrphase.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.797219] systemd[1]: Configuration file /lib/systemd/system/systemd-user-sessions.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.814923] systemd[1]: Configuration file /lib/systemd/system/nss-user-lookup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.831575] systemd[1]: Configuration file /lib/systemd/system/remote-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.847326] systemd[1]: Configuration file /lib/systemd/system/systemd-pcrphase-sysinit.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.865210] systemd[1]: Configuration file /lib/systemd/system/systemd-modules-load.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.882871] systemd[1]: Configuration file /lib/systemd/system/systemd-machine-id-commit.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.901251] systemd[1]: Configuration file /lib/systemd/system/systemd-journal-flush.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.919028] systemd[1]: Configuration file /lib/systemd/system/systemd-firstboot.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.936254] systemd[1]: Configuration file /lib/systemd/system/systemd-binfmt.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.953164] systemd[1]: Configuration file /lib/systemd/system/proc-sys-fs-binfmt_misc.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.971267] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-console.path is marked executable. Please remove executable permission bits. Proceeding anyway.
[   66.990109] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-console.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.009036] systemd[1]: Configuration file /lib/systemd/system/sys-kernel-tracing.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.026399] systemd[1]: Configuration file /lib/systemd/system/sys-kernel-debug.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.043432] systemd[1]: Configuration file /lib/systemd/system/sys-kernel-config.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.060664] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.076347] systemd[1]: Configuration file /lib/systemd/system/sys-fs-fuse-connections.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.095116] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.110771] systemd[1]: Configuration file /lib/systemd/system/proc-sys-fs-binfmt_misc.automount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.129839] systemd[1]: Configuration file /lib/systemd/system/kmod-static-nodes.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.146975] systemd[1]: Configuration file /lib/systemd/system/integritysetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.162847] systemd[1]: Configuration file /lib/systemd/system/dev-mqueue.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.178866] systemd[1]: Configuration file /lib/systemd/system/dev-hugepages.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.195151] systemd[1]: Configuration file /lib/systemd/system/cryptsetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.210665] systemd[1]: Configuration file /lib/systemd/system/emergency.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.226136] systemd[1]: Configuration file /lib/systemd/system/emergency.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.241911] systemd[1]: Configuration file /lib/systemd/system/swap.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.256854] systemd[1]: Configuration file /lib/systemd/system/local-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.273853] systemd[1]: Configuration file /lib/systemd/system/syslog.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.289870] systemd[1]: Configuration file /lib/systemd/system/systemd-journald-audit.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.307486] systemd[1]: Configuration file /lib/systemd/system/systemd-journald-dev-log.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.325936] systemd[1]: Configuration file /lib/systemd/system/sockets.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.342722] systemd[1]: Configuration file /lib/systemd/system/systemd-initctl.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.359505] systemd[1]: Configuration file /lib/systemd/system/systemd-initctl.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.376029] systemd[1]: Configuration file /lib/systemd/system/multi-user.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.399485] systemd[1]: Configuration file /lib/systemd/system/systemd-logind.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.419679] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.435413] systemd[1]: Configuration file /lib/systemd/system/user.slice is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.451083] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-wall.path is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.469606] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-wall.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.487996] systemd[1]: Configuration file /lib/systemd/system/ssh.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.508574] systemd[1]: Configuration file /lib/systemd/system/getty.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.525650] systemd[1]: Configuration file /lib/systemd/system/serial-getty@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.544581] systemd[1]: Configuration file /lib/systemd/system/rc-local.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.561378] systemd[1]: Configuration file /usr/lib/systemd/system/rc-local.service.d/debian.conf is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.578270] systemd[1]: Configuration file /lib/systemd/system/getty-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.594920] systemd[1]: Configuration file /lib/systemd/system/getty@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.612636] systemd[1]: Configuration file /lib/systemd/system/getty-static.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.628992] systemd[1]: Configuration file /etc/systemd/system/eGTouchD.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.645098] systemd[1]: Configuration file /lib/systemd/system/e2scrub_reap.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.661515] systemd[1]: Configuration file /lib/systemd/system/cron.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.678151] systemd[1]: Configuration file /lib/systemd/system/nss-lookup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.694060] systemd[1]: Configuration file /lib/systemd/system/rescue.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.711278] systemd[1]: Configuration file /lib/systemd/system/systemd-update-utmp.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.729969] systemd[1]: Configuration file /lib/systemd/system/rescue.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[   67.749874] systemd[1]: Queued start job for default target graphical.target.
[   67.776961] systemd[1]: Created slice system-getty.slice - Slice /system/getty.
[  OK  ] Created slice system-getty.slice - Slice /system/getty.
[   67.800740] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   67.802818] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
[   67.808795] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Created slice system-modpr…lice - Slice /system/modprobe.
[   67.840727] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   67.842758] systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
[   67.848768] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Created slice system-seria… - Slice /system/serial-getty.
[   67.882171] systemd[1]: Created slice user.slice - User and Session Slice.
[  OK  ] Created slice user.slice - User and Session Slice.
[   67.905330] systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
[  OK  ] Started systemd-ask-passwo…quests to Console Directory Watch.
[   67.933233] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
[  OK  ] Started systemd-ask-passwo… Requests to Wall Directory Watch.
[   67.962094] systemd[1]: proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point was skipped because of an unmet condition check (ConditionPathExists=/proc/sys/fs/binfmt_misc).
[   67.982098] systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
[  OK  ] Reached target cryptsetup.…get - Local Encrypted Volumes.
[   68.005027] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
[  OK  ] Reached target integrityse…Local Integrity Protected Volumes.
[   68.029102] systemd[1]: Reached target paths.target - Path Units.
[  OK  ] Reached target paths.target - Path Units.
[   68.053050] systemd[1]: Reached target remote-fs.target - Remote File Systems.
[  OK  ] Reached target remote-fs.target - Remote File Systems.
[   68.076971] systemd[1]: Reached target slices.target - Slice Units.
[  OK  ] Reached target slices.target - Slice Units.
[   68.101097] systemd[1]: Reached target swap.target - Swaps.
[  OK  ] Reached target swap.target - Swaps.
[   68.121231] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
[  OK  ] Reached target veritysetup… - Local Verity Protected Volumes.
[   68.145864] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe.
[  OK  ] Listening on systemd-initc… initctl Compatibility Named Pipe.
[   68.171085] systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket.
[  OK  ] Listening on systemd-journ…socket - Journal Audit Socket.
[   68.198522] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
[  OK  ] Listening on systemd-journ…t - Journal Socket (/dev/log).
[   68.226541] systemd[1]: Listening on systemd-journald.socket - Journal Socket.
[  OK  ] Listening on systemd-journald.socket - Journal Socket.
[   68.257991] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
[  OK  ] Listening on systemd-udevd….socket - udev Control Socket.
[   68.284218] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
[  OK  ] Listening on systemd-udevd…l.socket - udev Kernel Socket.
[   68.350068] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
         Mounting dev-hugepages.mount - Huge Pages File System...
[   68.384004] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
         Mounting dev-mqueue.mount▒▒POSIX Message Queue File System...
[   68.415921] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
         Mounting sys-kernel-debug.… - Kernel Debug File System...
[   68.441904] systemd[1]: sys-kernel-tracing.mount - Kernel Trace File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/tracing).
[   68.492597] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
         Starting kmod-static-nodes…ate List of Static Device Nodes...
[   68.553655] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
         Starting modprobe@configfs…m - Load Kernel Module configfs...
[   68.585259] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
         Starting modprobe@dm_mod.s…[0m - Load Kernel Module dm_mod...
[   68.608568] device-mapper: ioctl: 4.47.0-ioctl (2022-07-28) initialised: dm-devel@redhat.com
[   68.623055] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
         Starting modprobe@drm.service - Load Kernel Module drm...
[   68.669720] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
         Starting modprobe@efi_psto…- Load Kernel Module efi_pstore...
[   68.705223] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
         Starting modprobe@fuse.ser…e - Load Kernel Module fuse...
[   68.728051] fuse: init (API version 7.37)
[   68.738679] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
         Starting modprobe@loop.ser…e - Load Kernel Module loop...
[   68.773965] systemd[1]: Starting systemd-journald.service - Journal Service...
         Starting systemd-journald.service - Journal Service...
[   68.809195] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   68.817237] cpufreq: __target_index: Failed to change cpu frequency: -34
[   68.829662] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
         Starting systemd-modules-l…rvice - Load Kernel Modules...
[   68.863241] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
         Starting systemd-remount-f…nt Root and Kerne[   68.874930] systemd-journald[161]: Configuration file /etc/systemd/journald.conf is marked executable. Please remove executable permission bits. Proceeding anyway.
l File Systems...
[   68.893683] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   68.902909] cpufreq: __target_index: Failed to change cpu frequency: -34
[   68.915290] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
         Starting systemd-udev-trig…[0m - Coldplug All udev Devices...
[   68.953514] systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
[  OK  ] Mounted dev-hugepages.mount - Huge Pages File System.
[   68.981697] systemd[1]: Started systemd-journald.service - Journal Service.
[  OK  ] Started systemd-journald.service - Journal Service.
[  OK  ] Mounted dev-mqueue.mount▒▒- POSIX Message Queue File System.
[  OK  ] Mounted sys-kernel-debug.m…nt - Kernel Debug File System.
[  OK  ] Finished kmod-static-nodes…reate List of Static Device Nodes.
[  OK  ] Finished modprobe@configfs…[0m - Load Kernel Module configfs.
[  OK  ] Finished modprobe@dm_mod.s…e - Load Kernel Module dm_mod.
[  OK  ] Finished modprobe@drm.service - Load Kernel Module drm.
[  OK  ] Finished modprobe@efi_psto…m - Load Kernel Module efi_pstore.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  OK  ] Finished modprobe@loop.service - Load Kernel Module loop.
[  OK  ] Finished systemd-modules-l…service - Load Kernel Modules.
[  OK  ] Finished systemd-remount-f…ount Root and Kernel File Systems.
         Mounting sys-fs-fuse-conne… - FUSE Control File System...
         Mounting sys-kernel-config…ernel Configuration File System...
         Starting systemd-journal-f…h Journal to Persistent Storage...
         Starting systemd-random-se…ice - Load/Save Random Seed...
[   69.327419] systemd-journald[161]: Received client request to flush runtime journal.
[   69.343989] systemd-journald[161]: File /var/log/journal/61e3cf19309f4a3a80b3ea3558380ffb/system.journal corrupted or uncleanly shut down, renaming and replacing.
         Starting systemd-sysctl.se…ce - Apply Kernel Variables...
         Starting systemd-sysusers.…rvice - Create System Users...
[  OK  ] Finished systemd-udev-trig…e - Coldplug All udev Devices.
[  OK  ] Mounted sys-fs-fuse-connec…nt - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.… Kernel Configuration File System.
[  OK  ] Finished systemd-journal-f…ush Journal to Persistent Storage.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
         Starting ifupdown-pre.serv…ynchronize boot up for ifupdown...
[  OK  ] Finished ifupdown-pre.serv… synchronize boot up for ifupdown.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-tmpfiles-…ate Static Device Nodes in /dev...
[  OK  ] Finished systemd-tmpfiles-…reate Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pr…reparation for Local File Systems.
[  OK  ] Reached target local-fs.target - Local File Systems.
         Starting networking.service - Raise network interfaces...
         Starting systemd-binfmt.se…et Up Additional Binary Formats...
         Starting systemd-tmpfiles-… Volatile Files and Directories...
         Starting systemd-udevd.ser…ger for Device Events and Files...
[FAILED] Failed to start systemd-bi… Set Up Additional Binary Formats.
See 'systemctl status systemd-binfmt.service' for details.
[  OK  ] Finished systemd-tmpfiles-…te Volatile Files and Directories.
         Starting systemd-timesyncd… - Network Time Synchronization...
         Starting systemd-update-ut…rd System Boot/Shutdown in UTMP...
[  OK  ] Finished networking.service - Raise network interfaces.
[  OK  ] Started systemd-udevd.serv…nager for Device Events and Files.
[  OK  ] Finished systemd-update-ut…cord System Boot/Shutdown in UTMP.
[   70.304763] random: crng init done
[  OK  ] Found device dev-ttyS2.device - /dev/ttyS2.
[  OK  ] Finished systemd-random-se…rvice - Load/Save Random Seed.
[   70.456597] systemd-journald[161]: Oldest entry in /var/log/journal/61e3cf19309f4a3a80b3ea3558380ffb/system.journal is older than the configured file retention duration (1month), suggesting rotation.
[   70.480022] systemd-journald[161]: /var/log/journal/61e3cf19309f4a3a80b3ea3558380ffb/system.journal: Journal header limits reached or header out-of-date, rotating.
[  OK  ] Started systemd-timesyncd.…0m - Network Time Synchronization.
[  OK  ] Reached target sysinit.target - System Initialization.
[  OK  ] Started systemd-tmpfiles-c… Cleanup of Temporary Directories.
[  OK  ] Reached target time-set.target - System Time Set.
[  OK  ] Started apt-daily.timer - Daily apt download activities.
[  OK  ] Started apt-daily-upgrade.… apt upgrade and clean activities.
[  OK  ] Started dpkg-db-backup.tim… Daily dpkg database backup timer.
[   70.712612] pwm-backlight backlight: supply power not found, using dummy regulator
[  OK  ] Started e2scrub_all.timer▒▒etadata Check for All Filesystems.
[  OK  ] Started fstrim.timer - Discard unused blocks once a week.
[  OK  ] Started logrotate.timer - Daily rotation of log files.
[   70.767868] at24 0-0057: supply vcc not found, using dummy regulator
[  OK  ] Started man-db.timer - Daily ma[   70.780640] mc: Linux media interface: v0.10
n-db regeneration.
[   70.785643] pwm-backlight backlight: supply power not found, using dummy regulator
[   70.794832] rtc-pcf85063 0-0051: registered as rtc0
[   70.800491] rtc-pcf85063 0-0051: hctosys: unable to read the hardware clock
[   70.802375] pwm-backlight backlight: supply power not found, using dummy regulator
[  OK  ] Reached target timers.target - [   70.817879] videodev: Linux video capture interface: v2.00
Timer Units.
[   70.819634] pwm-backlight backlight: supply power not found, using dummy regulator
[  OK  ] Listening on dbus.socket▒▒- D-Bus System Message Bus Socket.
[  OK  ] Reached target sockets.target - Socket Units.
[  OK  ] Reached target basic.target - Basic System.
[  OK  ] Started cron.service -…kgroun[   70.918334] rtc-ti-k3 2b1f0000.rtc: registered as rtc1
d program processing daemon.
[   70.990885] k3-m4-rproc 5000000.m4fss: assigned reserved memory node m4f-dma-memory@9cb00000
         Starting dbus.service - D-Bus System Messa[   71.003312] k3-m4-rproc 5000000.m4fss: configured M4 for remoteproc mode
ge Bus...
[   71.015626] k3-m4-rproc 5000000.m4fss: local reset is deasserted for device
         Starting e2scrub_reap.serv…e ext4 Metadata C[   71.038377] remoteproc remoteproc0: 5000000.m4fss is available
heck Snapshots...
[   71.047038] remoteproc remoteproc0: Direct firmware load for am62-mcu-m4f0_0-fw failed with error -2
[   71.059363] remoteproc remoteproc0: powering up 5000000.m4fss
[   71.066158] remoteproc remoteproc0: Direct firmware load for am62-mcu-m4f0_0-fw failed with error -2
[   71.075475] remoteproc remoteproc0: request_firmware failed: -2
         Starting eGTouchD.service...
[   71.119817] platform 78000000.r5f: R5F core may have been powered on by a different host, programmed state (0) != actual state (1)
[   71.122528] pwm-beeper buzzer: supply amp not found, using dummy regulator
[   71.137877] platform 78000000.r5f: configured R5F for IPC-only mode
[   71.146184] platform 78000000.r5f: assigned reserved memory node r5f-dma-memory@9da00000
[   71.147978] input: pwm-beeper as /devices/platform/buzzer/input/input0
[   71.157397] [drm] Initialized tidss 1.0.0 20180215 for 30200000.dss on minor 0
[   71.177323] Console: switching to colour frame buffer device 128x37
[   71.204954] tidss 30200000.dss: [drm] fb0: tidssdrmfb frame buffer device
         Starting systemd-logind.se…ice - User Login Management...
[   71.254179] remoteproc remoteproc1: 78000000.r5f is available
[   71.261195] remoteproc remoteproc1: attaching to 78000000.r5f
[  OK  ] Started dbus.service - D-Bus System Message Bus.
[   71.293240] platform 78000000.r5f: R5F core initialized in IPC-only mode
[   71.300201] rproc-virtio rproc-virtio.1.auto: assigned reserved memory node r5f-dma-memory@9da00000
[  OK  ] Started eGTouchD.service.
[   71.340643] rproc-virtio rproc-virtio.1.auto: registered virtio0 (type 7)
[   71.347868] remoteproc remoteproc1: remote processor 78000000.r5f is now attached
         Starting NetworkManager.service - Network Manager...
[  OK  ] Created slice system-syste…- Slice /system/systemd-backlight.
         Starting systemd-backlight…ightness of backlight:backlight...
[  OK  ] Finished e2scrub_reap.serv…ine ext4 Metadata Check Snapshots.
[   71.602990] remoteproc remoteproc2: 30074000.pru is available
[   71.610515] remoteproc remoteproc3: 30078000.pru is available
[   71.622073] cdns-csi2rx: probe of 30101000.csi-bridge failed with error -22
[  OK  ] Finished systemd-backlight…Brightness of backlight:backlight.
[   71.702854] virtio_rpmsg_bus virtio0: rpmsg host is online
[   71.708687] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xd
[   71.716555] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xe
[   71.732609] xhci-hcd xhci-hcd.2.auto: xHCI Host Controller
[   71.738456] xhci-hcd xhci-hcd.2.auto: new USB bus registered, assigned bus number 1
[   71.749099] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: new channel: 0x401 -> 0xd!
[   71.756465] xhci-hcd xhci-hcd.2.auto: USB3 root hub has no ports
[   71.765161] xhci-hcd xhci-hcd.2.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000000000010010
[   71.765829] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 1 (src: 0xd)
[   71.774875] xhci-hcd xhci-hcd.2.auto: irq 458, io mem 0x31100000
[   71.788160] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 2 (src: 0xd)
[   71.793646] hub 1-0:1.0: USB hub found
[   71.797764] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 3 (src: 0xd)
[   71.805720] hub 1-0:1.0: 1 port detected
[  OK  ] Reached target usb-gadget.…m - Ha[   71.814014] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 4 (src: 0xd)
rdware activated USB gadget.
[   71.830142] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 5 (src: 0xd)
[   71.839260] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 6 (src: 0xd)
[   71.848152] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 7 (src: 0xd)
[   71.856898] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 8 (src: 0xd)
[   71.865459] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 9 (src: 0xd)
[   71.875487] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 10 (src: 0xd)
[   71.884887] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 11 (src: 0xd)
         Starting alsa-restore.serv…- Save/Restore So[   71.896327] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 12 (src: 0xd)
und Card State...
[   71.910318] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 13 (src: 0xd)
[   71.920322] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 14 (src: 0xd)
[   71.928883] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 15 (src: 0xd)
[   71.937424] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 16 (src: 0xd)
[  OK  ] Finished alsa-restore.serv…m - Sa[   71.945989] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 17 (src: 0xd)
ve/Restore Sound Card State.
[   71.960165] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 18 (src: 0xd)
[   71.971073] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 19 (src: 0xd)
[   71.979625] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 20 (src: 0xd)
[  OK  ] Reached target sound.target - S[   71.988163] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 21 (src: 0xd)
ound Card.
[   72.002148] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 22 (src: 0xd)
[   72.011596] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 23 (src: 0xd)
[   72.020982] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 24 (src: 0xd)
[   72.029552] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 25 (src: 0xd)
[   72.038039] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 26 (src: 0xd)
[   72.046552] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 27 (src: 0xd)
[   72.055029] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 28 (src: 0xd)
[   72.063523] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 29 (src: 0xd)
[   72.072021] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 30 (src: 0xd)
[   72.080638] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 31 (src: 0xd)
[   72.084833] usb 1-1: new high-speed USB device number 2 using xhci-hcd
[   72.089176] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 32 (src: 0xd)
[   72.104138] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 33 (src: 0xd)
[   72.112594] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 34 (src: 0xd)
[   72.121065] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 35 (src: 0xd)
[   72.129544] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 36 (src: 0xd)
[   72.138832] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 37 (src: 0xd)
[   72.147479] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 38 (src: 0xd)
[   72.156021] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 39 (src: 0xd)
[   72.164490] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 40 (src: 0xd)
[   72.172953] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 41 (src: 0xd)
[   72.181471] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 42 (src: 0xd)
[   72.189979] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 43 (src: 0xd)
[   72.198595] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 44 (src: 0xd)
[   72.207142] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 45 (src: 0xd)
[   72.215593] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 46 (src: 0xd)
[   72.224116] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 47 (src: 0xd)
[  OK  ] Started NetworkManager.service [   72.232827] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 48 (src: 0xd)
- Network Manager.
[   72.246755] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 49 (src: 0xd)
[   72.256909] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 50 (src: 0xd)
[  OK  ] Reached target network.target -[   72.267791] usb 1-1: unable to read config index 0 descriptor/all
 Network.
[   72.273553] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 51 (src: 0xd)
[   72.280528] usb 1-1: can't read configurations, error -71
[   72.287154] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 52 (src: 0xd)
[   72.287215] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 53 (src: 0xd)
[   72.309585] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 54 (src: 0xd)
[   72.318047] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 55 (src: 0xd)
[   72.326484] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 56 (src: 0xd)
[   72.326547] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 57 (src: 0xd)
[   72.326587] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 58 (src: 0xd)
[   72.326630] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 59 (src: 0xd)
[   72.326669] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 60 (src: 0xd)
[   72.326709] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 61 (src: 0xd)
[   72.326752] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 62 (src: 0xd)
[   72.326791] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 63 (src: 0xd)
[   72.326835] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 64 (src: 0xd)
[   72.326876] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 65 (src: 0xd)
[   72.326915] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 66 (src: 0xd)
[   72.326955] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 67 (src: 0xd)
[   72.326994] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 68 (src: 0xd)
[   72.336842] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.343890] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 69 (src: 0xd)
[   72.352229] cpufreq: __target_index: Failed to change cpu frequency: -34
[   72.360626] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 70 (src: 0xd)
[   72.385786] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.394305] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 71 (src: 0xd)
[   72.402610] cpufreq: __target_index: Failed to change cpu frequency: -34
[   72.411010] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 72 (src: 0xd)
[   72.436742] usb 1-1: new high-speed USB device number 3 using xhci-hcd
[   72.444267] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 73 (src: 0xd)
[   72.514794] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 74 (src: 0xd)
[   72.514852] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 75 (src: 0xd)
[   72.514902] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 76 (src: 0xd)
[   72.514945] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 77 (src: 0xd)
[   72.514984] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 78 (src: 0xd)
[   72.515026] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 79 (src: 0xd)
[   72.515064] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 80 (src: 0xd)
[   72.515105] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 81 (src: 0xd)
[   72.515145] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 82 (src: 0xd)
[   72.515184] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 83 (src: 0xd)
[   72.515226] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 84 (src: 0xd)
[   72.515265] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 85 (src: 0xd)
[   72.515312] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 86 (src: 0xd)
[   72.515352] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 87 (src: 0xd)
[   72.515391] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 88 (src: 0xd)
[   72.640873] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 89 (src: 0xd)
         Starting NetworkManager-wa…m - Network Manag[   72.649558] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 90 (src: 0xd)
er Wait Online...
[   72.649628] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 91 (src: 0xd)
[   72.649671] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 92 (src: 0xd)
[   72.649712] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 93 (src: 0xd)
[   72.649752] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 94 (src: 0xd)
[   72.649793] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 95 (src: 0xd)
[   72.649833] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 96 (src: 0xd)
[   72.649875] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 97 (src: 0xd)
[   72.649915] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 98 (src: 0xd)
[   72.649956] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 99 (src: 0xd)
[   72.649997] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 100 (src: 0xd)
[   72.650004] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: goodbye!
[   72.653508] usb 1-1: unable to read config index 0 descriptor/all
[   72.666351] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.673646] usb 1-1: can't read configurations, error -71
[   72.681809] cpufreq: __target_index: Failed to change cpu frequency: -34
[   72.690361] usb usb1-port1: attempt power cycle
[   72.722395] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.794237] cpufreq: __target_index: Failed to change cpu frequency: -34
         Starting apache2.service - The Apache HTTP Server...
         Starting ssh.service - OpenBSD Secure Shel[   72.863298] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
l server...
[   72.875923] cpufreq: __target_index: Failed to change cpu frequency: -34
[   72.886243] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.894500] cpufreq: __target_index: Failed to change cpu frequency: -34
         Starting systemd-user-sess…vice - Permit User Sessions...
         Starting vsftpd.service - vsftpd FTP server...
[   72.936609] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.944783] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Finished systemd-user-sess…ervice - Permit User Sessions.
[   72.957568] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.968230] cpufreq: __target_index: Failed to change cpu frequency: -34
[   72.986877] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   72.995018] cpufreq: __target_index: Failed to change cpu frequency: -34
[   73.023204] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.031368] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Started vsftpd.service - vsftpd FTP server.
[   73.061987] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.070149] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Started systemd-logind.service - User Login Management.
[   73.088872] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.097004] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Started getty@tty1.service - Getty on tty1.
[  OK  ] Started serial-getty@ttyS2…rvice - Serial Getty on ttyS2.
[   73.152759] usb 1-1: new high-speed USB device number 4 using xhci-hcd
[  OK  ] Reached target getty.target - Login Prompts.
[   73.178686] usb 1-1: unable to read config index 0 descriptor/all
[   73.184892] usb 1-1: can't read configurations, error -71
         Starting systemd-hostnamed.service - Hostname Service...
[   73.227563] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.235664] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Started ssh.service - OpenBSD Secure Shell server.
[  OK  ] Started apache2.service - The Apache HTTP Server.
[   73.289648] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.297845] cpufreq: __target_index: Failed to change cpu frequency: -34
[   73.310915] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.319193] cpufreq: __target_index: Failed to change cpu frequency: -34
[   73.320792] usb 1-1: new high-speed USB device number 5 using xhci-hcd
[   73.357831] usb 1-1: unable to read config index 0 descriptor/all
[   73.364035] usb 1-1: can't read configurations, error -71
[   73.369767] usb usb1-port1: unable to enumerate USB device
[  OK  ] Started systemd-hostnamed.service - Hostname Service.
[   73.573212] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.581485] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Listening on systemd-rfkil…l Switch Status /dev/rfkill Watch.
[   73.604279] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.612376] cpufreq: __target_index: Failed to change cpu frequency: -34
[   73.651019] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.659201] cpufreq: __target_index: Failed to change cpu frequency: -34
         Starting NetworkManager-di…nager Script Dispatcher Service...
[   73.695938] am65-cpsw-nuss 8000000.ethernet eth0: configuring for fixed/rmii link mode
[   73.704078] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.704154] am65-cpsw-nuss 8000000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off
[   73.712232] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Started NetworkManager-dis…Manager Script Dispatcher Service.
[   73.867533] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   73.875583] cpufreq: __target_index: Failed to change cpu frequency: -34

Debian GNU/Linux 12 am62xx ttyS2

am62xx login: 

boot 256s

U-Boot SPL 2023.04-00001-gf5b119738d-dirty (Oct 12 2023 - 08:54:47 +0800)
SYSFW ABI: 3.1 (firmware rev 0x0009 '9.0.5--v09.00.05 (Kool Koala)')
SPL initial stack usage: 13376 bytes
Trying to boot from MMC1
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Starting ATF on ARM64 core...

NOTICE:  BL31: v2.8(release):v2.8-226-g2fcd408bb3-dirty
NOTICE:  BL31: Built : 00:42:57, Jan 13 2023

U-Boot SPL 2023.04-00001-gf5b119738d-dirty (Oct 12 2023 - 08:55:00 +0800)
SYSFW ABI: 3.1 (firmware rev 0x0009 '9.0.5--v09.00.05 (Kool Koala)')
SPL initial stack usage: 1856 bytes
MMC: no card present
** Bad device specification mmc 1 **
Couldn't find partition mmc 1:1
Error: could not access storage.
Trying to boot from MMC1
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted
Warning: Detected image signing certificate on GP device. Skipping certificate to prevent boot failure. This will fail if the image was also encrypted


U-Boot 2023.04-00001-gf5b119738d-dirty (Oct 12 2023 - 08:55:00 +0800)

SoC:   AM62X SR1.0 GP
Model: Texas Instruments AM625 SK
EEPROM not available at 80, trying to read at 81
Reading on-board EEPROM at 0x51 failed -1
DRAM:  2 GiB
Core:  71 devices, 31 uclasses, devicetree: separate
MMC:   mmc@fa10000: 0, mmc@fa00000: 1
Loading Environment from nowhere... OK
In:    serial
Out:   serial
Err:   serial
EEPROM not available at 80, trying to read at 81
Reading on-board EEPROM at 0x51 failed -1
Net:   Could not get PHY for ethernet@8000000port@1: addr 0
am65_cpsw_nuss_port ethernet@8000000port@1: phy_connect() failed
No ethernet found.

Hit any key to stop autoboot:  0
switch to partitions #0, OK
mmc0(part 0) is current device
SD/MMC found on device 0
AAEON special eMMC boot set start...
bootpart=0:2 mmc partconf 0 1 7 1
Set to BOOT_BUS_WIDTH = 0x2, RESET = 0x0, BOOT_MODE = 0x0
name_fdt= echo fdtfile= load mmc 0:2 0x90000000 /boot/fitImage
switch to partitions #0, OK
mmc0(part 0) is current device
SD/MMC found on device 0
8704306 bytes read in 113 ms (73.5 MiB/s)
Failed to load '/boot/dtb/'
Unknown command 'bootz' - try 'help'
AAEON special eMMC boot set end.
Failed to load 'boot.scr'
653 bytes read in 14 ms (44.9 KiB/s)
Loaded env from uEnv.txt
Importing environment from mmc0 ...
## Error: "main_cpsw0_qsgmii_phyinit" not defined
20593152 bytes read in 246 ms (79.8 MiB/s)
55311 bytes read in 15 ms (3.5 MiB/s)
Working FDT set to 88000000
4247 bytes read in 15 ms (276.4 KiB/s)
## Flattened Device Tree blob at 88000000
   Booting using the fdt blob at 0x88000000
Working FDT set to 88000000
ERROR: reserving fdt memory region failed (addr=ff700000 size=8ca000 flags=4)
   Loading Device Tree to 000000008feef000, end 000000008fffffff ... OK
Working FDT set to 8feef000

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 6.1.33 (root@andrew-GENESYS-CML5) (aarch64-none-linux-gnu-gcc (Arm GNU Toolchain 11.3.Rel1) 11.3.1 20220712, GNU ld (Arm GNU Toolchain 11.3.Rel1) 2.38.20220708) #3 SMP PREEMPT Thu Oct  5 13:13:17 CST 2023
[    0.000000] Machine model: Texas Instruments AM625 SK
[    0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002800000 (options '')
[    0.000000] printk: bootconsole [ns16550a0] enabled
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x00000000f7600000, size 128 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009c800000, size 3 MiB
[    0.000000] OF: reserved mem: initialized node ipc-memories@9c800000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009cb00000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node m4f-dma-memory@9cb00000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009cc00000, size 14 MiB
[    0.000000] OF: reserved mem: initialized node m4f-memory@9cc00000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009da00000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@9da00000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x000000009db00000, size 12 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@9db00000, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000080000000-0x00000000ffffffff]
[    0.000000]   DMA32    empty
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000080000000-0x000000009c7fffff]
[    0.000000]   node   0: [mem 0x000000009c800000-0x000000009e6fffff]
[    0.000000]   node   0: [mem 0x000000009e700000-0x000000009e77ffff]
[    0.000000]   node   0: [mem 0x000000009e780000-0x000000009fffffff]
[    0.000000]   node   0: [mem 0x00000000a0000000-0x00000000ff6fffff]
[    0.000000]   node   0: [mem 0x00000000ff700000-0x00000000fffc9fff]
[    0.000000]   node   0: [mem 0x00000000fffca000-0x00000000ffffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000000ffffffff]
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: Trusted OS migration not required
[    0.000000] psci: SMC Calling Convention v1.2
[    0.000000] percpu: Embedded 19 pages/cpu s38376 r8192 d31256 u77824
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: detected: GIC system register CPU interface
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] alternatives: applying boot alternatives
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 516096
[    0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 mtdparts=spi-nand0:512k(ospi.tiboot3),2m(ospi.tispl),4m(ospi.u-boot),256k(ospi.env),256k(ospi.env.backup),98048k@32m(ospi.rootfs),256k@130816k(ospi.phypattern);omap2-nand.0:2m(NAND.tiboot3),2m(NAND.tispl),2m(NAND.tiboot3.backup),4m(NAND.u-boot),256k(NAND.u-boot-env),256k(NAND.u-boot-env.backup),-(NAND.file-system) root=PARTUUID=09a7d6ff-02 rw rootfstype=ext4 rootwait
[    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] Memory: 1838100K/2097152K available (12480K kernel code, 1294K rwdata, 4048K rodata, 2176K init, 501K bss, 127980K reserved, 131072K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU event tracing is enabled.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
[    0.000000]  Trampoline variant of Tasks RCU enabled.
[    0.000000]  Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: 256 SPIs implemented
[    0.000000] GICv3: 0 Extended SPIs implemented
[    0.000000] Root IRQ handler: gic_handle_irq
[    0.000000] GICv3: GICv3 features: 16 PPIs
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001880000
[    0.000000] ITS [mem 0x01820000-0x0182ffff]
[    0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS
[    0.000000] ITS@0x0000000001820000: Devices Table too large, reduce ids 20->19
[    0.000000] ITS@0x0000000001820000: allocated 524288 Devices @80800000 (flat, esz 8, psz 64K, shr 0)
[    0.000000] ITS: using cache flushing for cmd queue
[    0.000000] GICv3: using LPI property table @0x0000000080040000
[    0.000000] GIC: using cache flushing for LPI property table
[    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000080050000
[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0x3ffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns
[    0.000001] sched_clock: 58 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
[    0.008535] Console: colour dummy device 80x25
[    0.013129] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
[    0.023811] pid_max: default: 32768 minimum: 301
[    0.028586] LSM: Security Framework initializing
[    0.033442] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.041028] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.050864] cblist_init_generic: Setting adjustable number of callback queues.
[    0.058325] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.064622] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.071019] rcu: Hierarchical SRCU implementation.
[    0.075925] rcu:     Max phase no-delay instances is 1000.
[    0.081543] Platform MSI: msi-controller@1820000 domain created
[    0.087839] PCI/MSI: /bus@f0000/interrupt-controller@1800000/msi-controller@1820000 domain created
[    0.097653] EFI services will not be available.
[    0.102581] smp: Bringing up secondary CPUs ...
[    0.107897] Detected VIPT I-cache on CPU1
[    0.108014] GICv3: CPU1: found redistributor 1 region 0:0x00000000018a0000
[    0.108032] GICv3: CPU1: using allocated LPI pending table @0x0000000080060000
[    0.108089] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.108798] Detected VIPT I-cache on CPU2
[    0.108882] GICv3: CPU2: found redistributor 2 region 0:0x00000000018c0000
[    0.108897] GICv3: CPU2: using allocated LPI pending table @0x0000000080070000
[    0.108932] CPU2: Booted secondary processor 0x0000000002 [0x410fd034]
[    0.109569] Detected VIPT I-cache on CPU3
[    0.109654] GICv3: CPU3: found redistributor 3 region 0:0x00000000018e0000
[    0.109668] GICv3: CPU3: using allocated LPI pending table @0x0000000080080000
[    0.109698] CPU3: Booted secondary processor 0x0000000003 [0x410fd034]
[    0.109764] smp: Brought up 1 node, 4 CPUs
[    0.189493] SMP: Total of 4 processors activated.
[    0.194306] CPU features: detected: 32-bit EL0 Support
[    0.199579] CPU features: detected: CRC32 instructions
[    0.204899] CPU: All CPU(s) started at EL2
[    0.209095] alternatives: applying system-wide alternatives
[    0.216684] devtmpfs: initialized
[    0.228375] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.238379] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.249963] pinctrl core: initialized pinctrl subsystem
[    0.255979] DMI not present or invalid.
[    0.260548] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.267835] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
[    0.275394] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.283507] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.291696] audit: initializing netlink subsys (disabled)
[    0.297396] audit: type=2000 audit(0.192:1): state=initialized audit_enabled=0 res=1
[    0.297912] thermal_sys: Registered thermal governor 'step_wise'
[    0.305326] thermal_sys: Registered thermal governor 'power_allocator'
[    0.311515] cpuidle: using governor menu
[    0.322390] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.329419] ASID allocator initialised with 65536 entries
[    0.346123] platform display: Fixed dependency cycle(s) with /bus@f0000/dss@30200000
[    0.357894] KASLR disabled due to lack of seed
[    0.369776] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
[    0.376750] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
[    0.383161] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
[    0.390100] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
[    0.396508] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
[    0.403446] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
[    0.409854] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
[    0.416793] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
[    0.425054] k3-chipinfo 43000014.chipid: Family:AM62X rev:SR1.0 JTAGID[0x0bb7e02f] Detected
[    0.435240] iommu: Default domain type: Translated
[    0.440256] iommu: DMA domain TLB invalidation policy: strict mode
[    0.446946] SCSI subsystem initialized
[    0.451173] usbcore: registered new interface driver usbfs
[    0.456824] usbcore: registered new interface driver hub
[    0.462279] usbcore: registered new device driver usb
[    0.468012] pps_core: LinuxPPS API ver. 1 registered
[    0.473096] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.482450] PTP clock support registered
[    0.486589] EDAC MC: Ver: 3.0.0
[    0.490766] omap-mailbox 29000000.mailbox: omap mailbox rev 0x66fc9100
[    0.497916] FPGA manager framework
[    0.501500] Advanced Linux Sound Architecture Driver Initialized.
[    0.508755] clocksource: Switched to clocksource arch_sys_counter
[    0.515259] VFS: Disk quotas dquot_6.6.0
[    0.519317] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.532408] NET: Registered PF_INET protocol family
[    0.537711] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.546964] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
[    0.555775] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.563710] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.571913] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
[    0.579912] TCP: Hash tables configured (established 16384 bind 16384)
[    0.586823] UDP hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.593751] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear)
[    0.601277] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.607553] RPC: Registered named UNIX socket transport module.
[    0.613633] RPC: Registered udp transport module.
[    0.618442] RPC: Registered tcp transport module.
[    0.623251] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.629842] NET: Registered PF_XDP protocol family
[    0.634755] PCI: CLS 0 bytes, default 64
[    0.639604] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available
[    0.649765] Initialise system trusted keyrings
[    0.654613] workingset: timestamp_bits=46 max_order=19 bucket_order=0
[    0.667208] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.673901] NFS: Registering the id_resolver key type
[    0.679135] Key type id_resolver registered
[    0.683413] Key type id_legacy registered
[    0.687594] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.694451] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    0.702219] 9p: Installing v9fs 9p2000 file system support
[    0.741886] Key type asymmetric registered
[    0.746078] Asymmetric key parser 'x509' registered
[    0.751119] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[    0.758860] io scheduler mq-deadline registered
[    0.763500] io scheduler kyber registered
[    0.770963] pinctrl-single 4084000.pinctrl: 34 pins, size 136
[    0.777531] pinctrl-single f4000.pinctrl: 171 pins, size 684
[    0.784352] pinctrl-single a40000.pinctrl: 512 pins, size 2048
[    0.798294] Serial: 8250/16550 driver, 7 ports, IRQ sharing enabled
[    0.813879] loop: module loaded
[    0.818466] megasas: 07.719.03.00-rc1
[    0.826475] tun: Universal TUN/TAP device driver, 1.6
[    0.832443] thunder_xcv, ver 1.0
[    0.835791] thunder_bgx, ver 1.0
[    0.839124] nicpf, ver 1.0
[    0.842314] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version
[    0.849702] hns3: Copyright (c) 2017 Huawei Corporation.
[    0.855195] hclge is initializing
[    0.858603] e1000: Intel(R) PRO/1000 Network Driver
[    0.863595] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    0.869500] e1000e: Intel(R) PRO/1000 Network Driver
[    0.874574] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    0.880655] igb: Intel(R) Gigabit Ethernet Network Driver
[    0.886175] igb: Copyright (c) 2007-2014 Intel Corporation.
[    0.891900] igbvf: Intel(R) Gigabit Virtual Function Network Driver
[    0.898308] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    0.904497] sky2: driver version 1.30
[    0.909008] VFIO - User Level meta-driver version: 0.3
[    0.915132] usbcore: registered new interface driver usb-storage
[    0.922234] i2c_dev: i2c /dev entries driver
[    0.928863] sdhci: Secure Digital Host Controller Interface driver
[    0.935200] sdhci: Copyright(c) Pierre Ossman
[    0.940158] Synopsys Designware Multimedia Card Interface Driver
[    0.946786] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.953526] ledtrig-cpu: registered to indicate activity on CPUs
[    0.959901] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
[    0.966805] hid: raw HID events driver (C) Jiri Kosina
[    0.972183] usbcore: registered new interface driver usbhid
[    0.977886] usbhid: USB HID core driver
[    0.983191] optee: probing for conduit method.
[    0.987796] optee: revision 3.20 (8e74d476)
[    0.988117] optee: dynamic shared memory is enabled
[    0.997654] optee: initialized driver
[    1.003278] Initializing XFRM netlink socket
[    1.007714] NET: Registered PF_PACKET protocol family
[    1.013110] 9pnet: Installing 9P2000 support
[    1.017579] Key type dns_resolver registered
[    1.022386] registered taskstats version 1
[    1.026613] Loading compiled-in X.509 certificates
[    1.040069] ti-sci 44043000.system-controller: ABI: 3.1 (firmware rev 0x0009 '9.0.5--v09.00.05 (Kool Koala)')
[    1.103784] omap-gpmc 3b000000.memory-controller: GPMC revision 6.0
[    1.110257] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000
[    1.118218] omap_i2c 20000000.i2c: bus 0 rev0.12 at 400 kHz
[    1.125464] omap_i2c 20010000.i2c: bus 1 rev0.12 at 100 kHz
[    1.131696] ti-sci-intr 4210000.interrupt-controller: Interrupt Router 5 domain created
[    1.140053] ti-sci-intr bus@f0000:interrupt-controller@a00000: Interrupt Router 3 domain created
[    1.149289] ti-sci-inta 48000000.interrupt-controller: Interrupt Aggregator domain 28 created
[    1.159262] ti-udma 485c0100.dma-controller: Number of rings: 82
[    1.167503] ti-udma 485c0100.dma-controller: Channels: 48 (bchan: 18, tchan: 12, rchan: 18)
[    1.178737] ti-udma 485c0000.dma-controller: Number of rings: 150
[    1.188925] ti-udma 485c0000.dma-controller: Channels: 35 (tchan: 20, rchan: 15)
[    1.199201] printk: console [ttyS2] disabled
[    1.203664] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 239, base_baud = 3000000) is a 8250
[    1.212563] printk: console [ttyS2] enabled
[    1.212563] printk: console [ttyS2] enabled
[    1.221027] printk: bootconsole [ns16550a0] disabled
[    1.221027] printk: bootconsole [ns16550a0] disabled
[    1.232291] 2810000.serial: ttyS1 at MMIO 0x2810000 (irq = 241, base_baud = 3000000) is a 8250
[    1.242082] 2840000.serial: ttyS4 at MMIO 0x2840000 (irq = 242, base_baud = 3000000) is a 8250
[    1.251775] 2850000.serial: ttyS5 at MMIO 0x2850000 (irq = 243, base_baud = 3000000) is a 8250
[    1.261471] 2860000.serial: ttyS6 at MMIO 0x2860000 (irq = 244, base_baud = 3000000) is a 8250
[    1.270967] am65-cpsw-nuss 8000000.ethernet: initializing am65 cpsw nuss version 0x6BA01103, cpsw version 0x6BA81103 Ports: 3 quirks:00000006
[    1.283876] am65-cpsw-nuss 8000000.ethernet: initialized cpsw ale version 1.5
[    1.291007] am65-cpsw-nuss 8000000.ethernet: ALE Table size 512
[    1.297627] am65-cpsw-nuss 8000000.ethernet: CPTS ver 0x4e8a010c, freq:500000000, add_val:1 pps:0
[    1.308312] am65-cpsw-nuss 8000000.ethernet: set new flow-id-base 19
[    1.317710] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    1.319291] mmc0: CQHCI version 5.10
[    1.325763] cpufreq: __target_index: Failed to change cpu frequency: -34
[    1.326113] pca953x 1-0022: supply vcc not found, using dummy regulator
[    1.326214] pca953x 1-0022: using AI
[    1.356575] debugfs: Directory 'pd:182' with parent 'pm_genpd' already present!
[    1.364875] mmc1: CQHCI version 5.10
[    1.365400] mmc0: SDHCI controller on fa10000.mmc [fa10000.mmc] using ADMA 64-bit
[    1.378136] ALSA device list:
[    1.381141]   No soundcards found.
[    1.422856] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    1.430887] cpufreq: __target_index: Failed to change cpu frequency: -34
[    1.445294] mmc0: Command Queue Engine enabled
[    1.449779] mmc0: new HS200 MMC card at address 0001
[    1.456228] mmcblk0: mmc0:0001 TX2932 29.1 GiB
[    1.470873]  mmcblk0: p1 p2 p3
[    1.474857] mmcblk0boot0: mmc0:0001 TX2932 4.00 MiB
[    1.480901] mmcblk0boot1: mmc0:0001 TX2932 4.00 MiB
[    1.486746] mmcblk0rpmb: mmc0:0001 TX2932 4.00 MiB, chardev (240:0)
[    2.889041] sdhci-am654 fa00000.mmc: Power on failed
[    2.925201] mmc1: SDHCI controller on fa00000.mmc [fa00000.mmc] using ADMA 64-bit
[    2.933082] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    2.941258] cpufreq: __target_index: Failed to change cpu frequency: -34
[    2.972943] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    2.980983] cpufreq: __target_index: Failed to change cpu frequency: -34
[    2.992906] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.000944] cpufreq: __target_index: Failed to change cpu frequency: -34
[    3.015405] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.023446] cpufreq: __target_index: Failed to change cpu frequency: -34
[    3.128278] EXT4-fs (mmcblk0p2): recovery complete
[    3.133509] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
[    3.142161] VFS: Mounted root (ext4 filesystem) on device 179:2.
[    3.148839] devtmpfs: mounted
[    3.153241] Freeing unused kernel memory: 2176K
[    3.157870] Run /sbin/init as init process
[    3.165759] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.173804] cpufreq: __target_index: Failed to change cpu frequency: -34
[    3.186216] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.194275] cpufreq: __target_index: Failed to change cpu frequency: -34
[    3.207500] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.215564] cpufreq: __target_index: Failed to change cpu frequency: -34
[    3.215744] mmc0: running CQE recovery
[    3.228009] ------------[ cut here ]------------
[    3.232620] mmc0: cqhci: spurious TCN for tag 11
[    3.237287] WARNING: CPU: 0 PID: 52 at drivers/mmc/host/cqhci-core.c:786 cqhci_irq+0x3b0/0x66c
[    3.245907] Modules linked in:
[    3.248961] CPU: 0 PID: 52 Comm: kworker/0:1H Not tainted 6.1.33 #3
[    3.255219] Hardware name: Texas Instruments AM625 SK (DT)
[    3.260696] Workqueue: kblockd blk_mq_run_work_fn
[    3.265405] pstate: 600000c5 (nZCv daIF -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[    3.272357] pc : cqhci_irq+0x3b0/0x66c
[    3.276104] lr : cqhci_irq+0x3b0/0x66c
[    3.279850] sp : ffff800008003dc0
[    3.283156] x29: ffff800008003dc0 x28: ffff000000e28e40 x27: ffff0000013b0580
[    3.290289] x26: 0000000000000001 x25: ffff000000272898 x24: ffff800008fa4bc8
[    3.297421] x23: ffff80000938e5b0 x22: ffff0000013b0000 x21: ffff000000272880
[    3.304553] x20: 0000000000000002 x19: 000000000000000b x18: ffffffffffffffff
[    3.311684] x17: ffff80006e1c3000 x16: ffff800008000000 x15: ffff800088003aa7
[    3.318815] x14: 0000000000000000 x13: ffff800009281550 x12: 000000000000038d
[    3.325946] x11: 000000000000012f x10: ffff8000092d9550 x9 : ffff800009281550
[    3.333077] x8 : 00000000ffffefff x7 : ffff8000092d9550 x6 : 0000000000000000
[    3.340208] x5 : 000000000000bff4 x4 : 0000000000000000 x3 : 0000000000000000
[    3.347338] x2 : 0000000000000000 x1 : 0000000000000000 x0 : ffff000000e28e40
[    3.354471] Call trace:
[    3.356910]  cqhci_irq+0x3b0/0x66c
[    3.360310]  sdhci_am654_cqhci_irq+0x54/0x8c
[    3.364581]  sdhci_irq+0xb4/0xed0
[    3.367894]  __handle_irq_event_percpu+0x5c/0x164
[    3.372596]  handle_irq_event+0x4c/0xbc
[    3.376427]  handle_fasteoi_irq+0xa4/0x1f4
[    3.380520]  generic_handle_domain_irq+0x2c/0x44
[    3.385131]  gic_handle_irq+0x50/0x124
[    3.388878]  call_on_irq_stack+0x24/0x4c
[    3.392798]  do_interrupt_handler+0x80/0x84
[    3.396978]  el1_interrupt+0x34/0x70
[    3.400553]  el1h_64_irq_handler+0x18/0x2c
[    3.404644]  el1h_64_irq+0x64/0x68
[    3.408039]  _raw_spin_unlock_irqrestore+0x14/0x50
[    3.412824]  cqhci_request+0xd0/0x534
[    3.416484]  mmc_cqe_start_req+0x58/0x70
[    3.420406]  mmc_blk_mq_issue_rq+0x448/0x880
[    3.424671]  mmc_mq_queue_rq+0x118/0x2ac
[    3.428588]  blk_mq_dispatch_rq_list+0x1a4/0x8a4
[    3.433201]  __blk_mq_sched_dispatch_requests+0xb4/0x160
[    3.438509]  blk_mq_sched_dispatch_requests+0x3c/0x80
[    3.443557]  __blk_mq_run_hw_queue+0x80/0xbc
[    3.447822]  blk_mq_run_work_fn+0x20/0x30
[    3.451826]  process_one_work+0x1d0/0x320
[    3.455830]  worker_thread+0x14c/0x444
[    3.459573]  kthread+0x10c/0x110
[    3.462801]  ret_from_fork+0x10/0x20
[    3.466372] ---[ end trace 0000000000000000 ]---
[    3.477135] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[    3.485146] cpufreq: __target_index: Failed to change cpu frequency: -34
[   64.661150] mmc0: cqhci: timeout for tag 10, qcnt 6
[   64.666228] mmc0: cqhci: ============ CQHCI REGISTER DUMP ===========
[   64.672764] mmc0: cqhci: Caps:      0x000030c8 | Version:  0x00000510
[   64.679261] mmc0: cqhci: Config:    0x00000101 | Control:  0x00000000
[   64.685722] mmc0: cqhci: Int stat:  0x00000000 | Int enab: 0x00000016
[   64.692181] mmc0: cqhci: Int sig:   0x00000016 | Int Coal: 0x00000000
[   64.698640] mmc0: cqhci: TDL base:  0x8169f000 | TDL up32: 0x00000000
[   64.705102] mmc0: cqhci: Doorbell:  0x00000cf0 | TCN:      0x00000000
[   64.711607] mmc0: cqhci: Dev queue: 0x00000000 | Dev Pend: 0x00000000
[   64.718109] mmc0: cqhci: Task clr:  0x00000000 | SSC1:     0x00011000
[   64.725227] mmc0: cqhci: SSC2:      0x00000001 | DCMD rsp: 0x00000000
[   64.731990] mmc0: cqhci: RED mask:  0xfdf9a080 | TERRI:    0x8b2e0000
[   64.738459] mmc0: cqhci: Resp idx:  0x0000002e | Resp arg: 0x00000900
[   64.744939] mmc0: sdhci: ============ SDHCI REGISTER DUMP ===========
[   64.751412] mmc0: sdhci: Sys addr:  0x000000e0 | Version:  0x00001004
[   64.757875] mmc0: sdhci: Blk size:  0x00007080 | Blk cnt:  0x00000000
[   64.764342] mmc0: sdhci: Argument:  0x00000000 | Trn mode: 0x00000013
[   64.770805] mmc0: sdhci: Present:   0x01ff00f0 | Host ctl: 0x0000003c
[   64.777260] mmc0: sdhci: Power:     0x0000000f | Blk gap:  0x00000080
[   64.783717] mmc0: sdhci: Wake-up:   0x00000000 | Clock:    0x00000007
[   64.790177] mmc0: sdhci: Timeout:   0x0000000e | Int stat: 0x00000000
[   64.796624] mmc0: sdhci: Int enab:  0x02ff4000 | Sig enab: 0x02ff4000
[   64.803065] mmc0: sdhci: ACmd stat: 0x00000000 | Slot int: 0x00000000
[   64.809515] mmc0: sdhci: Caps:      0x3decc801 | Caps_1:   0x18002407
[   64.815957] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   64.823952] cpufreq: __target_index: Failed to change cpu frequency: -34
[   64.830659] mmc0: sdhci: Cmd:       0x0000153a | Max curr: 0x00000000
[   64.837090] mmc0: sdhci: Resp[0]:   0x00000900 | Resp[1]:  0xffffffff
[   64.843521] mmc0: sdhci: Resp[2]:   0x328f5903 | Resp[3]:  0x00d04f01
[   64.849953] mmc0: sdhci: Host ctl2: 0x0000000b
[   64.854398] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[   64.862392] cpufreq: __target_index: Failed to change cpu frequency: -34
[   64.869104] mmc0: sdhci: ADMA Err:  0x00000000 | ADMA Ptr: 0x000000008121c20c
[   64.876245] mmc0: sdhci: ============================================
[   64.882717] mmc0: running CQE recovery
[   64.950827] mmc0: running CQE recovery
[  126.101163] mmc0: cqhci: timeout for tag 4, qcnt 7
[  126.106146] mmc0: cqhci: ============ CQHCI REGISTER DUMP ===========
[  126.112670] mmc0: cqhci: Caps:      0x000030c8 | Version:  0x00000510
[  126.119168] mmc0: cqhci: Config:    0x00000101 | Control:  0x00000000
[  126.125634] mmc0: cqhci: Int stat:  0x00000000 | Int enab: 0x00000016
[  126.132094] mmc0: cqhci: Int sig:   0x00000016 | Int Coal: 0x00000000
[  126.138554] mmc0: cqhci: TDL base:  0x8169f000 | TDL up32: 0x00000000
[  126.145013] mmc0: cqhci: Doorbell:  0x000001f3 | TCN:      0x00000000
[  126.151473] mmc0: cqhci: Dev queue: 0x00000000 | Dev Pend: 0x00000000
[  126.157978] mmc0: cqhci: Task clr:  0x00000000 | SSC1:     0x00011000
[  126.164480] mmc0: cqhci: SSC2:      0x00000001 | DCMD rsp: 0x00000000
[  126.171390] mmc0: cqhci: RED mask:  0xfdf9a080 | TERRI:    0x8d2e0000
[  126.178174] mmc0: cqhci: Resp idx:  0x0000002e | Resp arg: 0x00000900
[  126.184656] mmc0: sdhci: ============ SDHCI REGISTER DUMP ===========
[  126.191129] mmc0: sdhci: Sys addr:  0x00000100 | Version:  0x00001004
[  126.197593] mmc0: sdhci: Blk size:  0x00007080 | Blk cnt:  0x00000000
[  126.204046] mmc0: sdhci: Argument:  0x00000000 | Trn mode: 0x00000013
[  126.210510] mmc0: sdhci: Present:   0x01ff00f0 | Host ctl: 0x0000003c
[  126.216971] mmc0: sdhci: Power:     0x0000000f | Blk gap:  0x00000080
[  126.223422] mmc0: sdhci: Wake-up:   0x00000000 | Clock:    0x00000007
[  126.229887] mmc0: sdhci: Timeout:   0x0000000e | Int stat: 0x00000000
[  126.236340] mmc0: sdhci: Int enab:  0x02ff4000 | Sig enab: 0x02ff4000
[  126.242789] mmc0: sdhci: ACmd stat: 0x00000000 | Slot int: 0x00000000
[  126.249230] mmc0: sdhci: Caps:      0x3decc801 | Caps_1:   0x18002407
[  126.255679] mmc0: sdhci: Cmd:       0x0000153a | Max curr: 0x00000000
[  126.262119] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  126.270116] cpufreq: __target_index: Failed to change cpu frequency: -34
[  126.276822] mmc0: sdhci: Resp[0]:   0x00000900 | Resp[1]:  0xffffffff
[  126.283254] mmc0: sdhci: Resp[2]:   0x328f5903 | Resp[3]:  0x00d04f01
[  126.289687] mmc0: sdhci: Host ctl2: 0x0000000b
[  126.294125] mmc0: sdhci: ADMA Err:  0x00000000 | ADMA Ptr: 0x000000008121c20c
[  126.301259] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  126.309252] cpufreq: __target_index: Failed to change cpu frequency: -34
[  126.315964] mmc0: sdhci: ============================================
[  126.322429] mmc0: running CQE recovery
[  126.390132] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  126.398210] cpufreq: __target_index: Failed to change cpu frequency: -34
[  126.400343] systemd[1]: System time before build time, advancing clock.
[  126.468253] NET: Registered PF_INET6 protocol family
[  126.474907] Segment Routing with IPv6
[  126.478671] In-situ OAM (IOAM) with IPv6
[  126.505257] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  126.513315] cpufreq: __target_index: Failed to change cpu frequency: -34
[  126.514744] mmc0: running CQE recovery
[  187.541145] mmc0: cqhci: timeout for tag 10, qcnt 2
[  187.546216] mmc0: cqhci: ============ CQHCI REGISTER DUMP ===========
[  187.552708] mmc0: cqhci: Caps:      0x000030c8 | Version:  0x00000510
[  187.559175] mmc0: cqhci: Config:    0x00000101 | Control:  0x00000000
[  187.565640] mmc0: cqhci: Int stat:  0x00000000 | Int enab: 0x00000016
[  187.572521] mmc0: cqhci: Int sig:   0x00000016 | Int Coal: 0x00000000
[  187.579037] mmc0: cqhci: TDL base:  0x8169f000 | TDL up32: 0x00000000
[  187.585506] mmc0: cqhci: Doorbell:  0x00000c00 | TCN:      0x00000000
[  187.591954] mmc0: cqhci: Dev queue: 0x00000000 | Dev Pend: 0x00000000
[  187.598432] mmc0: cqhci: Task clr:  0x00000000 | SSC1:     0x00011000
[  187.604906] mmc0: cqhci: SSC2:      0x00000001 | DCMD rsp: 0x00000000
[  187.611367] mmc0: cqhci: RED mask:  0xfdf9a080 | TERRI:    0x8d2e0000
[  187.617835] mmc0: cqhci: Resp idx:  0x0000002e | Resp arg: 0x00000900
[  187.624294] mmc0: sdhci: ============ SDHCI REGISTER DUMP ===========
[  187.630746] mmc0: sdhci: Sys addr:  0x000000b0 | Version:  0x00001004
[  187.637206] mmc0: sdhci: Blk size:  0x00007080 | Blk cnt:  0x00000000
[  187.643658] mmc0: sdhci: Argument:  0x00000000 | Trn mode: 0x00000013
[  187.650106] mmc0: sdhci: Present:   0x01ff00f0 | Host ctl: 0x0000003c
[  187.656547] mmc0: sdhci: Power:     0x0000000f | Blk gap:  0x00000080
[  187.662997] mmc0: sdhci: Wake-up:   0x00000000 | Clock:    0x00000007
[  187.669444] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  187.677441] cpufreq: __target_index: Failed to change cpu frequency: -34
[  187.684146] mmc0: sdhci: Timeout:   0x0000000e | Int stat: 0x00000000
[  187.690579] mmc0: sdhci: Int enab:  0x02ff4000 | Sig enab: 0x02ff4000
[  187.697010] mmc0: sdhci: ACmd stat: 0x00000000 | Slot int: 0x00000000
[  187.703443] mmc0: sdhci: Caps:      0x3decc801 | Caps_1:   0x18002407
[  187.709883] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  187.717875] cpufreq: __target_index: Failed to change cpu frequency: -34
[  187.724586] mmc0: sdhci: Cmd:       0x0000153a | Max curr: 0x00000000
[  187.731034] mmc0: sdhci: Resp[0]:   0x00000900 | Resp[1]:  0xffffffff
[  187.737486] mmc0: sdhci: Resp[2]:   0x328f5903 | Resp[3]:  0x00d04f01
[  187.743940] mmc0: sdhci: Host ctl2: 0x0000000b
[  187.748401] mmc0: sdhci: ADMA Err:  0x00000000 | ADMA Ptr: 0x000000008121c20c
[  187.755544] mmc0: sdhci: ============================================
[  187.762010] mmc0: running CQE recovery
[  187.765760] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  187.773754] cpufreq: __target_index: Failed to change cpu frequency: -34
[  187.795129] systemd[1]: Configuration file /etc/systemd/system.conf is marked executable. Please remove executable permission bits. Proceeding anyway.
[  187.815913] systemd[1]: systemd 252.6-1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[  187.848119] systemd[1]: Detected architecture arm64.

Welcome to Debian GNU/Linux 12 (bookworm)!

[  187.875483] systemd[1]: Hostname set to <am62xx>.
[  187.881288] mmc0: running CQE recovery
[  187.887266] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  187.895317] cpufreq: __target_index: Failed to change cpu frequency: -34
[  248.981141] mmc0: cqhci: timeout for tag 5, qcnt 3
[  248.986117] mmc0: cqhci: ============ CQHCI REGISTER DUMP ===========
[  248.992619] mmc0: cqhci: Caps:      0x000030c8 | Version:  0x00000510
[  248.999100] mmc0: cqhci: Config:    0x00000101 | Control:  0x00000000
[  249.005577] mmc0: cqhci: Int stat:  0x00000000 | Int enab: 0x00000016
[  249.012067] mmc0: cqhci: Int sig:   0x00000016 | Int Coal: 0x00000000
[  249.018561] mmc0: cqhci: TDL base:  0x8169f000 | TDL up32: 0x00000000
[  249.025070] mmc0: cqhci: Doorbell:  0x00000160 | TCN:      0x00000000
[  249.031570] mmc0: cqhci: Dev queue: 0x00000000 | Dev Pend: 0x00000000
[  249.038047] mmc0: cqhci: Task clr:  0x00000000 | SSC1:     0x00011000
[  249.044513] mmc0: cqhci: SSC2:      0x00000001 | DCMD rsp: 0x00000000
[  249.050992] mmc0: cqhci: RED mask:  0xfdf9a080 | TERRI:    0x8b2e0000
[  249.057467] mmc0: cqhci: Resp idx:  0x0000002e | Resp arg: 0x00000900
[  249.063928] mmc0: sdhci: ============ SDHCI REGISTER DUMP ===========
[  249.070381] mmc0: sdhci: Sys addr:  0x000000f8 | Version:  0x00001004
[  249.076847] mmc0: sdhci: Blk size:  0x00007080 | Blk cnt:  0x00000000
[  249.083308] mmc0: sdhci: Argument:  0x00000000 | Trn mode: 0x00000013
[  249.089761] mmc0: sdhci: Present:   0x01ff00f0 | Host ctl: 0x0000003c
[  249.096219] mmc0: sdhci: Power:     0x0000000f | Blk gap:  0x00000080
[  249.102673] mmc0: sdhci: Wake-up:   0x00000000 | Clock:    0x00000007
[  249.109125] mmc0: sdhci: Timeout:   0x0000000e | Int stat: 0x00000000
[  249.115566] mmc0: sdhci: Int enab:  0x02ff4000 | Sig enab: 0x02ff4000
[  249.122016] mmc0: sdhci: ACmd stat: 0x00000000 | Slot int: 0x00000000
[  249.128456] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  249.136451] cpufreq: __target_index: Failed to change cpu frequency: -34
[  249.143157] mmc0: sdhci: Caps:      0x3decc801 | Caps_1:   0x18002407
[  249.149588] mmc0: sdhci: Cmd:       0x0000153a | Max curr: 0x00000000
[  249.156020] mmc0: sdhci: Resp[0]:   0x00000900 | Resp[1]:  0xffffffff
[  249.162450] mmc0: sdhci: Resp[2]:   0x328f5903 | Resp[3]:  0x00d04f01
[  249.168891] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  249.176884] cpufreq: __target_index: Failed to change cpu frequency: -34
[  249.183595] mmc0: sdhci: Host ctl2: 0x0000000b
[  249.188049] mmc0: sdhci: ADMA Err:  0x00000000 | ADMA Ptr: 0x000000008121c20c
[  249.195196] mmc0: sdhci: ============================================
[  249.201666] mmc0: running CQE recovery
[  249.206022] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  249.214020] cpufreq: __target_index: Failed to change cpu frequency: -34
[  249.324973] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  249.333097] cpufreq: __target_index: Failed to change cpu frequency: -34
[  249.554024] systemd[1]: Configuration file /lib/systemd/system/graphical.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.577881] systemd[1]: Configuration file /lib/systemd/system/shutdown.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.593678] systemd[1]: Configuration file /lib/systemd/system/systemd-update-utmp-runlevel.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.613955] systemd[1]: Configuration file /lib/systemd/system/systemd-journald.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.631646] systemd[1]: Configuration file /lib/systemd/system/systemd-journald.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.650662] systemd[1]: Configuration file /lib/systemd/system/sysinit.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.665455] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  249.670905] systemd[1]: Configuration file /lib/systemd/system/veritysetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.673516] cpufreq: __target_index: Failed to change cpu frequency: -34
[  249.696572] systemd[1]: Configuration file /lib/systemd/system/systemd-udevd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.715049] systemd[1]: Configuration file /lib/systemd/system/systemd-udevd-kernel.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.732496] systemd[1]: Configuration file /lib/systemd/system/systemd-udevd-control.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.750232] systemd[1]: Configuration file /lib/systemd/system/systemd-udev-trigger.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.767812] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-setup.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.785753] systemd[1]: Configuration file /lib/systemd/system/initrd-switch-root.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.803232] systemd[1]: Configuration file /lib/systemd/system/initrd-cleanup.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.819795] systemd[1]: Configuration file /lib/systemd/system/initrd.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.836555] systemd[1]: Configuration file /lib/systemd/system/systemd-pcrphase-initrd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.854737] systemd[1]: Configuration file /lib/systemd/system/systemd-sysext.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.871590] systemd[1]: Configuration file /lib/systemd/system/cryptsetup-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.887937] systemd[1]: Configuration file /lib/systemd/system/initrd-parse-etc.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.905081] systemd[1]: Configuration file /lib/systemd/system/initrd-usr-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.921693] systemd[1]: Configuration file /lib/systemd/system/initrd-root-device.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.939836] systemd[1]: Configuration file /lib/systemd/system/remote-veritysetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.956692] systemd[1]: Configuration file /lib/systemd/system/veritysetup-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.973129] systemd[1]: Configuration file /lib/systemd/system/remote-fs-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  249.989682] systemd[1]: Configuration file /lib/systemd/system/remote-cryptsetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.006310] systemd[1]: Configuration file /lib/systemd/system/basic.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.022171] systemd[1]: Configuration file /lib/systemd/system/slices.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.037608] systemd[1]: Configuration file /lib/systemd/system/paths.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.052673] systemd[1]: Configuration file /lib/systemd/system/timers.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.070253] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-clean.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.087926] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-clean.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.105822] systemd[1]: Configuration file /lib/systemd/system/time-set.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.121564] systemd[1]: Configuration file /lib/systemd/system/man-db.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.141061] systemd[1]: Configuration file /lib/systemd/system/time-sync.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.157094] systemd[1]: Configuration file /lib/systemd/system/man-db.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.173264] systemd[1]: Configuration file /lib/systemd/system/logrotate.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.188986] systemd[1]: Configuration file /lib/systemd/system/logrotate.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.205092] systemd[1]: Configuration file /lib/systemd/system/fstrim.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.220581] systemd[1]: Configuration file /lib/systemd/system/fstrim.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.237280] systemd[1]: Configuration file /lib/systemd/system/e2scrub_all.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.253292] systemd[1]: Configuration file /lib/systemd/system/e2scrub_all.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.269315] systemd[1]: Configuration file /lib/systemd/system/dpkg-db-backup.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.286000] systemd[1]: Configuration file /lib/systemd/system/dpkg-db-backup.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.302628] systemd[1]: Configuration file /lib/systemd/system/apt-daily.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.318637] systemd[1]: Configuration file /lib/systemd/system/apt-daily.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.334918] systemd[1]: Configuration file /lib/systemd/system/NetworkManager.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.351583] systemd[1]: Configuration file /lib/systemd/system/dbus.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.366895] systemd[1]: Configuration file /lib/systemd/system/dbus.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.382185] systemd[1]: Configuration file /lib/systemd/system/network-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.398147] systemd[1]: Configuration file /lib/systemd/system/systemd-networkd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.416979] systemd[1]: Configuration file /lib/systemd/system/systemd-networkd.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.433847] systemd[1]: Configuration file /lib/systemd/system/network-online.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.451227] systemd[1]: Configuration file /lib/systemd/system/networking.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.467669] systemd[1]: Configuration file /lib/systemd/system/ifupdown-pre.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.484058] systemd[1]: Configuration file /lib/systemd/system/NetworkManager-wait-online.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.502400] systemd[1]: Configuration file /lib/systemd/system/network.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.517733] systemd[1]: Configuration file /lib/systemd/system/apt-daily-upgrade.timer is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.534851] systemd[1]: Configuration file /lib/systemd/system/apt-daily-upgrade.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.552094] systemd[1]: Configuration file /lib/systemd/system/initrd-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.568007] systemd[1]: Configuration file /lib/systemd/system/initrd-root-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.585810] systemd[1]: Configuration file /lib/systemd/system/initrd-udevadm-cleanup-db.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.604471] systemd[1]: Configuration file /lib/systemd/system/systemd-udev-settle.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.621971] systemd[1]: Configuration file /lib/systemd/system/initrd-switch-root.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.639160] systemd[1]: Configuration file /lib/systemd/system/systemd-tmpfiles-setup-dev.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.657845] systemd[1]: Configuration file /lib/systemd/system/local-fs-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.674268] systemd[1]: Configuration file /lib/systemd/system/systemd-timesyncd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.693673] systemd[1]: Configuration file /lib/systemd/system/systemd-remount-fs.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.711158] systemd[1]: Configuration file /lib/systemd/system/systemd-fsck-root.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.728507] systemd[1]: Configuration file /lib/systemd/system/systemd-fsckd.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.745002] systemd[1]: Configuration file /lib/systemd/system/systemd-fsckd.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.761441] systemd[1]: Configuration file /lib/systemd/system/systemd-sysusers.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.778558] systemd[1]: Configuration file /lib/systemd/system/systemd-sysctl.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.795348] systemd[1]: Configuration file /lib/systemd/system/systemd-repart.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.812278] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.829129] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.844719] systemd[1]: Configuration file /lib/systemd/system/systemd-random-seed.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.863001] systemd[1]: Configuration file /lib/systemd/system/first-boot-complete.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.880086] systemd[1]: Configuration file /lib/systemd/system/systemd-pstore.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.896996] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.912671] systemd[1]: Configuration file /lib/systemd/system/systemd-pcrphase.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.934882] systemd[1]: Configuration file /lib/systemd/system/systemd-user-sessions.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.941293] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  250.958665] cpufreq: __target_index: Failed to change cpu frequency: -34
[  250.962153] systemd[1]: Configuration file /lib/systemd/system/nss-user-lookup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.983177] systemd[1]: Configuration file /lib/systemd/system/remote-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  250.997122] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  250.999018] systemd[1]: Configuration file /lib/systemd/system/systemd-pcrphase-sysinit.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.005683] cpufreq: __target_index: Failed to change cpu frequency: -34
[  251.024111] systemd[1]: Configuration file /lib/systemd/system/systemd-modules-load.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.036779] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  251.046000] systemd[1]: Configuration file /lib/systemd/system/systemd-machine-id-commit.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.051790] cpufreq: __target_index: Failed to change cpu frequency: -34
[  251.077464] systemd[1]: Configuration file /lib/systemd/system/systemd-journal-flush.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.095264] systemd[1]: Configuration file /lib/systemd/system/systemd-firstboot.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.112531] systemd[1]: Configuration file /lib/systemd/system/systemd-binfmt.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.129388] systemd[1]: Configuration file /lib/systemd/system/proc-sys-fs-binfmt_misc.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.147506] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-console.path is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.166330] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-console.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.185189] systemd[1]: Configuration file /lib/systemd/system/sys-kernel-tracing.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.202511] systemd[1]: Configuration file /lib/systemd/system/sys-kernel-debug.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.219440] systemd[1]: Configuration file /lib/systemd/system/sys-kernel-config.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.236632] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.252308] systemd[1]: Configuration file /lib/systemd/system/sys-fs-fuse-connections.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.271088] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.286712] systemd[1]: Configuration file /lib/systemd/system/proc-sys-fs-binfmt_misc.automount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.305754] systemd[1]: Configuration file /lib/systemd/system/kmod-static-nodes.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.322868] systemd[1]: Configuration file /lib/systemd/system/integritysetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.338753] systemd[1]: Configuration file /lib/systemd/system/dev-mqueue.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.354776] systemd[1]: Configuration file /lib/systemd/system/dev-hugepages.mount is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.371143] systemd[1]: Configuration file /lib/systemd/system/cryptsetup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.386683] systemd[1]: Configuration file /lib/systemd/system/emergency.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.402159] systemd[1]: Configuration file /lib/systemd/system/emergency.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.417932] systemd[1]: Configuration file /lib/systemd/system/swap.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.432893] systemd[1]: Configuration file /lib/systemd/system/local-fs.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.449892] systemd[1]: Configuration file /lib/systemd/system/syslog.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.465935] systemd[1]: Configuration file /lib/systemd/system/systemd-journald-audit.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.483556] systemd[1]: Configuration file /lib/systemd/system/systemd-journald-dev-log.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.502015] systemd[1]: Configuration file /lib/systemd/system/sockets.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.518884] systemd[1]: Configuration file /lib/systemd/system/systemd-initctl.socket is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.535648] systemd[1]: Configuration file /lib/systemd/system/systemd-initctl.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.552176] systemd[1]: Configuration file /lib/systemd/system/multi-user.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.575569] systemd[1]: Configuration file /lib/systemd/system/systemd-logind.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.595715] systemd[1]: Configuration file /lib/systemd/system/modprobe@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.611443] systemd[1]: Configuration file /lib/systemd/system/user.slice is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.627120] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-wall.path is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.645648] systemd[1]: Configuration file /lib/systemd/system/systemd-ask-password-wall.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.664041] systemd[1]: Configuration file /lib/systemd/system/ssh.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.684586] systemd[1]: Configuration file /lib/systemd/system/getty.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.701694] systemd[1]: Configuration file /lib/systemd/system/serial-getty@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.720650] systemd[1]: Configuration file /lib/systemd/system/rc-local.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.737461] systemd[1]: Configuration file /usr/lib/systemd/system/rc-local.service.d/debian.conf is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.754342] systemd[1]: Configuration file /lib/systemd/system/getty-pre.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.770956] systemd[1]: Configuration file /lib/systemd/system/getty@.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.788657] systemd[1]: Configuration file /lib/systemd/system/getty-static.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.805021] systemd[1]: Configuration file /etc/systemd/system/eGTouchD.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.822030] systemd[1]: Configuration file /lib/systemd/system/e2scrub_reap.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.838440] systemd[1]: Configuration file /lib/systemd/system/cron.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.855120] systemd[1]: Configuration file /lib/systemd/system/nss-lookup.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.871062] systemd[1]: Configuration file /lib/systemd/system/rescue.target is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.888237] systemd[1]: Configuration file /lib/systemd/system/systemd-update-utmp.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.906963] systemd[1]: Configuration file /lib/systemd/system/rescue.service is marked executable. Please remove executable permission bits. Proceeding anyway.
[  251.926859] systemd[1]: Queued start job for default target graphical.target.
[  251.960875] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  251.961039] systemd[1]: Created slice system-getty.slice - Slice /system/getty.
[  251.968916] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Created slice system-getty.slice - Slice /system/getty.
[  251.988724] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  251.998914] cpufreq: __target_index: Failed to change cpu frequency: -34
[  252.001091] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
[  OK  ] Created slice system-modpr…lice - Slice /system/modprobe.
[  252.030829] systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
[  OK  ] Created slice system-seria… - Slice /system/serial-getty.
[  252.058276] systemd[1]: Created slice user.slice - User and Session Slice.
[  OK  ] Created slice user.slice - User and Session Slice.
[  252.084959] systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
[  OK  ] Started systemd-ask-passwo…quests to Console Directory Watch.
[  252.115635] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
[  OK  ] Started systemd-ask-passwo… Requests to Wall Directory Watch.
[  252.141248] systemd[1]: proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point was skipped because of an unmet condition check (ConditionPathExists=/proc/sys/fs/binfmt_misc).
[  252.160857] systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
[  OK  ] Reached target cryptsetup.…get - Local Encrypted Volumes.
[  252.185051] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
[  OK  ] Reached target integrityse…Local Integrity Protected Volumes.
[  252.209164] systemd[1]: Reached target paths.target - Path Units.
[  OK  ] Reached target paths.target - Path Units.
[  252.233084] systemd[1]: Reached target remote-fs.target - Remote File Systems.
[  OK  ] Reached target remote-fs.target - Remote File Systems.
[  252.257012] systemd[1]: Reached target slices.target - Slice Units.
[  OK  ] Reached target slices.target - Slice Units.
[  252.281263] systemd[1]: Reached target swap.target - Swaps.
[  OK  ] Reached target swap.target - Swaps.
[  252.301203] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
[  OK  ] Reached target veritysetup… - Local Verity Protected Volumes.
[  252.325946] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe.
[  OK  ] Listening on systemd-initc… initctl Compatibility Named Pipe.
[  252.351110] systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket.
[  OK  ] Listening on systemd-journ…socket - Journal Audit Socket.
[  252.378580] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
[  OK  ] Listening on systemd-journ…t - Journal Socket (/dev/log).
[  252.408066] systemd[1]: Listening on systemd-journald.socket - Journal Socket.
[  OK  ] Listening on systemd-journald.socket - Journal Socket.
[  252.444964] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
[  OK  ] Listening on systemd-udevd….socket - udev Control Socket.
[  252.470807] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
[  OK  ] Listening on systemd-udevd…l.socket - udev Kernel Socket.
[  252.525288] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
         Mounting dev-hugepages.mount - Huge Pages File System...
[  252.555162] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  252.555885] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
[  252.563284] cpufreq: __target_index: Failed to change cpu frequency: -34
         Mounting dev-mqueue.mount▒▒POSIX Message Queue File System...
[  252.625274] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
         Mounting sys-kernel-debug.… - Kernel Debug File System...
[  252.649926] systemd[1]: sys-kernel-tracing.mount - Kernel Trace File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/tracing).
[  252.673640] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
         Starting kmod-static-nodes…ate List of Static Device Nodes...
[  252.703751] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
         Starting modprobe@configfs…m - Load Kernel Module configfs...
[  252.757646] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
         Starting modprobe@dm_mod.s…[0m - Load Kernel Module dm_mod...
[  252.788469] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
         Starting modprobe@drm.service - Load Kerne[  252.800964] device-mapper: ioctl: 4.47.0-ioctl (2022-07-28) initialised: dm-devel@redhat.com
l Module drm...
[  252.865892] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
         Starting modprobe@efi_psto…- Load Kernel Module efi_pstore...
[  252.905276] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
         Starting modprobe@fuse.ser…e - Load Kernel Module fuse...
[  252.928316] fuse: init (API version 7.37)
[  252.977904] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
         Starting modprobe@loop.ser…e - Load Kernel Module loop...
[  253.019841] systemd[1]: Starting systemd-journald.service - Journal Service...
         Starting systemd-journald.service - Journal Service...
[  253.053577] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
[  253.057317] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  253.069582] cpufreq: __target_index: Failed to change cpu frequency: -34
         Starting systemd-modules-l…rvice - Load Kernel Modules...
[  253.084898] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  253.092972] cpufreq: __target_index: Failed to change cpu frequency: -34
[  253.113561] systemd-journald[161]: Configuration file /etc/systemd/journald.conf is marked executable. Please remove executable permission bits. Proceeding anyway.
[  253.117617] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
[  253.128332] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  253.145576] cpufreq: __target_index: Failed to change cpu frequency: -34
         Starting systemd-remount-f…nt Root and Kernel File Systems...
[  253.205608] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
         Starting systemd-udev-trig…[0m - Coldplug All udev Devices...
[  253.237007] systemd[1]: Started systemd-journald.service - Journal Service.
[  OK  ] Started systemd-journald.service - Journal Service.
[  OK  ] Mounted dev-hugepages.mount - Huge Pages File System.
[  OK  ] Mounted dev-mqueue.mount▒▒- POSI[  253.282491] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
X Message Queue File System.
[  253.295900] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Mounted sys-kernel-debug.m…nt - Kernel Debug File System.
[  253.325276] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  253.333356] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Finished kmod-static-nodes…reate List of Static Device Nodes.
[  OK  ] Finished modprobe@configfs…[0m - Load Kernel Module configfs.
[  OK  ] Finished modprobe@dm_mod.s…e - Load Kernel Module dm_mod.
[  OK  ] Finished modprobe@drm.service - Load Kernel Module drm.
[  OK  ] Finished modprobe@efi_psto…m - Load Kernel Module efi_pstore.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[  OK  ] Finished modprobe@loop.service - Load Kernel Module loop.
[  OK  ] Finished systemd-modules-l…service - Load Kernel Modules.
[  OK  ] Finished systemd-remount-f…ount Root and Kernel File Systems.
         Mounting sys-fs-fuse-conne… - FUSE Control File System...
         Mounting sys-kernel-config…ernel Configuration File System...
         Starting systemd-journal-f…h Journal to Persistent Storage...
         Starting systemd-random-se…ice - Load/Save Random Seed...
[  253.628376] systemd-journald[161]: Received client request to flush runtime journal.
[  253.643479] systemd-journald[161]: File /var/log/journal/61e3cf19309f4a3a80b3ea3558380ffb/system.journal corrupted or uncleanly shut down, renaming and replacing.
         Starting systemd-sysctl.se…ce - Apply Kernel Variables...
         Starting systemd-sysusers.…rvice - Create System Users...
[  OK  ] Mounted sys-fs-fuse-connec…nt - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.… Kernel Configuration File System.
[  OK  ] Finished systemd-udev-trig…e - Coldplug All udev Devices.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
         Starting ifupdown-pre.serv…ynchronize boot up for ifupdown...
[  OK  ] Finished systemd-journal-f…ush Journal to Persistent Storage.
[  OK  ] Finished ifupdown-pre.serv… synchronize boot up for ifupdown.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-tmpfiles-…ate Static Device Nodes in /dev...
[  OK  ] Finished systemd-tmpfiles-…reate Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pr…reparation for Local File Systems.
[  OK  ] Reached target local-fs.target - Local File Systems.
         Starting networking.service - Raise network interfaces...
         Starting systemd-binfmt.se…et Up Additional Binary Formats...
         Starting systemd-tmpfiles-… Volatile Files and Directories...
         Starting systemd-udevd.ser…ger for Device Events and Files...
[FAILED] Failed to start systemd-bi… Set Up Additional Binary Formats.
See 'systemctl status systemd-binfmt.service' for details.
[  OK  ] Finished systemd-tmpfiles-…te Volatile Files and Directories.
         Starting systemd-timesyncd… - Network Time Synchronization...
         Starting systemd-update-ut…rd System Boot/Shutdown in UTMP...
[  OK  ] Finished networking.service - Raise network interfaces.
[  OK  ] Finished systemd-update-ut…cord System Boot/Shutdown in UTMP.
[  OK  ] Started systemd-udevd.serv…nager for Device Events and Files.
[  254.424828] random: crng init done
[  OK  ] Finished systemd-random-se…rvice - Load/Save Random Seed.
[  OK  ] Found device dev-ttyS2.device - /dev/ttyS2.
[  254.760078] systemd-journald[161]: Oldest entry in /var/log/journal/61e3cf19309f4a3a80b3ea3558380ffb/system.journal is older than the configured file retention duration (1month), suggesting rotation.
[  OK  ] Started systemd-timesyncd.…0m - N[  254.782837] systemd-journald[161]: /var/log/journal/61e3cf19309f4a3a80b3ea3558380ffb/system.journal: Journal header limits reached or header out-of-date, rotating.
etwork Time Synchronization.
[  OK  ] Reached target sysinit.target - System Initialization.
[  OK  ] Started systemd-tmpfiles-c… Cleanup of Temporary Directories.
[  OK  ] Reached target time-set.target - System Time Set.
[  OK  ] Started apt-daily.timer - Daily apt download activities.
[  OK  ] Started apt-daily-upgrade.… apt upgrade and clean activities.
[  OK  ] Started dpkg-db-backup.tim… Daily dpkg database backup timer.
[  254.905464] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  254.913575] cpufreq: __target_index: Failed to change cpu frequency: -34
[  OK  ] Started e2scrub_all.timer▒▒etadata Check for All Filesystems.
[  OK  ] Started fstrim.timer - Discard unused blocks once a week.
[  OK  ] Started logrotate.timer - Daily rotation of log files.
[  OK  ] Started man-db.timer - Daily ma[  254.974260] pwm-backlight backlight: supply power not found, using dummy regulator
n-db regeneration.
[  OK  ] Reached target timers.target - Timer Units.
[  OK  ] Listening on dbus.socket▒▒- D-Bus System Message Bus Socket.
[  255.025476] mc: Linux media interface: v0.10
[  OK  ] Reached target sockets.target - Socket Units.
[  255.042993] videodev: Linux video capture interface: v2.00
[  OK  ] Reached target basic.target - B[  255.055814] at24 0-0057: supply vcc not found, using dummy regulator
asic System.
[  255.083518] rtc-pcf85063 0-0051: registered as rtc0
[  255.090535] rtc-pcf85063 0-0051: hctosys: unable to read the hardware clock
[  255.157767] platform 78000000.r5f: R5F core may have been powered on by a different host, programmed state (0) != actual state (1)
[  255.169853] k3-m4-rproc 5000000.m4fss: assigned reserved memory node m4f-dma-memory@9cb00000
[  OK  ] Started cron.service -…kgroun[  255.170352] platform 78000000.r5f: configured R5F for IPC-only mode
d program processing daemon.
[  255.190786] platform 78000000.r5f: assigned reserved memory node r5f-dma-memory@9da00000
[  255.195309] k3-m4-rproc 5000000.m4fss: configured M4 for remoteproc mode
[  255.209751] k3-m4-rproc 5000000.m4fss: local reset is deasserted for device
[  255.215378] remoteproc remoteproc0: 78000000.r5f is available
[  255.215829] pwm-beeper buzzer: supply amp not found, using dummy regulator
[  255.216271] input: pwm-beeper as /devices/platform/buzzer/input/input0
[  255.218062] remoteproc remoteproc1: 5000000.m4fss is available
[  255.222694] remoteproc remoteproc0: attaching to 78000000.r5f
[  255.230431] remoteproc remoteproc1: Direct firmware load for am62-mcu-m4f0_0-fw failed with error -2
[  255.257072] remoteproc remoteproc1: powering up 5000000.m4fss
[  255.257959] platform 78000000.r5f: R5F core initialized in IPC-only mode
[  255.262999] remoteproc remoteproc1: Direct firmware load for am62-mcu-m4f0_0-fw failed with error -2
[  255.269717] rproc-virtio rproc-virtio.0.auto: assigned reserved memory node r5f-dma-memory@9da00000
[  255.278986] remoteproc remoteproc1: request_firmware failed: -2
[  255.296569] [drm] Initialized tidss 1.0.0 20180215 for 30200000.dss on minor 0
         Starting dbus.service - D-Bus System Messa[  255.306593] rproc-virtio rproc-virtio.0.auto: registered virtio0 (type 7)
ge Bus...
[  255.320169] remoteproc remoteproc0: remote processor 78000000.r5f is now attached
[  255.337729] Console: switching to colour frame buffer device 128x37
[  255.365231] tidss 30200000.dss: [drm] fb0: tidssdrmfb frame buffer device
         Starting e2scrub_reap.serv…e ext4 Metadata Check Snapshots...
         Starting eGTouchD.service...
         Starting systemd-logind.se…ice - User Login Management...
[  255.504479] rtc-ti-k3 2b1f0000.rtc: registered as rtc1
[  OK  ] Started dbus.service - D-Bus System Message Bus.
[  OK  ] Started eGTouchD.service.
         Starting NetworkManager.service - Network Manager...
[  OK  ] Created slice system-syste…- Slice /system/systemd-backlight.
         Starting systemd-backlight…ightness of backlight:backlight...
[  OK  ] Finished e2scrub_reap.serv…ine ext4 Metadata Check Snapshots.
[  OK  ] Finished systemd-backlight…Brightness of backlight:backlight.
[  255.793688] remoteproc remoteproc2: 30074000.pru is available
[  255.860339] remoteproc remoteproc3: 30078000.pru is available
[  255.972923] cdns-csi2rx: probe of 30101000.csi-bridge failed with error -22
[  255.976832] xhci-hcd xhci-hcd.2.auto: xHCI Host Controller
[  255.980942] virtio_rpmsg_bus virtio0: rpmsg host is online
[  255.985735] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xd
[  255.999323] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xe
[  256.001848] xhci-hcd xhci-hcd.2.auto: new USB bus registered, assigned bus number 1
         Starting alsa-restore.serv…- Save/Restore So[  256.017585] xhci-hcd xhci-hcd.2.auto: USB3 root hub has no ports
und Card State...
[  256.028029] xhci-hcd xhci-hcd.2.auto: hcc params 0x0258fe6d hci version 0x110 quirks 0x0000000000010010
[  256.043882] xhci-hcd xhci-hcd.2.auto: irq 458, io mem 0x31100000
[  256.051439] hub 1-0:1.0: USB hub found
[  256.055477] hub 1-0:1.0: 1 port detected
[  OK  ] Finished alsa-restore.serv…m - Save/Restore Sound Card State.
[  OK  ] Started NetworkManager.service - Network Manager.
[  256.099475] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: new channel: 0x401 -> 0xd!
[  256.108253] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 1 (src: 0xd)
[  256.116820] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 2 (src: 0xd)
[  256.125321] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 3 (src: 0xd)
[  OK  ] Started systemd-logind.service [  256.135499] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 4 (src: 0xd)
- User Login Management.
[  256.147807] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 5 (src: 0xd)
[  256.158426] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 6 (src: 0xd)
[  256.166875] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 7 (src: 0xd)
[  256.175288] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 8 (src: 0xd)
[  256.183655] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 9 (src: 0xd)
[  OK  ] Reached target network.target -[  256.192109] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 10 (src: 0xd)
 Network.
[  256.206077] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 11 (src: 0xd)
[  256.215359] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 12 (src: 0xd)
[  256.223776] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 13 (src: 0xd)
[  256.232215] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 14 (src: 0xd)
[  OK  ] Reached target sound.target - S[  256.240760] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 15 (src: 0xd)
ound Card.
[  256.254814] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 16 (src: 0xd)
[  256.264145] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 17 (src: 0xd)
[  256.272600] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 18 (src: 0xd)
[  256.281077] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 19 (src: 0xd)
[  256.289540] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 20 (src: 0xd)
[  OK  ] Reached target usb-gadget.…m - Ha[  256.297959] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 21 (src: 0xd)
rdware activated USB gadget.
[  256.311917] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 22 (src: 0xd)
[  256.316861] usb 1-1: new high-speed USB device number 2 using xhci-hcd
[  256.322885] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 23 (src: 0xd)
[  256.337833] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 24 (src: 0xd)
[  256.346315] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 25 (src: 0xd)
[  256.354742] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 26 (src: 0xd)
[  256.363170] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 27 (src: 0xd)
[  256.371592] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 28 (src: 0xd)
[  256.379993] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 29 (src: 0xd)
[  256.388613] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 30 (src: 0xd)
         Starting NetworkManager-wa…m - Network Manag[  256.397189] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 31 (src: 0xd)
er Wait Online...
[  256.411252] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 32 (src: 0xd)
[  256.421210] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 33 (src: 0xd)
[  256.429783] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 34 (src: 0xd)
         Starting apache2.service - The Apache HTTP[  256.438353] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 35 (src: 0xd)
 Server...
[  256.452596] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 36 (src: 0xd)
[  256.462014] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 37 (src: 0xd)
[  256.470635] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 38 (src: 0xd)
[  256.479343] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 39 (src: 0xd)
         Starting ssh.service - OpenBSD Secure Shel[  256.488470] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 40 (src: 0xd)
l server...
[  256.502557] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 41 (src: 0xd)
[  256.512161] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 42 (src: 0xd)
[  256.520841] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 43 (src: 0xd)
[  256.530077] usb 1-1: unable to read config index 0 descriptor/all
[  256.531596] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 44 (src: 0xd)
[  256.536261] usb 1-1: can't read configurations, error -71
[  256.550449] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 45 (src: 0xd)
[  256.559070] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 46 (src: 0xd)
[  256.567757] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 47 (src: 0xd)
         Starting systemd-hostnamed.service - Hostname Service...
[  256.605547] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 48 (src: 0xd)
         Starting systemd-user-sess…vice - Permit[  256.614339] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 49 (src: 0xd)
 User Sessions...
[  256.628591] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 50 (src: 0xd)
[  256.648022] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 51 (src: 0xd)
[  256.657234] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 52 (src: 0xd)
[  256.665862] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 53 (src: 0xd)
         Starting vsftpd.service - vsftpd FTP serve[  256.674584] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 54 (src: 0xd)
r...[  256.676937] usb 1-1: new high-speed USB device number 3 using xhci-hcd

[  256.688474] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 55 (src: 0xd)
[  256.703954] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 56 (src: 0xd)
[  256.714879] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 57 (src: 0xd)
[  256.725343] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 58 (src: 0xd)
[  OK  ] Finished systemd-user-sess…ervice[  256.736315] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 59 (src: 0xd)
 - Permit User Sessions.
[  256.751142] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 60 (src: 0xd)
[  256.760913] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 61 (src: 0xd)
[  256.769493] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 62 (src: 0xd)
[  256.778931] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 63 (src: 0xd)
[  256.789130] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 64 (src: 0xd)
[  256.797859] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 65 (src: 0xd)
[  256.806452] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 66 (src: 0xd)
[  256.815023] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 67 (src: 0xd)
[  256.823618] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 68 (src: 0xd)
[  256.832264] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 69 (src: 0xd)
[  256.840980] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 70 (src: 0xd)
[  256.849576] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 71 (src: 0xd)
[  256.858137] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 72 (src: 0xd)
[  256.866633] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 73 (src: 0xd)
[  256.875227] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 74 (src: 0xd)
[  256.883885] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 75 (src: 0xd)
[  256.892529] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 76 (src: 0xd)
[  256.901846] usb 1-1: unable to read config index 0 descriptor/all
[  256.908034] usb 1-1: can't read configurations, error -71
[  256.911098] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 77 (src: 0xd)
[  256.921979] usb usb1-port1: attempt power cycle
[  256.926797] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 78 (src: 0xd)
[  256.935330] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 79 (src: 0xd)
[  256.943868] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 80 (src: 0xd)
[  256.952418] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 81 (src: 0xd)
[  256.960969] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 82 (src: 0xd)
[  256.969530] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 83 (src: 0xd)
[  256.978100] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 84 (src: 0xd)
[  256.986579] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 85 (src: 0xd)
[  256.995091] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 86 (src: 0xd)
[  257.003619] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 87 (src: 0xd)
[  257.012150] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 88 (src: 0xd)
[  257.020700] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 89 (src: 0xd)
[  257.029932] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 90 (src: 0xd)
[  257.040526] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 91 (src: 0xd)
[  257.040596] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 92 (src: 0xd)
[  OK  ] Started vsftpd.service - vsftpd[  257.040631] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 93 (src: 0xd)
 FTP server.
[  257.040671] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 94 (src: 0xd)
[  257.040815] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 95 (src: 0xd)
[  257.040860] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 96 (src: 0xd)
[  257.099550] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 97 (src: 0xd)
[  257.099615] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 98 (src: 0xd)
[  257.099658] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 99 (src: 0xd)
[  257.100028] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: incoming msg 100 (src: 0xd)
[  257.100053] rpmsg_client_sample virtio0.ti.ipc4.ping-pong.-1.13: goodbye!
[  OK  ] Started systemd-hostnamed.service - Hostname Service.
[  OK  ] Started ssh.service - OpenBSD Secure Shell server.
[  OK  ] Listening on systemd-rfkil…l Switch Status /dev/rfkill Watch.
[  OK  ] Started getty@tty1.service - Getty on tty1.
[  OK  ] Started serial-getty@ttyS2…rvice - Serial Getty on ttyS2.
[  257.303966] am65-cpsw-nuss 8000000.ethernet eth0: configuring for fixed/rmii link mode
[  257.312084] am65-cpsw-nuss 8000000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off
[  OK  ] Reached target getty.target - Login Prompts.
[  257.336866] usb 1-1: new high-speed USB device number 4 using xhci-hcd
[  OK  ] Started apache2.service - The Apache HTTP Server.
[  257.363143] usb 1-1: unable to read config index 0 descriptor/all
[  257.369355] usb 1-1: can't read configurations, error -71
         Starting NetworkManager-di…nager Script Dispatcher Service...
[  OK  ] Started NetworkManager-dis…Manager Script Dispatcher Service.
[  257.508873] usb 1-1: new high-speed USB device number 5 using xhci-hcd
[  257.538834] usb 1-1: unable to read config index 0 descriptor/all
[  257.544971] usb 1-1: can't read configurations, error -71
[  257.548795] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  257.550613] usb usb1-port1: unable to enumerate USB device
[  257.558380] cpufreq: __target_index: Failed to change cpu frequency: -34
[  257.592849] cpu cpu0: dev_pm_opp_set_rate: failed to find OPP for freq 1404000000 (-34)
[  257.600901] cpufreq: __target_index: Failed to change cpu frequency: -34

Debian GNU/Linux 12 am62xx ttyS2

am62xx login:

Thanks.

Fox Yang said:

I had disabling the eMMC high-speed mode.

It's boot over u-boot stage,but durring boot in kernel stage will stuck random time.

I test many time,maybe boot finsh at 25s 135s 280s or not.

Just to confirm, with the patch applied to disable HS200 mode, your errors no longer happen during U-Boot, but moved into the Kernel boot sequence? This would make sense, since the MMC gets re-initialized during Kernel startup back to HS200 mode. Can you please apply the below patch to the Kernel (same principle as what we did with U-Boot), to see if this now stabilizes the entire boot process.

diff --git a/arch/arm64/boot/dts/ti/k3-am62-main.dtsi b/arch/arm64/boot/dts/ti/k3-am62-main.dtsi
index c554bec7ed18..556902f33218 100644
--- a/arch/arm64/boot/dts/ti/k3-am62-main.dtsi
+++ b/arch/arm64/boot/dts/ti/k3-am62-main.dtsi
@@ -548,14 +548,12 @@ sdhci0: mmc@fa10000 {
                assigned-clocks = <&k3_clks 57 6>;
                assigned-clock-parents = <&k3_clks 57 8>;
                mmc-ddr-1_8v;
-               mmc-hs200-1_8v;
                ti,trm-icp = <0x2>;
                bus-width = <8>;
                ti,clkbuf-sel = <0x7>;
                ti,otap-del-sel-legacy = <0x0>;
                ti,otap-del-sel-mmc-hs = <0x0>;
                ti,otap-del-sel-ddr52 = <0x5>;
-               ti,otap-del-sel-hs200 = <0x5>;
                ti,itap-del-sel-legacy = <0xa>;
                ti,itap-del-sel-mmc-hs = <0x1>;
                status = "disabled";

Your Kernel logs indicate a loot of MMC related low-level communication errors, pointing to a HW-related issue of sorts.

Andreas Dannenberg said:

I looked over the schematic extract I don't see any immediate issue but I've asked our HW expert to double-check.

As indicated earlier I've also discussed your schematic with our eMMC HW expert Paul. Here is what he had to say:

We recommend a pull-down on clock to hold the eMMC device CLK input in a valid logic state until our IOs are configured.  It appears they have one on MMC1_CLK, but not one on MMC0_CLK.  The eMMC device CLK input would be floating until our IOs are initialized.  This may allow the eMMC device to enter a bad state that doesn’t recover.

That is the only schematic issue I spotted.  We should ask if their PCB trace delay are within the limits defined in the datasheet.

Perhaps a non-optimum PCB trace layout that cause signal integrity issues and the Kingston eMMC device may be more sensitive to signal quality issues. 

Regards, Andreas

Hi,

After add disable HS200 mode in kernel ,boot in kernel stage stuck is same situation.

But stuck frequency and time is less before.

Both I ask HW to add a pull-down resistance on MMC0_CLK ,but no help.

Thanks.

Fox Yang said:

After add disable HS200 mode in kernel ,boot in kernel stage stuck is same situation.

But stuck frequency and time is less before.

Ok this further suggests there potentially being some signaling issue.

Can you do a PCB trace propagation delay analysis as well, to make sure you are meeting the datasheet requirements?

Also can you use a good oscilloscope to probe all the power rails of the eMMC chip during access? If the power rails are not 100% stable and sufficiently dimensioned it could result in some marginal operation that would make certain eMMC modules "work" and others "break".

Regards, Andreas

Hi,

Ok,I will check with HW.

Do you have SW Tuning guide about EMMC for reference and double check?

Thanks.

Hi Fox, I've re-assigned this thread to our eMMC HW expert to guide/work next steps with you. Stay tuned.

I'm not able to answer any questions related to software. I will need to re-assign this thread to the software team if your only question is related to software.

From a hardware debug perspective, it is not possible to measure the signal timing relationships on the PCB to confirm timing margin in the read path since the appropriate delays are introduced inside the AM62x device during tuning. The write path uses fixed timing delays and we know the AM62x device is compliant to the eMMC standard as long as the PCB traces do not exceed the delays defined in the datasheet.

The intermittent nature of the problem may be related to a signal integrity issue, which is highlighted by some sensitivity in the Kinston device.

Based on the information provided above, it is not clear how I can help from the hardware perspective.

Regards,
Paul