OrangePi Zero 3 sometimes unable to boot

[ 0.000000] Machine model: OrangePi Zero3 [ 0.000000] OF: reserved mem: 0x0000000040000000..0x000000004003ffff (256 KiB) nomap non-reusable secmon@40000000 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] [ 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 0x0000000040000000-0x000000004003ffff] [ 0.000000] node 0: [mem 0x0000000040040000-0x000000007fffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] [ 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: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.4 [ 0.000000] percpu: Embedded 18 pages/cpu s36008 r8192 d29528 u73728 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] alternatives: applying boot alternatives [ 0.000000] Kernel command line: coherent_pool=2M console=ttyS0,115200 earlyprintk root=PARTUUID=5452574f-02 rootwait [ 0.000000] Unknown kernel command line parameters "earlyprintk", will be passed to user space. [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 258048 [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB [ 0.000000] software IO TLB: area num 4. [ 0.000000] software IO TLB: mapped [mem 0x000000007eb00000-0x000000007ec00000] (1MB) [ 0.000000] Memory: 1013448K/1048576K available (8576K kernel code, 1282K rwdata, 2628K rodata, 448K init, 313K bss, 35128K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 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] Root IRQ handler: gic_handle_irq [ 0.000000] GIC: Using split EOI/Deactivate mode [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. [ 0.000000] arch_timer: cp15 timer(s) running at 24.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns [ 0.000000] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns [ 0.000284] Console: colour dummy device 80x25 [ 0.000322] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=240000) [ 0.000333] pid_max: default: 32768 minimum: 301 [ 0.004281] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [ 0.004293] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [ 0.007146] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 0.007829] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. [ 0.008018] rcu: Hierarchical SRCU implementation. [ 0.008022] rcu: Max phase no-delay instances is 1000. [ 0.008447] smp: Bringing up secondary CPUs ... [ 0.008886] Detected VIPT I-cache on CPU1 [ 0.008952] CPU1: Booted secondary processor 0x0000000001 [0x410fd034] [ 0.009415] Detected VIPT I-cache on CPU2 [ 0.009454] CPU2: Booted secondary processor 0x0000000002 [0x410fd034] [ 0.009914] Detected VIPT I-cache on CPU3 [ 0.009955] CPU3: Booted secondary processor 0x0000000003 [0x410fd034] [ 0.010028] smp: Brought up 1 node, 4 CPUs [ 0.010034] SMP: Total of 4 processors activated. [ 0.010038] CPU features: detected: 32-bit EL0 Support [ 0.010042] CPU features: detected: CRC32 instructions [ 0.010084] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching [ 0.010089] CPU: All CPU(s) started at EL2 [ 0.010092] alternatives: applying system-wide alternatives [ 0.015134] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.015151] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.016825] pinctrl core: initialized pinctrl subsystem [ 0.018604] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.019487] DMA: preallocated 2048 KiB GFP_KERNEL pool for atomic allocations [ 0.019735] DMA: preallocated 2048 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.020002] DMA: preallocated 2048 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.020362] thermal_sys: Registered thermal governor 'step_wise' [ 0.020457] ASID allocator initialised with 65536 entries [ 0.022151] /soc/clock@3001000: Fixed dependency cycle(s) with /soc/rtc@7000000 [ 0.022187] /soc/interrupt-controller@3021000: Fixed dependency cycle(s) with /soc/interrupt-controller@3021000 [ 0.022279] /soc/rtc@7000000: Fixed dependency cycle(s) with /soc/clock@3001000 [ 0.022291] /soc/rtc@7000000: Fixed dependency cycle(s) with /soc/clock@7010000 [ 0.022304] /soc/clock@7010000: Fixed dependency cycle(s) with /soc/clock@3001000 [ 0.022315] /soc/clock@7010000: Fixed dependency cycle(s) with /soc/rtc@7000000 [ 0.022516] /soc/clock@3001000: Fixed dependency cycle(s) with /soc/rtc@7000000 [ 0.024409] /soc/clock@3001000: Fixed dependency cycle(s) with /soc/rtc@7000000 [ 0.024460] /soc/rtc@7000000: Fixed dependency cycle(s) with /soc/clock@3001000 [ 0.024524] /soc/rtc@7000000: Fixed dependency cycle(s) with /soc/clock@7010000 [ 0.024605] /soc/rtc@7000000: Fixed dependency cycle(s) with /soc/clock@7010000 [ 0.024658] /soc/clock@7010000: Fixed dependency cycle(s) with /soc/clock@3001000 [ 0.024721] /soc/clock@7010000: Fixed dependency cycle(s) with /soc/rtc@7000000 [ 0.026167] Modules: 29408 pages in range for non-PLT usage [ 0.026172] Modules: 520928 pages in range for PLT usage [ 0.027910] cryptd: max_cpu_qlen set to 1000 [ 0.030516] SCSI subsystem initialized [ 0.031139] usbcore: registered new interface driver usbfs [ 0.031166] usbcore: registered new interface driver hub [ 0.031206] usbcore: registered new device driver usb [ 0.031357] pps_core: LinuxPPS API ver. 1 registered [ 0.031360] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [email protected] [ 0.031374] PTP clock support registered [ 0.031585] Advanced Linux Sound Architecture Driver Initialized. [ 0.032386] clocksource: Switched to clocksource arch_sys_counter [ 0.038433] NET: Registered PF_INET protocol family [ 0.038563] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) [ 0.040526] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) [ 0.040545] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.040558] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.040627] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) [ 0.040931] TCP: Hash tables configured (established 8192 bind 8192) [ 0.041358] MPTCP token hash table entries: 1024 (order: 2, 24576 bytes, linear) [ 0.041513] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) [ 0.041544] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) [ 0.041891] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.043878] workingset: timestamp_bits=46 max_order=18 bucket_order=0 [ 0.051001] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 0.051708] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc. [ 0.056865] sun4i-usb-phy 5100400.phy: failed to get clock usb0_phy [ 0.058751] gpio gpiochip0: Static allocation of GPIO base is deprecated, use dynamic allocation. [ 0.059383] gpio gpiochip0: Static allocation of GPIO base is deprecated, use dynamic allocation. [ 0.063829] Serial: 8250/16550 driver, 8 ports, IRQ sharing disabled [ 0.072595] loop: module loaded [ 0.075430] usbcore: registered new interface driver usb-storage [ 0.075812] mousedev: PS/2 mouse device common for all mice [ 0.075991] i2c_dev: i2c /dev entries driver [ 0.076214] mv64xxx_i2c 7081400.i2c: can't get pinctrl, bus recovery not supported [ 0.076601] /soc/i2c@7081400/pmic@36: Fixed dependency cycle(s) with /soc/pinctrl@300b000 [ 0.079769] sunxi-wdt 30090a0.watchdog: Watchdog enabled (timeout=16 sec, nowayout=0) [ 0.080755] SMCCC: SOC_ID: ID = jep106:091e:1823 Revision = 0x00000002 [ 0.082964] NET: Registered PF_INET6 protocol family [ 0.084025] Segment Routing with IPv6 [ 0.084078] In-situ OAM (IOAM) with IPv6 [ 0.084138] NET: Registered PF_PACKET protocol family [ 0.084160] can: controller area network core [ 0.084191] NET: Registered PF_CAN protocol family [ 0.084197] 8021q: 802.1Q VLAN Support v1.8 [ 0.106816] sun4i-usb-phy 5100400.phy: Couldn't get regulator usb1_vbus... Deferring probe [ 0.107796] gpio gpiochip0: Static allocation of GPIO base is deprecated, use dynamic allocation. [ 0.112561] sun50i-h616-pinctrl 300b000.pinctrl: request() failed for pin 80 [ 0.112569] sun50i-h616-pinctrl 300b000.pinctrl: pin-80 (300b000.pinctrl:80) status -517 [ 0.115604] sun50i-h616-pinctrl 300b000.pinctrl: initialized sunXi PIO driver [ 0.116171] gpio gpiochip1: Static allocation of GPIO base is deprecated, use dynamic allocation. [ 0.116351] sun50i-h616-r-pinctrl 7022000.pinctrl: initialized sunXi PIO driver [ 0.116589] sun50i-h616-pinctrl 300b000.pinctrl: request() failed for pin 224 [ 0.116596] sun50i-h616-pinctrl 300b000.pinctrl: pin-224 (5000000.serial) status -517 [ 0.116604] sun50i-h616-pinctrl 300b000.pinctrl: could not request pin 224 (PH0) from group PH0 on device 300b000.pinctrl [ 0.116612] dw-apb-uart 5000000.serial: Error applying setting, reverse things back [ 0.116783] sun50i-h616-pinctrl 300b000.pinctrl: request() failed for pin 64 [ 0.116789] sun50i-h616-pinctrl 300b000.pinctrl: pin-64 (5010000.spi) status -517 [ 0.116797] sun50i-h616-pinctrl 300b000.pinctrl: could not request pin 64 (PC0) from group PC0 on device 300b000.pinctrl [ 0.116804] sun6i-spi 5010000.spi: Error applying setting, reverse things back [ 0.117247] sun50i-h616-pinctrl 300b000.pinctrl: request() failed for pin 256 [ 0.117253] sun50i-h616-pinctrl 300b000.pinctrl: pin-256 (5020000.ethernet) status -517 [ 0.117260] sun50i-h616-pinctrl 300b000.pinctrl: could not request pin 256 (PI0) from group PI0 on device 300b000.pinctrl [ 0.117267] dwmac-sun8i 5020000.ethernet: Error applying setting, reverse things back [ 0.117620] axp20x-i2c 0-0036: AXP20x variant AXP313a found [ 0.119524] axp20x-i2c 0-0036: AXP20X driver loaded [ 0.126123] sun4i-usb-phy 5100400.phy: Couldn't get regulator usb1_vbus... Deferring probe [ 0.127133] printk: console [ttyS0] disabled [ 0.127710] sunxi-mmc 4020000.mmc: Got CD GPIO [ 0.147705] 5000000.serial: ttyS0 at MMIO 0x5000000 (irq = 290, base_baud = 1500000) is a 16550A [ 0.147744] printk: console [ttyS0] enabled [ 0.153508] sunxi-mmc 4020000.mmc: initialized, max. request size: 16384 KB, uses new timings mode [ 0.154772] sun6i-spi 5010000.spi: Failed to request TX DMA channel [ 0.206939] mmc0: host does not support reading read-only switch, assuming write-enable [ 0.207592] sun6i-spi 5010000.spi: Failed to request RX DMA channel [ 0.216791] mmc0: new high speed SDHC card at address aaaa [ 0.223514] spi-nor spi0.0: spi-nor-generic (16384 Kbytes) [ 0.228080] mmcblk0: mmc0:aaaa SC16G 14.8 GiB [ 0.233904] dwmac-sun8i 5020000.ethernet: IRQ eth_wake_irq not found [ 0.241683] mmcblk0: p1 p2 p3 [ 0.242023] dwmac-sun8i 5020000.ethernet: IRQ eth_lpi not found [ 1.251007] dwmac-sun8i 5020000.ethernet: PTP uses main clock [ 1.256763] dwmac-sun8i 5020000.ethernet: Current syscon value is not the default 51c06 (expect 0) [ 1.265880] dwmac-sun8i 5020000.ethernet: No HW DMA feature register supported [ 1.273099] dwmac-sun8i 5020000.ethernet: RX Checksum Offload Engine supported [ 1.280309] dwmac-sun8i 5020000.ethernet: COE Type 2 [ 1.285275] dwmac-sun8i 5020000.ethernet: TX Checksum insertion supported [ 1.292051] dwmac-sun8i 5020000.ethernet: Normal descriptors [ 1.297703] dwmac-sun8i 5020000.ethernet: Chain mode enabled [ 1.308331] usb_phy_generic usb_phy_generic.0.auto: dummy supplies not allowed for exclusive requests [ 1.312629] ohci-platform 5200400.usb: Generic Platform OHCI controller [ 1.318338] ehci-platform 5200000.usb: EHCI Host Controller [ 1.324187] ohci-platform 5200400.usb: new USB bus registered, assigned bus number 1 [ 1.329756] ehci-platform 5200000.usb: new USB bus registered, assigned bus number 2 [ 1.337538] ohci-platform 5200400.usb: irq 16, io mem 0x05200400 [ 1.345280] ehci-platform 5200000.usb: irq 15, io mem 0x05200000 [ 1.357334] clk: Disabling unused clocks [ 1.361365] ALSA device list: [ 1.364339] No soundcards found. [ 1.382416] ehci-platform 5200000.usb: USB 2.0 started, EHCI 1.00 [ 1.388614] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 [ 1.396972] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1.404191] usb usb2: Product: EHCI Host Controller [ 1.409061] usb usb2: Manufacturer: Linux 6.6.69 ehci_hcd [ 1.414453] usb usb2: SerialNumber: 5200000.usb [ 1.419300] hub 2-0:1.0: USB hub found [ 1.423067] hub 2-0:1.0: 1 port detected [ 1.427290] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.06 [ 1.435553] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1.442767] usb usb1: Product: Generic Platform OHCI controller [ 1.448676] usb usb1: Manufacturer: Linux 6.6.69 ohci_hcd [ 1.454069] usb usb1: SerialNumber: 5200400.usb [ 1.458824] hub 1-0:1.0: USB hub found [ 1.462590] hub 1-0:1.0: 1 port detected [ 1.480058] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem [ 1.487367] EXT4-fs (mmcblk0p2): write access will be enabled during recovery [ 1.522969] EXT4-fs (mmcblk0p2): recovery complete [ 1.529492] EXT4-fs (mmcblk0p2): mounted filesystem ff313567-e9f1-5a5d-9895-3ba130b4a864 ro with ordered data mode. Quota mode: disabled. [ 1.541884] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 1.548835] Freeing unused kernel memory: 448K [ 1.553345] Run /sbin/init as init process [ 1.644185] init: Console is alive [ 1.647692] init: - watchdog - [ 1.870507] kmodloader: loading kernel modules from /etc/modules-boot.d/* [ 1.898206] usbcore: registered new interface driver uas [ 1.903723] kmodloader: done loading kernel modules from /etc/modules-boot.d/* [ 1.912766] init: - preinit - [ 6.472394] random: crng init done WARNING: Variable 'children' does not exist or is not an array/object WARNING: Variable '2' does not exist or is not an array/object [ 6.654417] mount_root: mounting /dev/root [ 6.698010] EXT4-fs (mmcblk0p2): re-mounted ff313567-e9f1-5a5d-9895-3ba130b4a864 r/w. Quota mode: disabled. [ 6.707846] mount_root: loading kmods from internal overlay [ 6.723597] kmodloader: loading kernel modules from //etc/modules-boot.d/* [ 6.731580] kmodloader: done loading kernel modules from //etc/modules-boot.d/* [ 6.959385] block: attempting to load /tmp/overlay/upper/etc/config/fstab [ 6.966270] block: unable to load configuration (fstab: Entry not found) [ 6.973008] block: attempting to load /tmp/overlay/etc/config/fstab [ 6.979312] block: unable to load configuration (fstab: Entry not found) [ 6.986052] block: attempting to load /etc/config/fstab [ 6.995072] block: extroot: not configured [ 6.999605] block: attempting to load /etc/config/fstab [ 7.004964] block: extroot: not configured [ 7.074649] urandom-seed: Seeding with /etc/urandom.seed [ 7.091101] procd: - early - [ 7.094148] procd: - watchdog - [ 7.632110] procd: - watchdog - [ 7.636319] procd: - ubus - [ 7.801719] procd: - init - Please press Enter to activate this console. [ 8.040776] kmodloader: loading kernel modules from /etc/modules.d/* [ 8.171829] NET: Registered PF_ALG protocol family [ 8.188031] tun: Universal TUN/TAP device driver, 1.6 [ 8.198871] GACT probability on [ 8.202529] Mirror/redirect action on [ 8.209092] u32 classifier [ 8.211808] input device check on [ 8.215557] Actions configured [ 8.241827] Simple TC action Loaded [ 8.257126] ntfs3: Enabled Linux POSIX ACLs support [ 8.257192] Unable to handle kernel write to read-only memory at virtual address ffffff800291e001 [ 8.257192] Unable to handle kernel write to read-only memory at virtual address ffffff800291e000 [ 8.257198] Mem abort info: [ 8.257200] ESR = 0x000000009600004f [ 8.257202] EC = 0x25: DABT (current EL), IL = 32 bits [ 8.257205] SET = 0, FnV = 0 [ 8.257207] EA = 0, S1PTW = 0 [ 8.257210] FSC = 0x0f: level 3 permission fault [ 8.257213] Data abort info: [ 8.257214] ISV = 0, ISS = 0x0000004f, ISS2 = 0x00000000 [ 8.257216] CM = 0, WnR = 1, TnD = 0, TagAccess = 0 [ 8.257219] GCS = 0, Overlay = 0, DirtyBit = 0, Xs = 0 [ 8.257223] swapper pgtable: 4k pages, 39-bit VAs, pgdp=0000000040d07000 [ 8.257227] [ffffff800291e000] pgd=180000007fffa003, p4d=180000007fffa003, pud=180000007fffa003, pmd=180000007ffe9003, pte=006000004291e787 [ 8.257241] Internal error: Oops: 000000009600004f [#1] SMP [ 8.257245] Modules linked in: ntfs3(+) sch_teql sch_sfq sch_multiq sch_gred sch_fq sch_codel em_text em_nbyte em_meta em_cmp act_skbmod act_simple act_pedit act_csum libcrc32c act_connmark nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 sch_tbf sch_ingress sch_htb sch_hfsc em_u32 cls_u32 cls_route cls_matchall cls_fw cls_flow cls_basic act_skbedit act_mirred act_gact ifb ip6_udp_tunnel udp_tunnel tun autofs4 nls_utf8 crypto_user algif_skcipher algif_rng algif_hash algif_aead af_alg sha512_generic sha512_arm64 sha256_generic sha256_arm64 sha3_generic jitterentropy_rng drbg hmac ecb arc4 uas xhci_plat_hcd xhci_hcd fsl_mph_dr_of ehci_fsl exfat [ 8.257356] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.6.69 #0 [ 8.257361] Hardware name: OrangePi Zero3 (DT) [ 8.257365] pstate: 004000c5 (nzcv daIF +PAN -UAO -TCO -DIT -SSBS BTYPE=--) [ 8.257370] pc : sun6i_spi_handler+0x150/0x1b0 [ 8.257386] lr : __handle_irq_event_percpu+0x44/0x11c [ 8.257396] sp : ffffffc080003f10 [ 8.257398] x29: ffffffc080003f10 x28: ffffffc080b94140 x27: ffffffc080b93c50 [ 8.257406] x26: ffffff803fdd2000 x25: ffffffc080a50948 x24: ffffff803fdd200c [ 8.257413] x23: ffffff8001f9c200 x22: 0000000000000124 x21: 0000000000000000 [ 8.257420] x20: ffffff8001f9c230 x19: ffffff8001f76080 x18: ffffffc0815f3d30 [ 8.257427] x17: ffffffbfbf210000 x16: ffffffc080000000 x15: 0000000000000002 [ 8.257434] x14: 0000000000000000 x13: 0000000000000000 x12: 0000000000000000 [ 8.257441] x11: 00000000fa83b2da x10: 00000000000008a0 x9 : ffffffc080b83d20 [ 8.257448] x8 : ffffff803fd8d230 x7 : fef116f4e2cc602b x6 : 2694c4c74e28a85c [ 8.257454] x5 : c7e5d9e69843752c x4 : ffffff800291e001 x3 : 0000000000000000 [ 8.257461] x2 : ffffff800291e000 x1 : ffffff8002c31540 x0 : 0000000000000003 [ 8.257469] Call trace: [ 8.257471] sun6i_spi_handler+0x150/0x1b0 [ 8.257478] handle_irq_event+0x40/0xc4 [ 8.257484]