EDIT: With @daniel's help I fixed this issue and am leaving the bulk of this post here so others can find the solution, which is: DON'T USE schedutil CPU GOVERNOR SETTING on the Belkin RT3200, because the MT7622, which controls the 2.4Ghz radio, doesn't support it.
Could this be related to my 2.4Ghz radio not initializing? Haven't found much help through searching.
What's frustrating is that on rare occasions, the 2.4Ghz radio WILL initialize during power-up. But 90% of the time it doesn't. (I also haven't ruled out the possibility that I have a bad unit, but why does it work sometimes?)
Running 22.03.3 stable
Tue Jan 24 00:47:10 2023 kern.err kernel: [ 28.684221] mt7622-wmac 18000000.wmac: Message 00000010 (seq 1) timeout
Tue Jan 24 00:47:10 2023 kern.err kernel: [ 28.690854] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:10 2023 kern.err kernel: [ 28.914695] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:10 2023 kern.err kernel: [ 29.134635] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:10 2023 kern.err kernel: [ 29.354654] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:11 2023 kern.err kernel: [ 29.574639] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:11 2023 kern.err kernel: [ 29.794663] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:11 2023 kern.err kernel: [ 30.014687] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:11 2023 kern.err kernel: [ 30.234656] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:12 2023 kern.err kernel: [ 30.454626] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:12 2023 kern.err kernel: [ 30.674659] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:12 2023 kern.err kernel: [ 30.894631] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
Tue Jan 24 00:47:12 2023 daemon.err hostapd: Could not set interface wlan0 flags (UP): I/O error
Tue Jan 24 00:47:12 2023 daemon.err hostapd: nl80211: Could not set interface 'wlan0' UP
Tue Jan 24 00:47:12 2023 daemon.notice hostapd: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Tue Jan 24 00:47:12 2023 daemon.err hostapd: nl80211 driver initialization failed.
Tue Jan 24 00:47:12 2023 daemon.notice hostapd: wlan0: CTRL-EVENT-TERMINATING
Tue Jan 24 00:47:12 2023 daemon.err hostapd: hostapd_free_hapd_data: Interface wlan0 wasn't started
Here's my entire kernel log if it helps anyone:
[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[ 0.000000] Linux version 5.10.161 (builder@buildhost) (aarch64-openwrt-linux-musl-gcc (OpenWrt GCC 11.2.0 r20028-43d71ad93e) 11.2.0, GNU ld (GNU Binutils) 2.37) #0 SMP Tue Jan 3 00:24:21 2023
[ 0.000000] Machine model: Linksys E8450 (UBI)
[ 0.000000] earlycon: uart8250 at MMIO32 0x0000000011002000 (options '')
[ 0.000000] printk: bootconsole [uart8250] enabled
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000040000000-0x000000005fffffff]
[ 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-0x0000000042ffffff]
[ 0.000000] node 0: [mem 0x0000000043000000-0x000000004302ffff]
[ 0.000000] node 0: [mem 0x0000000043030000-0x000000005fffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000005fffffff]
[ 0.000000] On node 0 totalpages: 131072
[ 0.000000] DMA zone: 2048 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 131072 pages, LIFO batch:31
[ 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.2
[ 0.000000] percpu: Embedded 20 pages/cpu s44312 r8192 d29416 u81920
[ 0.000000] pcpu-alloc: s44312 r8192 d29416 u81920 alloc=20*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] Detected VIPT I-cache on CPU0
[ 0.000000] CPU features: detected: ARM erratum 845719
[ 0.000000] CPU features: kernel page table isolation disabled by kernel configuration
[ 0.000000] CPU features: detected: ARM erratum 843419
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 129024
[ 0.000000] Kernel command line: earlycon=uart8250,mmio32,0x11002000 console=ttyS0,115200n1 swiotlb=512
[ 0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] Memory: 494120K/524288K available (8254K kernel code, 894K rwdata, 1448K rodata, 448K init, 300K bss, 30168K reserved, 0K cma-reserved)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] rcu: Hierarchical RCU implementation.
[ 0.000000] Tracing variant of Tasks RCU enabled.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[ 0.000000] GIC: GICv2 detected, but range too small and irqchip.gicv2_force_probe not set
[ 0.000000] arch_timer: cp15 timer(s) running at 12.50MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049cda, max_idle_ns: 440795202628 ns
[ 0.000003] sched_clock: 56 bits at 12MHz, resolution 80ns, wraps every 4398046511080ns
[ 0.008263] Calibrating delay loop (skipped), value calculated using timer frequency.. 25.00 BogoMIPS (lpj=125000)
[ 0.018661] pid_max: default: 32768 minimum: 301
[ 0.023371] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes, linear)
[ 0.030714] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes, linear)
[ 0.039528] rcu: Hierarchical SRCU implementation.
[ 0.044476] dyndbg: Ignore empty _ddebug table in a CONFIG_DYNAMIC_DEBUG_CORE build
[ 0.052481] smp: Bringing up secondary CPUs ...
[ 0.057384] Detected VIPT I-cache on CPU1
[ 0.057391] CPU features: SANITY CHECK: Unexpected variation in SYS_CNTFRQ_EL0. Boot CPU: 0x00000000bebc20, CPU1: 0x00000000000000
[ 0.057409] CPU features: Unsupported CPU feature variation detected.
[ 0.057441] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[ 0.057509] smp: Brought up 1 node, 2 CPUs
[ 0.090437] SMP: Total of 2 processors activated.
[ 0.095153] CPU features: detected: 32-bit EL0 Support
[ 0.100310] CPU features: detected: CRC32 instructions
[ 0.105575] CPU: All CPU(s) started at EL2
[ 0.109686] alternatives: patching kernel code
[ 0.117659] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.127557] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[ 0.134451] pinctrl core: initialized pinctrl subsystem
[ 0.141014] NET: Registered protocol family 16
[ 0.145903] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
[ 0.153036] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[ 0.160823] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[ 0.169129] thermal_sys: Registered thermal governor 'fair_share'
[ 0.169135] thermal_sys: Registered thermal governor 'bang_bang'
[ 0.175250] thermal_sys: Registered thermal governor 'step_wise'
[ 0.181319] thermal_sys: Registered thermal governor 'user_space'
[ 0.187629] ASID allocator initialised with 65536 entries
[ 0.199696] pstore: Registered ramoops as persistent store backend
[ 0.205930] ramoops: using 0x10000@0x42ff0000, ecc: 0
[ 0.241261] cryptd: max_cpu_qlen set to 1000
[ 0.248021] SCSI subsystem initialized
[ 0.251938] libata version 3.00 loaded.
[ 0.255965] usbcore: registered new interface driver usbfs
[ 0.261585] usbcore: registered new interface driver hub
[ 0.266964] usbcore: registered new device driver usb
[ 0.274145] clocksource: Switched to clocksource arch_sys_counter
[ 0.280939] NET: Registered protocol family 2
[ 0.285502] IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.293226] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes, linear)
[ 0.301653] TCP established hash table entries: 4096 (order: 3, 32768 bytes, linear)
[ 0.309461] TCP bind hash table entries: 4096 (order: 4, 65536 bytes, linear)
[ 0.316680] TCP: Hash tables configured (established 4096 bind 4096)
[ 0.323142] UDP hash table entries: 256 (order: 1, 8192 bytes, linear)
[ 0.329713] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear)
[ 0.336827] NET: Registered protocol family 1
[ 0.341216] PCI: CLS 0 bytes, default 64
[ 0.347831] workingset: timestamp_bits=46 max_order=17 bucket_order=0
[ 0.356922] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.362781] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA) (RTIME) (CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[ 0.405525] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[ 0.413481] mtk-tphy 1a0c4000.usb-phy: failed to get ref_clk(id-1)
[ 0.425415] mt-pmic-pwrap 10001000.pwrap: unexpected interrupt int=0x1
[ 0.440384] Serial: 8250/16550 driver, 16 ports, IRQ sharing enabled
[ 0.448827] printk: console [ttyS0] disabled
[ 0.473321] 11002000.serial: ttyS0 at MMIO 0x11002000 (irq = 22, base_baud = 1562500) is a ST16650V2
[ 0.482556] printk: console [ttyS0] enabled
[ 0.490928] printk: bootconsole [uart8250] disabled
[ 0.521495] 11004000.serial: ttyS1 at MMIO 0x11004000 (irq = 23, base_baud = 1562500) is a ST16650V2
[ 0.531499] 1100c000.serial: ttyS2 at MMIO 0x1100c000 (irq = 27, base_baud = 17499995) is a MediaTek BTIF
[ 0.541224] serial serial0: tty port ttyS2 registered
[ 0.546953] mtk_rng 1020f000.rng: registered RNG driver
[ 0.552499] cacheinfo: Unable to detect cache hierarchy for CPU 0
[ 0.552599] random: crng init done
[ 0.565217] loop: module loaded
[ 0.568362] Loading iSCSI transport class v2.0-870.
[ 0.575172] mtk-snand 1100d000.snfi: chip is FM35Q1GA, size 128MB, page size 2048, oob size 64
[ 0.583978] 4 fixed-partitions partitions found on MTD device 1100d000.snfi
[ 0.591002] OF: Bad cell count for /snfi@1100d000/partitions
[ 0.596677] OF: Bad cell count for /snfi@1100d000/partitions
[ 0.602803] Creating 4 MTD partitions on "1100d000.snfi":
[ 0.608219] 0x000000000000-0x000000080000 : "bl2"
[ 0.613817] 0x000000080000-0x0000001c0000 : "fip"
[ 0.620219] 0x0000001c0000-0x0000002c0000 : "factory"
[ 0.626731] 0x000000300000-0x000008000000 : "ubi"
[ 0.790192] mtk_soc_eth 1b100000.ethernet eth0: mediatek frame engine at 0xffffffc011c80000, irq 37
[ 0.800952] i2c /dev entries driver
[ 0.805773] mtk-wdt 10212000.watchdog: Watchdog enabled (timeout=31 sec, nowayout=0)
[ 0.817244] NET: Registered protocol family 10
[ 0.822592] Segment Routing with IPv6
[ 0.826334] NET: Registered protocol family 17
[ 0.830824] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[ 0.843906] 8021q: 802.1Q VLAN Support v1.8
[ 0.849308] pstore: Using crash dump compression: deflate
[ 0.864483] mtk-pcie 1a143000.pcie: host bridge /pcie@1a143000 ranges:
[ 0.871021] mtk-pcie 1a143000.pcie: Parsing ranges property...
[ 0.876886] mtk-pcie 1a143000.pcie: MEM 0x0020000000..0x0027ffffff -> 0x0020000000
[ 0.901447] mtk-pcie 1a143000.pcie: PCI host bridge to bus 0000:00
[ 0.907655] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.913135] pci_bus 0000:00: root bus resource [mem 0x20000000-0x27ffffff]
[ 0.920007] pci_bus 0000:00: scanning bus
[ 0.924053] pci 0000:00:00.0: [14c3:3258] type 01 class 0x060400
[ 0.930087] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x1ffffffff 64bit pref]
[ 0.938970] pci_bus 0000:00: fixups for bus
[ 0.943160] pci 0000:00:00.0: scanning [bus 00-00] behind bridge, pass 0
[ 0.949870] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[ 0.957889] pci 0000:00:00.0: scanning [bus 00-00] behind bridge, pass 1
[ 0.964728] pci_bus 0000:01: scanning bus
[ 0.968950] pci 0000:01:00.0: [14c3:7915] type 00 class 0x000280
[ 0.975141] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x000fffff 64bit pref]
[ 0.982460] pci 0000:01:00.0: reg 0x18: [mem 0x00000000-0x00003fff 64bit pref]
[ 0.989786] pci 0000:01:00.0: reg 0x20: [mem 0x00000000-0x00000fff 64bit pref]
[ 0.997749] pci 0000:01:00.0: supports D1 D2
[ 1.002010] pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 1.008645] pci 0000:01:00.0: PME# disabled
[ 1.013126] pci 0000:01:00.0: 2.000 Gb/s available PCIe bandwidth, limited by 2.5 GT/s PCIe x1 link at 0000:00:00.0 (capable of 4.000 Gb/s with 5.0 GT/s PCIe x1 link)
[ 1.055537] pci_bus 0000:01: fixups for bus
[ 1.059724] pci_bus 0000:01: bus scan returning with max=01
[ 1.065309] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01
[ 1.071920] pci_bus 0000:00: bus scan returning with max=01
[ 1.077510] pci 0000:00:00.0: BAR 0: no space for [mem size 0x200000000 64bit pref]
[ 1.085163] pci 0000:00:00.0: BAR 0: failed to assign [mem size 0x200000000 64bit pref]
[ 1.093159] pci 0000:00:00.0: BAR 8: assigned [mem 0x20000000-0x201fffff]
[ 1.099946] pci 0000:01:00.0: BAR 0: assigned [mem 0x20000000-0x200fffff 64bit pref]
[ 1.107770] pci 0000:01:00.0: BAR 2: assigned [mem 0x20100000-0x20103fff 64bit pref]
[ 1.115595] pci 0000:01:00.0: BAR 4: assigned [mem 0x20104000-0x20104fff 64bit pref]
[ 1.123412] pci 0000:00:00.0: PCI bridge to [bus 01]
[ 1.128378] pci 0000:00:00.0: bridge window [mem 0x20000000-0x201fffff]
[ 1.135259] pcieport 0000:00:00.0: of_irq_parse_pci: failed with rc=-22
[ 1.141864] pcieport 0000:00:00.0: assign IRQ: got 0
[ 1.146839] pcieport 0000:00:00.0: enabling device (0000 -> 0002)
[ 1.152943] pcieport 0000:00:00.0: enabling bus mastering
[ 1.158897] mtk-pcie 1a145000.pcie: host bridge /pcie@1a145000 ranges:
[ 1.165455] mtk-pcie 1a145000.pcie: Parsing ranges property...
[ 1.171288] mtk-pcie 1a145000.pcie: MEM 0x0028000000..0x002fffffff -> 0x0028000000
[ 1.279503] mtk-pcie 1a145000.pcie: Port1 link down
[ 1.284519] mtk-pcie 1a145000.pcie: PCI host bridge to bus 0001:00
[ 1.290697] pci_bus 0001:00: root bus resource [bus 00-ff]
[ 1.296184] pci_bus 0001:00: root bus resource [mem 0x28000000-0x2fffffff]
[ 1.303050] pci_bus 0001:00: scanning bus
[ 1.308280] pci_bus 0001:00: fixups for bus
[ 1.312457] pci_bus 0001:00: bus scan returning with max=00
[ 1.318382] mtk_hsdma 1b007000.dma-controller: Using 3 as missing dma-requests property
[ 1.326641] mtk_hsdma 1b007000.dma-controller: MediaTek HSDMA driver registered
[ 1.382946] mt7530 mdio-bus:00 lan1 (uninitialized): PHY [mt7530-0:00] driver [MediaTek MT7531 PHY] (irq=145)
[ 1.402808] mt7530 mdio-bus:00 lan2 (uninitialized): PHY [mt7530-0:01] driver [MediaTek MT7531 PHY] (irq=146)
[ 1.422665] mt7530 mdio-bus:00 lan3 (uninitialized): PHY [mt7530-0:02] driver [MediaTek MT7531 PHY] (irq=147)
[ 1.442521] mt7530 mdio-bus:00 lan4 (uninitialized): PHY [mt7530-0:03] driver [MediaTek MT7531 PHY] (irq=148)
[ 1.462560] mt7530 mdio-bus:00 wan (uninitialized): PHY [mt7530-0:04] driver [MediaTek MT7531 PHY] (irq=149)
[ 1.474270] mt7530 mdio-bus:00: configuring for fixed/2500base-x link mode
[ 1.481341] DSA: tree 0 setup
[ 1.481514] mt7530 mdio-bus:00: Link is Up - 2.5Gbps/Full - flow control rx/tx
[ 1.485143] xhci-mtk 1a0c0000.usb: xHCI Host Controller
[ 1.496808] xhci-mtk 1a0c0000.usb: new USB bus registered, assigned bus number 1
[ 1.505889] xhci-mtk 1a0c0000.usb: hcc params 0x01403198 hci version 0x96 quirks 0x0000000000210010
[ 1.514984] xhci-mtk 1a0c0000.usb: irq 31, io mem 0x1a0c0000
[ 1.521140] hub 1-0:1.0: USB hub found
[ 1.524940] hub 1-0:1.0: 2 ports detected
[ 1.529218] xhci-mtk 1a0c0000.usb: xHCI Host Controller
[ 1.534465] xhci-mtk 1a0c0000.usb: new USB bus registered, assigned bus number 2
[ 1.541866] xhci-mtk 1a0c0000.usb: Host supports USB 3.0 SuperSpeed
[ 1.548180] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[ 1.556610] hub 2-0:1.0: USB hub found
[ 1.560381] hub 2-0:1.0: 1 port detected
[ 1.565422] UBI: auto-attach mtd3
[ 1.568750] ubi0: attaching mtd3
[ 1.954178] ubi0: scanning is finished
[ 1.962199] ubi0: attached mtd3 (name "ubi", size 125 MiB)
[ 1.967705] ubi0: PEB size: 131072 bytes (128 KiB), LEB size: 126976 bytes
[ 1.974586] ubi0: min./max. I/O unit sizes: 2048/2048, sub-page size 2048
[ 1.981365] ubi0: VID header offset: 2048 (aligned 2048), data offset: 4096
[ 1.988325] ubi0: good PEBs: 1000, bad PEBs: 0, corrupted PEBs: 0
[ 1.994413] ubi0: user volume: 6, internal volumes: 1, max. volumes count: 128
[ 2.001626] ubi0: max/mean erase counter: 2/0, WL threshold: 4096, image sequence number: 1056720629
[ 2.010753] ubi0: available PEBs: 2, total reserved PEBs: 998, PEBs reserved for bad PEB handling: 20
[ 2.020055] ubi0: background thread "ubi_bgt0d" started, PID 853
[ 2.027052] FIT: Selected configuration: "config-1" (OpenWrt linksys_e8450-ubi)
[ 2.034425] FIT: kernel sub-image 0x00001000..0x004dd26b "kernel-1" (ARM64 OpenWrt Linux-5.10.161)
[ 2.044354] FIT: flat_dt sub-image 0x004de000..0x004e5578 "fdt-1" (ARM64 OpenWrt linksys_e8450-ubi device tree blob)
[ 2.055758] FIT: filesystem sub-image 0x004e6000..0x00b5dfff "rootfs-1" (ARM64 OpenWrt linksys_e8450-ubi rootfs)
[ 2.066557] FIT: selecting configured loadable "rootfs-1" to be root filesystem
[ 2.073856] ubiblock0_4: p1(rootfs-1)
[ 2.074212] block ubiblock0_4: created from ubi0:4(fit)
[ 2.086641] VFS: Mounted root (squashfs filesystem) readonly on device 259:1.
[ 2.093978] Freeing unused kernel memory: 448K
[ 2.134184] Run /sbin/init as init process
[ 2.138275] with arguments:
[ 2.141232] /sbin/init
[ 2.143928] with environment:
[ 2.147068] HOME=/
[ 2.149417] TERM=linux
[ 2.319960] init: Console is alive
[ 2.323505] init: - watchdog -
[ 2.596256] kmodloader: loading kernel modules from /etc/modules-boot.d/*
[ 2.647239] kmodloader: done loading kernel modules from /etc/modules-boot.d/*
[ 2.659630] init: - preinit -
[ 2.876173] mtk_soc_eth 1b100000.ethernet eth0: configuring for fixed/2500base-x link mode
[ 2.884719] mtk_soc_eth 1b100000.ethernet eth0: Link is Up - 2.5Gbps/Full - flow control rx/tx
[ 2.893407] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 2.904995] mt7530 mdio-bus:00 lan1: configuring for phy/gmii link mode
[ 2.912127] 8021q: adding VLAN 0 to HW filter on device lan1
[ 6.968002] UBIFS (ubi0:5): Mounting in unauthenticated mode
[ 6.973776] UBIFS (ubi0:5): background thread "ubifs_bgt0_5" started, PID 930
[ 6.997196] UBIFS (ubi0:5): recovery needed
[ 7.053181] UBIFS (ubi0:5): recovery completed
[ 7.057712] UBIFS (ubi0:5): UBIFS: mounted UBI device 0, volume 5, name "rootfs_data"
[ 7.065549] UBIFS (ubi0:5): LEB size: 126976 bytes (124 KiB), min./max. I/O unit sizes: 2048 bytes/2048 bytes
[ 7.075459] UBIFS (ubi0:5): FS size: 91168768 bytes (86 MiB, 718 LEBs), journal size 4571136 bytes (4 MiB, 36 LEBs)
[ 7.085908] UBIFS (ubi0:5): reserved for root: 4306125 bytes (4205 KiB)
[ 7.092515] UBIFS (ubi0:5): media format: w5/r0 (latest is w5/r0), UUID 3D6B3F25-9E17-4D53-BD24-F35D311ABB10, small LPT model
[ 7.107706] mount_root: switching to ubifs overlay
[ 7.114970] overlayfs: "xino" feature enabled using 2 upper inode bits.
[ 7.124751] urandom-seed: Seeding with /etc/urandom.seed
[ 7.192785] procd: - early -
[ 7.195822] procd: - watchdog -
[ 7.741163] procd: - watchdog -
[ 7.745204] procd: - ubus -
[ 7.798968] procd: - init -
[ 8.061651] urngd: v1.0.2 started.
[ 8.121788] kmodloader: loading kernel modules from /etc/modules.d/*
[ 8.170709] Loading modules backported from Linux version v5.15.81-0-ge4a7232c917c
[ 8.178303] Backport generated by backports.git v5.15.81-1-0-ge1867d55
[ 8.237644] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[ 8.250016] mt7915e 0000:01:00.0: assign IRQ: got 150
[ 8.255171] pci 0000:00:00.0: enabling bus mastering
[ 8.260156] mt7915e 0000:01:00.0: enabling device (0000 -> 0002)
[ 8.266294] mt7915e 0000:01:00.0: enabling bus mastering
[ 8.451442] mt7915e 0000:01:00.0: HW/SW Version: 0x8a108a10, Build Time: 20211222184017a
[ 8.451442]
[ 8.577848] mt7915e 0000:01:00.0: WM Firmware Version: ____000000, Build Time: 20211222184052
[ 8.600261] mt7915e 0000:01:00.0: WA Firmware Version: DEV_000000, Build Time: 20211222184111
[ 8.742826] PPP generic driver version 2.4.2
[ 8.748445] NET: Registered protocol family 24
[ 8.756464] kmodloader: done loading kernel modules from /etc/modules.d/*
[ 11.290243] mtk_soc_eth 1b100000.ethernet eth0: Link is Down
[ 11.299402] mtk_soc_eth 1b100000.ethernet eth0: configuring for fixed/2500base-x link mode
[ 11.315589] mt7530 mdio-bus:00 lan1: configuring for phy/gmii link mode
[ 11.320004] mtk_soc_eth 1b100000.ethernet eth0: Link is Up - 2.5Gbps/Full - flow control rx/tx
[ 11.323042] 8021q: adding VLAN 0 to HW filter on device lan1
[ 11.348029] br-lan: port 1(lan1) entered blocking state
[ 11.353262] br-lan: port 1(lan1) entered disabled state
[ 11.367702] device lan1 entered promiscuous mode
[ 11.372360] device eth0 entered promiscuous mode
[ 11.381713] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 11.398152] mt7530 mdio-bus:00 lan2: configuring for phy/gmii link mode
[ 11.409492] 8021q: adding VLAN 0 to HW filter on device lan2
[ 11.422972] br-lan: port 2(lan2) entered blocking state
[ 11.428303] br-lan: port 2(lan2) entered disabled state
[ 11.437234] device lan2 entered promiscuous mode
[ 11.450625] mt7530 mdio-bus:00 lan3: configuring for phy/gmii link mode
[ 11.464344] 8021q: adding VLAN 0 to HW filter on device lan3
[ 11.477469] mt7530 mdio-bus:00 lan3: Link is Up - 1Gbps/Full - flow control rx/tx
[ 11.489154] br-lan: port 3(lan3) entered blocking state
[ 11.494458] br-lan: port 3(lan3) entered disabled state
[ 11.507238] device lan3 entered promiscuous mode
[ 11.516590] br-lan: port 3(lan3) entered blocking state
[ 11.521838] br-lan: port 3(lan3) entered forwarding state
[ 11.527426] IPv6: ADDRCONF(NETDEV_CHANGE): br-lan: link becomes ready
[ 11.539795] mt7530 mdio-bus:00 lan4: configuring for phy/gmii link mode
[ 11.552808] 8021q: adding VLAN 0 to HW filter on device lan4
[ 11.571088] mt7530 mdio-bus:00 lan4: Link is Up - 1Gbps/Full - flow control rx/tx
[ 11.582120] br-lan: port 4(lan4) entered blocking state
[ 11.587425] br-lan: port 4(lan4) entered disabled state
[ 11.613290] device lan4 entered promiscuous mode
[ 11.629056] br-lan: port 4(lan4) entered blocking state
[ 11.634326] br-lan: port 4(lan4) entered forwarding state
[ 11.648867] mt7530 mdio-bus:00 wan: configuring for phy/gmii link mode
[ 11.663117] 8021q: adding VLAN 0 to HW filter on device wan
[ 11.675164] mt7530 mdio-bus:00 wan: Link is Up - 1Gbps/Full - flow control rx/tx
[ 11.685062] IPv6: ADDRCONF(NETDEV_CHANGE): wan: link becomes ready
[ 28.684221] mt7622-wmac 18000000.wmac: Message 00000010 (seq 1) timeout
[ 28.690854] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 28.914695] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 29.134635] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 29.354654] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 29.574639] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 29.794663] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 30.014687] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 30.234656] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 30.454626] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 30.674659] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 30.894631] mt7622-wmac 18000000.wmac: Failed to get patch semaphore
[ 31.697809] br-lan: port 5(wlan1) entered blocking state
[ 31.703141] br-lan: port 5(wlan1) entered disabled state
[ 31.708910] device wlan1 entered promiscuous mode
[ 31.713810] br-lan: port 5(wlan1) entered blocking state
[ 31.719308] br-lan: port 5(wlan1) entered forwarding state
[ 31.734455] br-lan: port 5(wlan1) entered disabled state
[ 32.587400] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready
[ 32.594069] br-lan: port 5(wlan1) entered blocking state
[ 32.599470] br-lan: port 5(wlan1) entered forwarding state
[ 474.489954] mt7530 mdio-bus:00 lan1: Link is Up - 1Gbps/Full - flow control rx/tx
[ 474.497505] br-lan: port 1(lan1) entered blocking state
[ 474.502787] br-lan: port 1(lan1) entered forwarding state
[ 484.148763] mt7530 mdio-bus:00 lan1: Link is Down
[ 484.153951] br-lan: port 1(lan1) entered disabled state
[ 486.840593] mt7530 mdio-bus:00 lan1: Link is Up - 1Gbps/Full - flow control rx/tx
[ 486.848174] br-lan: port 1(lan1) entered blocking state
[ 486.853445] br-lan: port 1(lan1) entered forwarding state
[18235.225429] mt7530 mdio-bus:00 lan4: Link is Down
[18235.230989] br-lan: port 4(lan4) entered disabled state
[18236.781576] mt7530 mdio-bus:00 lan4: Link is Up - 10Mbps/Full - flow control off
[18236.789076] br-lan: port 4(lan4) entered blocking state
[18236.794319] br-lan: port 4(lan4) entered forwarding state
[55356.350182] mt7530 mdio-bus:00 lan4: Link is Down
[55356.355796] br-lan: port 4(lan4) entered disabled state
[55358.710511] mt7530 mdio-bus:00 lan4: Link is Up - 1Gbps/Full - flow control rx/tx
[55358.718356] br-lan: port 4(lan4) entered blocking state
[55358.723598] br-lan: port 4(lan4) entered forwarding state