Ath10k Wi-Fi 2.g band not coming up first boot and dropping during operation

Hi, I have a Wallystech dr4029 and the WI-FI on radio 0 2.5g band won't come up on first boot after a software upgrade, in subsequent boots it does or disabling and enabling the interface after boot makes it work also.

it looks like in the log it is up temporally during first boot but bring up of the inter interfaces cause reset and it fails later on.
It has had the same issue in my last few builds and started on builds after the 24 of march before that is had no issues.

Mon Apr 15 23:27:07 2024 daemon.err hostapd: Interface initialization failed
Mon Apr 15 23:27:07 2024 daemon.notice hostapd: Adults_2.5G: interface state COUNTRY_UPDATE->DISABLED
Mon Apr 15 23:27:07 2024 daemon.notice hostapd: Adults_2.5G: AP-DISABLED
Mon Apr 15 23:27:07 2024 daemon.err hostapd: Adults_2.5G: Unable to setup interface.
Mon Apr 15 23:27:07 2024 daemon.notice hostapd: nl80211: deinit ifname=Adults_2.5G disabled_11b_rates=0
Mon Apr 15 23:27:07 2024 kern.info kernel: [   56.781580] device Adults_2.5G left promiscuous mode
Mon Apr 15 23:27:07 2024 kern.info kernel: [   56.781775] br-adults_lan: port 2(Adults_2.5G) entered disabled state
Mon Apr 15 23:27:07 2024 kern.info kernel: [   56.832224] ath10k_ahb a000000.wifi: mac flush null vif, drop 0 queues 0xffff
Mon Apr 15 23:27:07 2024 daemon.info ModemManager[6040]: hotplug: remove network interface br-kids_lan: event processed
Mon Apr 15 23:27:07 2024 kern.warn kernel: [   56.891962] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 0
Mon Apr 15 23:27:07 2024 kern.warn kernel: [   56.892031] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 0
Mon Apr 15 23:27:07 2024 daemon.err hostapd: rmdir[ctrl_interface=/var/run/hostapd]: Permission denied
Mon Apr 15 23:27:07 2024 daemon.notice hostapd: Adults_2.5G: CTRL-EVENT-TERMINATING
Mon Apr 15 23:27:07 2024 daemon.err hostapd: hostapd_free_hapd_data: Interface Adults_2.5G wasn't started
Mon Apr 15 23:27:07 2024 daemon.err hostapd: rmdir[ctrl_interface=/var/run/hostapd]: Permission denied
Mon Apr 15 23:27:07 2024 daemon.notice hostapd: Kids_2.5g: CTRL-EVENT-TERMINATING
Mon Apr 15 23:27:07 2024 daemon.err hostapd: hostapd_free_hapd_data: Interface Kids_2.5g wasn't started
Mon Apr 15 23:27:07 2024 daemon.notice hostapd: hostapd.add_iface failed for phy phy0 ifname=Adults_2.5G
Mon Apr 15 23:27:07 2024 daemon.notice [4241]: <msg> [base-manager] couldn't check support for device '/sys/devices/platform/soc/a800000.wifi': not supported by any plugin
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: started, version 2.90 cachesize 150
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: UBus support enabled: connected to system bus
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.1.100 -- 192.168.1.249, lease time 12h
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq-dhcp[1]: DHCP, sockets bound exclusively to interface br-adults_lan
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: using nameserver 8.8.8.8#53
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: using only locally-known addresses for adults_lan
Mon Apr 15 23:27:07 2024 daemon.warn dnsmasq[1]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns.5893 - 0 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:07 2024 daemon.warn netifd: Wireless device 'radio1' setup failed, retry=3
Mon Apr 15 23:27:07 2024 daemon.warn netifd: Wireless device 'radio0' setup failed, retry=3
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns.5893 - 0 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:07 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: started, version 2.90 cachesize 150
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: UBus support enabled: connected to system bus
Mon Apr 15 23:27:08 2024 daemon.warn dnsmasq[1]: warning: interface br-kids_lan does not currently exist
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.2.100 -- 192.168.2.249, lease time 12h
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: using nameserver 8.8.8.8#53
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: using only locally-known addresses for kids_lan
Mon Apr 15 23:27:08 2024 daemon.warn dnsmasq[1]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns.5893 - 0 names
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:08 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:08 2024 daemon.notice wpa_supplicant[2553]: Set new config for phy phy0
Mon Apr 15 23:27:08 2024 daemon.info ModemManager[6120]: hotplug: add network interface br-kids_lan: event processed
Mon Apr 15 23:27:08 2024 daemon.info ModemManager[6196]: hotplug: remove network interface Adults_2.5G: event processed
Mon Apr 15 23:27:09 2024 daemon.notice netifd: radio0 (6116): Command failed: Not found
Mon Apr 15 23:27:09 2024 daemon.notice netifd: Wireless device 'radio0' is now down
Mon Apr 15 23:27:09 2024 daemon.notice netifd: Interface 'kids_lan' is enabled
Mon Apr 15 23:27:09 2024 daemon.notice netifd: Interface 'kids_lan' is setting up now
Mon Apr 15 23:27:09 2024 daemon.notice netifd: Interface 'kids_lan' is now up
Mon Apr 15 23:27:09 2024 daemon.notice netifd: wan (4608): udhcpc: broadcasting discover
Mon Apr 15 23:27:09 2024 daemon.notice netifd: radio0 (6255): WARNING: Variable 'data' does not exist or is not an array/object
Mon Apr 15 23:27:09 2024 daemon.info [4241]: <inf> [modem0] SIM hot swap setup succeeded
Mon Apr 15 23:27:10 2024 daemon.notice hostapd: Set new config for phy phy0:
Mon Apr 15 23:27:10 2024 user.notice mwan3-hotplug[6254]: mwan3 hotplug on loopback not called because interface disabled
Mon Apr 15 23:27:10 2024 daemon.notice wpa_supplicant[2553]: Set new config for phy phy0
Mon Apr 15 23:27:11 2024 daemon.notice wpa_supplicant[2553]: Set new config for phy phy0
Mon Apr 15 23:27:11 2024 daemon.notice hostapd: Set new config for phy phy0: /var/run/hostapd-phy0.conf
Mon Apr 15 23:27:11 2024 daemon.notice hostapd: Restart interface for phy phy0
Mon Apr 15 23:27:11 2024 user.notice nlbwmon: Reloading nlbwmon due to ifup of loopback (lo)
Mon Apr 15 23:27:12 2024 daemon.notice hostapd: Configuration file: data: driver=nl80211 logger_syslog=127 logger_syslog_level=4 logger_stdout=127 logger_stdout_level=4 country_code=NZ ieee80211d=1 hw_mode=g supported_rates=60 90 120 180 240 360 480 540 basic_rates=60 120 240 beacon_int=100 chanlist=11 #num_global_macaddr=1 ieee80211n=1 ht_coex=0 ht_capab=[LDPC][SHORT-GI-20][SHORT-GI-40][TX-STBC][RX-STBC1][MAX-AMSDU-7935][DSSS_CCK-40] channel=11  interface=Adults_2.5G bssid=c4:4b:d1:00:47:4e ctrl_interface=/var/run/hostapd ap_isolate=1 bss_load_update_period=60 chan_util_avg_period=600 disassoc_low_ack=1 skip_inactivity_poll=0 preamble=1 wmm_enabled=1 ignore_broadcast_ssid=0 uapsd_advertisement_enabled=1 utf8_ssid=1 multi_ap=0 nas_identifier=adult wpa_passphrase=asdf1234 wpa_psk_file=/var/run/hostapd-Adults_2.5G.psk auth_algs=1 wpa=2 wpa_pairwise=CCMP ssid=Adults_2.5g bridge=br-adults_lan wds_bridge= snoop_iface=br-adults_lan time_advertisement=2 time_zone=NZST-12NZDT,M9.5.0,M4.1.0/3 wnm_sleep_mode=1 wnm_sleep_mode_no_keys=1 b
Mon Apr 15 23:27:12 2024 daemon.notice netifd: Wireless device 'radio0' is now up
Mon Apr 15 23:27:12 2024 daemon.info ModemManager[7068]: hotplug: add network interface Adults_2.5G: event processed
Mon Apr 15 23:27:12 2024 daemon.err uhttpd[3702]: [info] luci: accepted login on /admin/network/wireless for root from 192.168.1.10
Mon Apr 15 23:27:13 2024 kern.warn kernel: [   63.215040] ath10k_ahb a000000.wifi: 10.4 wmi init: vdevs: 16  peers: 48  tid: 96
Mon Apr 15 23:27:13 2024 kern.warn kernel: [   63.215115] ath10k_ahb a000000.wifi: msdu-desc: 2500  skid: 32
Mon Apr 15 23:27:13 2024 kern.info kernel: [   63.261725] ath10k_ahb a000000.wifi: wmi print 'P 48/48 V 16 K 144 PH 176 T 186  msdu-desc: 2500  sw-crypt: 0 ct-sta: 0'
Mon Apr 15 23:27:13 2024 kern.info kernel: [   63.262580] ath10k_ahb a000000.wifi: wmi print 'free: 53268 iram: 13704 sram: 35752'
Mon Apr 15 23:27:13 2024 kern.info kernel: [   63.616978] ath10k_ahb a000000.wifi: rts threshold -1
Mon Apr 15 23:27:13 2024 kern.warn kernel: [   63.617453] ath10k_ahb a000000.wifi: Firmware lacks feature flag indicating a retry limit of > 2 is OK, requested limit: 4
Mon Apr 15 23:27:13 2024 kern.info kernel: [   63.625790] br-adults_lan: port 2(Adults_2.5G) entered blocking state
Mon Apr 15 23:27:13 2024 kern.info kernel: [   63.632063] br-adults_lan: port 2(Adults_2.5G) entered disabled state
Mon Apr 15 23:27:14 2024 kern.info kernel: [   63.638874] device Adults_2.5G entered promiscuous mode
Mon Apr 15 23:27:14 2024 daemon.notice hostapd: Adults_2.5G: interface state UNINITIALIZED->COUNTRY_UPDATE
Mon Apr 15 23:27:14 2024 daemon.notice netifd: Interface 'wan' is now up
Mon Apr 15 23:27:14 2024 daemon.notice netifd: wan (4608): udhcpc: broadcasting select for 192.168.0.100, server 192.168.0.1
Mon Apr 15 23:27:14 2024 daemon.notice netifd: wan (4608): udhcpc: lease of 192.168.0.100 obtained from 192.168.0.1, lease time 86400
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.194825] IPv6: ADDRCONF(NETDEV_CHANGE): Adults_2.5G: link becomes ready
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.195183] br-adults_lan: port 2(Adults_2.5G) entered blocking state
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.200705] br-adults_lan: port 2(Adults_2.5G) entered forwarding state
Mon Apr 15 23:27:14 2024 daemon.notice netifd: Network device 'Adults_2.5G' link is up
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.316108] br-kids_lan: port 1(Kids_2.5g) entered blocking state
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.316189] br-kids_lan: port 1(Kids_2.5g) entered disabled state
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.321797] device Kids_2.5g entered promiscuous mode
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.342036] ath10k_ahb a000000.wifi: rts threshold -1
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.346231] br-kids_lan: port 1(Kids_2.5g) entered blocking state
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.346325] br-kids_lan: port 1(Kids_2.5g) entered forwarding state
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.352648] IPv6: ADDRCONF(NETDEV_CHANGE): br-kids_lan: link becomes ready
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.360133] device Kids_2.5g left promiscuous mode
Mon Apr 15 23:27:14 2024 kern.info kernel: [   64.365438] br-kids_lan: port 1(Kids_2.5g) entered disabled state
Mon Apr 15 23:27:14 2024 daemon.notice netifd: Interface 'kids_lan' is now down
Mon Apr 15 23:27:14 2024 daemon.info ModemManager[7426]: hotplug: add network interface Kids_2.5g: event processed
Mon Apr 15 23:27:15 2024 daemon.err hostapd: l2_packet_init: ioctl[SIOCGIFHWADDR]: No such device
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' is disabled
Mon Apr 15 23:27:15 2024 kern.info kernel: [   64.734655] br-kids_lan: port 1(Kids_2.5g) entered blocking state
Mon Apr 15 23:27:15 2024 kern.info kernel: [   64.734724] br-kids_lan: port 1(Kids_2.5g) entered disabled state
Mon Apr 15 23:27:15 2024 kern.info kernel: [   64.740247] device Kids_2.5g entered promiscuous mode
Mon Apr 15 23:27:15 2024 daemon.err hostapd: Neighbor Discovery snooping initialization failed
Mon Apr 15 23:27:15 2024 daemon.info ModemManager[7504]: hotplug: remove network interface br-kids_lan: event processed
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: exiting on receipt of SIGTERM
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: exiting on receipt of SIGTERM
Mon Apr 15 23:27:15 2024 kern.warn kernel: [   64.832309] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 1
Mon Apr 15 23:27:15 2024 kern.info kernel: [   64.902289] device Kids_2.5g left promiscuous mode
Mon Apr 15 23:27:15 2024 kern.info kernel: [   64.902378] br-kids_lan: port 1(Kids_2.5g) entered disabled state
Mon Apr 15 23:27:15 2024 user.notice https-dns-proxy: Restarting dnsmasq on_config_update βœ“
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' is enabled
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' is setting up now
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' is now up
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: started, version 2.90 cachesize 150
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: UBus support enabled: connected to system bus
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: started, version 2.90 cachesize 150
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.1.100 -- 192.168.1.249, lease time 12h
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: UBus support enabled: connected to system bus
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq-dhcp[1]: DHCP, sockets bound exclusively to interface br-adults_lan
Mon Apr 15 23:27:15 2024 daemon.warn dnsmasq[1]: warning: interface br-kids_lan does not currently exist
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.2.100 -- 192.168.2.249, lease time 12h
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: using nameserver 127.0.0.1#5054
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: using nameserver 127.0.0.1#5053
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: using only locally-known addresses for adults_lan
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: using nameserver 127.0.0.1#5054
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: using nameserver 127.0.0.1#5053
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: using only locally-known addresses for kids_lan
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns.6564 - 0 names
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' is now down
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns.6564 - 0 names
Mon Apr 15 23:27:15 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:15 2024 user.notice mwan3-hotplug[7277]: mwan3 hotplug on kids_lan not called because interface disabled
Mon Apr 15 23:27:15 2024 daemon.info ModemManager[7603]: hotplug: add network interface br-kids_lan: event processed
Mon Apr 15 23:27:15 2024 user.notice https-dns-proxy: Setting service raw_trigger for 'interface.*.up'βœ“
Mon Apr 15 23:27:15 2024 daemon.notice hostapd: nl80211: Failed to remove interface Kids_2.5g from bridge br-kids_lan: No such device
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' is disabled
Mon Apr 15 23:27:15 2024 daemon.notice netifd: bridge 'br-kids_lan' link is up
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' has link connectivity
Mon Apr 15 23:27:15 2024 daemon.notice netifd: bridge 'br-kids_lan' link is down
Mon Apr 15 23:27:15 2024 daemon.notice netifd: Interface 'kids_lan' has link connectivity loss
Mon Apr 15 23:27:15 2024 daemon.info ModemManager[7695]: hotplug: remove network interface Kids_2.5g: event processed
Mon Apr 15 23:27:15 2024 daemon.err hostapd: Interface initialization failed
Mon Apr 15 23:27:15 2024 daemon.notice hostapd: Adults_2.5G: interface state COUNTRY_UPDATE->DISABLED
Mon Apr 15 23:27:15 2024 daemon.notice hostapd: Adults_2.5G: AP-DISABLED
Mon Apr 15 23:27:15 2024 daemon.err hostapd: Adults_2.5G: Unable to setup interface.
Mon Apr 15 23:27:15 2024 daemon.notice hostapd: nl80211: deinit ifname=Adults_2.5G disabled_11b_rates=0
Mon Apr 15 23:27:15 2024 kern.info kernel: [   65.527260] device Adults_2.5G left promiscuous mode
Mon Apr 15 23:27:15 2024 kern.info kernel: [   65.527516] br-adults_lan: port 2(Adults_2.5G) entered disabled state
Mon Apr 15 23:27:15 2024 daemon.notice [4241]: <msg> [base-manager] port Kids_2.5g released by device '/sys/devices/platform/soc/a000000.wifi'
Mon Apr 15 23:27:15 2024 daemon.warn [4241]: <wrn> [plugin-manager] task 3,Kids_2.5g: failed: Operation was cancelled
Mon Apr 15 23:27:15 2024 kern.info kernel: [   65.607509] ath10k_ahb a000000.wifi: mac flush null vif, drop 0 queues 0xffff
Mon Apr 15 23:27:16 2024 daemon.info ModemManager[7831]: hotplug: remove network interface br-kids_lan: event processed
Mon Apr 15 23:27:16 2024 kern.warn kernel: [   65.652012] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 0
Mon Apr 15 23:27:16 2024 kern.warn kernel: [   65.652161] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 0
Mon Apr 15 23:27:16 2024 daemon.err hostapd: rmdir[ctrl_interface=/var/run/hostapd]: Permission denied
Mon Apr 15 23:27:16 2024 daemon.notice hostapd: Adults_2.5G: CTRL-EVENT-TERMINATING
Mon Apr 15 23:27:16 2024 daemon.err hostapd: hostapd_free_hapd_data: Interface Adults_2.5G wasn't started
Mon Apr 15 23:27:16 2024 daemon.err hostapd: rmdir[ctrl_interface=/var/run/hostapd]: Permission denied
Mon Apr 15 23:27:16 2024 daemon.notice hostapd: Kids_2.5g: CTRL-EVENT-TERMINATING
Mon Apr 15 23:27:16 2024 daemon.err hostapd: hostapd_free_hapd_data: Interface Kids_2.5g wasn't started
Mon Apr 15 23:27:16 2024 daemon.notice hostapd: hostapd.add_iface failed for phy phy0 ifname=Adults_2.5G
Mon Apr 15 23:27:16 2024 daemon.notice netifd: Network device 'Adults_2.5G' link is down
Mon Apr 15 23:27:16 2024 user.notice firewall: Reloading firewall due to ifup of kids_lan (br-kids_lan)
Mon Apr 15 23:27:16 2024 daemon.info dnsmasq[1]: exiting on receipt of SIGTERM
Mon Apr 15 23:27:16 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:16 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:16 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:16 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:17 2024 daemon.err procd: Got unexpected signal 1
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: started, version 2.90 cachesize 150
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: UBus support enabled: connected to system bus
Mon Apr 15 23:27:17 2024 daemon.warn dnsmasq[1]: warning: interface br-kids_lan does not currently exist
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.2.100 -- 192.168.2.249, lease time 12h
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: using nameserver 127.0.0.1#5054
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: using nameserver 127.0.0.1#5053
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: using only locally-known addresses for kids_lan
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:17 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:18 2024 daemon.info [4241]: <inf> [modem0] retrying (5/7) unlock required check
Mon Apr 15 23:27:18 2024 daemon.notice [4241]: <msg> [base-manager] couldn't check support for device '/sys/devices/platform/soc/a000000.wifi': not supported by any plugin
Mon Apr 15 23:27:19 2024 daemon.notice netifd: Wireless device 'radio1' is now down
Mon Apr 15 23:27:19 2024 kern.info kernel: [   68.933203] device Adults_5g left promiscuous mode
Mon Apr 15 23:27:19 2024 kern.info kernel: [   68.933450] br-adults_lan: port 3(Adults_5g) entered disabled state
Mon Apr 15 23:27:19 2024 daemon.notice netifd: Interface 'kids_lan' is enabled
Mon Apr 15 23:27:19 2024 daemon.notice netifd: Interface 'kids_lan' is setting up now
Mon Apr 15 23:27:19 2024 daemon.notice netifd: Interface 'kids_lan' is now up
Mon Apr 15 23:27:19 2024 user.notice nlbwmon: Reloading nlbwmon due to ifup of kids_lan (br-kids_lan)
Mon Apr 15 23:27:19 2024 daemon.info ModemManager[8505]: hotplug: add network interface br-kids_lan: event processed
Mon Apr 15 23:27:19 2024 daemon.notice netifd: radio1 (8506): WARNING: Variable 'data' does not exist or is not an array/object
Mon Apr 15 23:27:19 2024 daemon.notice miniupnpd[8420]: perform_stun: #0 external address or port changed
Mon Apr 15 23:27:19 2024 daemon.notice miniupnpd[8420]: perform_stun: #1 external address or port changed
Mon Apr 15 23:27:19 2024 daemon.notice miniupnpd[8420]: perform_stun: #2 external address or port changed
Mon Apr 15 23:27:19 2024 daemon.notice miniupnpd[8420]: perform_stun: #3 external address or port changed
Mon Apr 15 23:27:19 2024 daemon.warn miniupnpd[8420]: STUN: ext interface wan with private IP address 192.168.0.100 is now behind restrictive or symmetric NAT with public IP address 115.189.98.195 which does not support port forwarding
Mon Apr 15 23:27:19 2024 daemon.warn miniupnpd[8420]: NAT on upstream router blocks incoming connections set by miniupnpd
Mon Apr 15 23:27:19 2024 daemon.warn miniupnpd[8420]: Turn off NAT on upstream router or change it to full-cone NAT 1:1 type
Mon Apr 15 23:27:19 2024 daemon.warn miniupnpd[8420]: Port forwarding is now disabled
Mon Apr 15 23:27:19 2024 daemon.notice miniupnpd[8420]: HTTP listening on port 5000
Mon Apr 15 23:27:19 2024 daemon.warn miniupnpd[8420]: no HTTP IPv6 address, disabling IPv6
Mon Apr 15 23:27:19 2024 daemon.notice miniupnpd[8420]: Listening for NAT-PMP/PCP traffic on port 5351
Mon Apr 15 23:27:20 2024 daemon.notice hostapd: Set new config for phy phy1:
Mon Apr 15 23:27:20 2024 kern.warn kernel: [   70.241550] ath10k_ahb a800000.wifi: peer-unmap-event: unknown peer id 0
Mon Apr 15 23:27:20 2024 daemon.info ModemManager[8865]: hotplug: remove network interface Adults_5g: event processed
Mon Apr 15 23:27:20 2024 daemon.notice wpa_supplicant[2553]: Set new config for phy phy1
Mon Apr 15 23:27:21 2024 user.notice SQM: Stopping SQM on wan
Mon Apr 15 23:27:21 2024 daemon.info ModemManager[9053]: hotplug: remove network interface ifb4wan: event processed
Mon Apr 15 23:27:21 2024 user.notice SQM: Starting SQM script: piece_of_cake.qos on wan, in: 21000 Kbps, out: 12000 Kbps
Mon Apr 15 23:27:22 2024 daemon.info ModemManager[9272]: hotplug: add network interface SQM_IFB_640a6: event processed
Mon Apr 15 23:27:22 2024 daemon.info ModemManager[9358]: hotplug: remove network interface SQM_IFB_640a6: event processed
Mon Apr 15 23:27:22 2024 daemon.notice wpa_supplicant[2553]: Set new config for phy phy1
Mon Apr 15 23:27:22 2024 daemon.notice hostapd: Set new config for phy phy1: /var/run/hostapd-phy1.conf
Mon Apr 15 23:27:22 2024 daemon.notice hostapd: Restart interface for phy phy1
Mon Apr 15 23:27:22 2024 daemon.info ModemManager[9425]: hotplug: add network interface SQM_IFB_988f1: event processed
Mon Apr 15 23:27:22 2024 daemon.info ModemManager[9527]: hotplug: remove network interface SQM_IFB_988f1: event processed
Mon Apr 15 23:27:22 2024 daemon.info procd: - init complete -
Mon Apr 15 23:27:22 2024 daemon.info ModemManager[9584]: hotplug: add network interface ifb4wan: event processed
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1130] N: ttyd 1.7.3 (libwebsockets 4.3.2-unknown)
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1133] N: tty configuration:
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1137] N:   start command: /bin/login
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1141] N:   close signal: SIGHUP (1)
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1145] N:   terminal type: xterm-256color
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1262] N:    /usr/lib/libwebsockets-evlib_uv.so
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1268] N: lws_create_context: LWS: 4.3.2-unknown, NET CLI SRV H1 H2 WS ConMon IPV6-off
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1278] N: elops_init_pt_uv:  Using foreign event loop...
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1283] N: __lws_lc_tag:  ++ [wsi|0|pipe] (1)
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1287] N: __lws_lc_tag:  ++ [vh|0|netlink] (1)
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1293] N: __lws_lc_tag:  ++ [vh|1|default||7681] (2)
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1298] N: [vh|1|default||7681]: lws_socket_bind: source ads 0.0.0.0
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1302] N: __lws_lc_tag:  ++ [wsi|1|listen|default||7681] (2)
Mon Apr 15 23:27:23 2024 daemon.notice ttyd[9469]: [2024/04/15 23:27:23:1305] N:  Listening on port: 7681
Mon Apr 15 23:27:23 2024 user.notice SQM: piece_of_cake.qos was started on wan successfully
Mon Apr 15 23:27:23 2024 daemon.info ModemManager[9702]: hotplug: add network interface SQM_IFB_0b734: event processed
Mon Apr 15 23:27:23 2024 daemon.info ModemManager[9785]: hotplug: remove network interface SQM_IFB_0b734: event processed
Mon Apr 15 23:27:23 2024 daemon.notice hostapd: Configuration file: data: driver=nl80211 logger_syslog=127 logger_syslog_level=4 logger_stdout=127 logger_stdout_level=4 country_code=NZ ieee80211d=1 ieee80211h=1 hw_mode=a beacon_int=100 chanlist=36 tx_queue_data2_burst=2.0 #num_global_macaddr=1 ieee80211n=1 ht_coex=0 ht_capab=[HT40+][LDPC][SHORT-GI-20][SHORT-GI-40][TX-STBC][RX-STBC1][MAX-AMSDU-7935][DSSS_CCK-40] ieee80211ac=1 vht_oper_chwidth=1 vht_oper_centr_freq_seg0_idx=42 vht_capab=[RXLDPC][SHORT-GI-80][TX-STBC-2BY1][SU-BEAMFORMER][SU-BEAMFORMEE][MU-BEAMFORMER][MU-BEAMFORMEE][RX-ANTENNA-PATTERN][TX-ANTENNA-PATTERN][RX-STBC-1][SOUNDING-DIMENSION-2][BF-ANTENNA-3][MAX-MPDU-11454][MAX-A-MPDU-LEN-EXP7] channel=36  interface=Adults_5g bssid=c4:4b:d1:00:47:4f ctrl_interface=/var/run/hostapd ap_isolate=1 bss_load_update_period=60 chan_util_avg_period=600 disassoc_low_ack=1 skip_inactivity_poll=0 preamble=1 wmm_enabled=1 ignore_broadcast_ssid=0 uapsd_advertisement_enabled=1 utf8_ssid=1 multi_ap=0 nas_identifier=adult wpa_passphrase=
Mon Apr 15 23:27:23 2024 daemon.notice netifd: Wireless device 'radio1' is now up
Mon Apr 15 23:27:23 2024 daemon.info ModemManager[9826]: hotplug: add network interface Adults_5g: event processed
Mon Apr 15 23:27:23 2024 user.notice mwan3-hotplug[8783]: Execute ifup event on interface wan (wan)
Mon Apr 15 23:27:24 2024 daemon.notice [4241]: <msg> [modem0] state changed (unknown -> locked)
Mon Apr 15 23:27:24 2024 daemon.warn [4241]: <wrn> [modem0] modem couldn't be initialized: Couldn't check unlock status: QMI operation failed: GW primary session index unknown
Mon Apr 15 23:27:24 2024 daemon.notice [4241]: <msg> [modem0] state changed (locked -> failed)
Mon Apr 15 23:27:24 2024 daemon.warn [4241]: <wrn> [modem0] error initializing: Modem in failed state: sim-missing
Mon Apr 15 23:27:24 2024 kern.warn kernel: [   74.485268] ath10k_ahb a800000.wifi: 10.4 wmi init: vdevs: 16  peers: 48  tid: 96
Mon Apr 15 23:27:24 2024 kern.warn kernel: [   74.485339] ath10k_ahb a800000.wifi: msdu-desc: 2500  skid: 32
Mon Apr 15 23:27:24 2024 kern.info kernel: [   74.532346] ath10k_ahb a800000.wifi: wmi print 'P 48/48 V 16 K 144 PH 176 T 186  msdu-desc: 2500  sw-crypt: 0 ct-sta: 0'
Mon Apr 15 23:27:24 2024 kern.info kernel: [   74.533209] ath10k_ahb a800000.wifi: wmi print 'free: 53268 iram: 13704 sram: 35752'
Mon Apr 15 23:27:25 2024 daemon.info dnsmasq[1]: exiting on receipt of SIGTERM
Mon Apr 15 23:27:25 2024 daemon.info dnsmasq[1]: read /etc/hosts - 12 names
Mon Apr 15 23:27:25 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.adults_dns - 21 names
Mon Apr 15 23:27:25 2024 daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.kids_dns - 14 names
Mon Apr 15 23:27:25 2024 daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses
Mon Apr 15 23:27:25 2024 daemon.err procd: Got unexpected signal 1
Mon Apr 15 23:27:25 2024 kern.info kernel: [   74.848889] ath10k_ahb a800000.wifi: rts threshold -1

Few lines earlier it talks causes of failure.
What is in /etc/config/wireless /etc/config/network ?

All my configs are here but none of them have changed.
I checked that the config's were not altered after a reboot or a disable and enable interface.

pj_openwrt/files/etc/config at master Β· professor-jonny/pj_openwrt (github.com)

Not a single mistake in configs. Usteer highly recommended.
Try to rise wpad log level and global log size and get events around first attempt to start 2ghz radio.

Thanks Ill try change the log level and see if it come up with any more indications.

As for Usteer, I did have DAWN setup before as it has a LUCI config app that is easier to play with.
Dawn spammed the logs quite badly and obscured everything else even on the lowest log level so out it went a while ago.

Rationale that you dont need heap of roaming protocols if you dont use them, just side note, not related to problem at hand.

Interestingly - does error messages change swapping ath10k-ct for ath10k and vice versa (2 packages - driver and firmware, board- package remains unchanged)

Ill try, but I found the CT driver to work better for me but it might be anecdotal.

1 Like

I wonder how was other worse if total fail is better...

I did find the CT version to not work with some of the Xbox 360 slim consoles.
I believe there is a bug as some wireless adaptor models has issues obtaining a IP address unless it was forced into legacy mode.
I actually found many other forum posts on the net about this same issue with and i come to the conclusion it was only with ath10k chipsets and the Xbox 360.

I actually filed a bug with Ben Greear (candellatech) and they confirmed it was likely an issue with power-save or block-ack not being supported properly on the 360 and was suggested to try another driver or chipset as was unlikely he would fix it.
He did say that I would have to supply monitor-port RF packet capture.
sadly, I don't have a device capable of doing this.

It was more like tongue in cheek joke, like what can be worse than no connection at all :wink:

1 Like

I set the wpad level to 2 in my build environment then built an image with the wpad level at 4 (no other changes just editing the files in etc/config)

I tried each image fresh (sysupgrade) and it boots and the WI-FI on radio0 comes up with wpad level at 4 but not at 2, could it just be a timing issue or something?

Lower log levels log more, you need 1 for all crypto events or 0 for packet dumps in log.

The 2.4g did stop in the middle of the night last night but i dont know if below may offer any insight:

Fri Apr 19 23:04:29 2024 kern.warn kernel: [  154.515182] ath10k_ahb a000000.wifi: Invalid VHT mcs 15 peer stats
Sat Apr 20 00:24:31 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 38:8a:06:a1:81:c6
Sat Apr 20 00:24:31 2024 kern.info kernel: [ 1536.332916] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 00:24:32 2024 user.info usteer: station 38:8a:06:a1:81:c6 disconnected from node hostapd.Adults_2.5G
Sat Apr 20 00:25:06 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-CONNECTED 38:8a:06:a1:81:c6 auth_alg=open
Sat Apr 20 00:25:06 2024 daemon.notice hostapd: Adults_2.5G: EAPOL-4WAY-HS-COMPLETED 38:8a:06:a1:81:c6
Sat Apr 20 01:01:00 2024 daemon.notice hostapd: Adults_5g: AP-STA-DISCONNECTED 3a:0e:8b:4c:df:d3
Sat Apr 20 01:01:00 2024 kern.info kernel: [ 3725.403783] ath10k_ahb a800000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 01:01:01 2024 user.info usteer: station 3a:0e:8b:4c:df:d3 disconnected from node hostapd.Adults_5g
Sat Apr 20 01:01:07 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-CONNECTED 18:5b:b3:0e:0d:d0 auth_alg=open
Sat Apr 20 01:01:07 2024 daemon.notice hostapd: Adults_2.5G: EAPOL-4WAY-HS-COMPLETED 18:5b:b3:0e:0d:d0
Sat Apr 20 05:24:00 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-CONNECTED 1c:f8:d0:c3:20:b5 auth_alg=open
Sat Apr 20 05:24:00 2024 daemon.notice hostapd: Adults_2.5G: EAPOL-4WAY-HS-COMPLETED 1c:f8:d0:c3:20:b5
Sat Apr 20 06:21:00 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 1c:f8:d0:c3:20:b5
Sat Apr 20 06:21:00 2024 user.info usteer: station 1c:f8:d0:c3:20:b5 disconnected from node hostapd.Adults_2.5G
Sat Apr 20 06:21:02 2024 kern.info kernel: [22926.486012] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 06:28:48 2024 daemon.info hostapd: Kids_2.5g: STA c2:d3:b8:df:1e:6a IEEE 802.11: authenticated
Sat Apr 20 06:28:48 2024 daemon.info hostapd: Kids_2.5g: STA c2:d3:b8:df:1e:6a IEEE 802.11: associated (aid 1)
Sat Apr 20 06:28:48 2024 daemon.notice hostapd: Kids_2.5g: AP-STA-CONNECTED c2:d3:b8:df:1e:6a auth_alg=open
Sat Apr 20 06:28:48 2024 daemon.info hostapd: Kids_2.5g: STA c2:d3:b8:df:1e:6a RADIUS: starting accounting session 407BDF60E85D1E14
Sat Apr 20 06:34:07 2024 daemon.notice hostapd: Kids_2.5g: AP-STA-DISCONNECTED c2:d3:b8:df:1e:6a
Sat Apr 20 06:34:07 2024 daemon.info hostapd: Kids_2.5g: STA c2:d3:b8:df:1e:6a IEEE 802.11: disassociated due to inactivity
Sat Apr 20 06:34:08 2024 user.info usteer: station c2:d3:b8:df:1e:6a disconnected from node hostapd.Kids_2.5g
Sat Apr 20 06:34:08 2024 daemon.info hostapd: Kids_2.5g: STA c2:d3:b8:df:1e:6a IEEE 802.11: deauthenticated due to inactivity (timer DEAUTH/REMOVE)
Sat Apr 20 06:34:08 2024 kern.info kernel: [23713.029131] ath10k_ahb a000000.wifi: mac flush vdev 1 drop 0 queues 0x2 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:16:04 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 38:8a:06:a1:81:c6
Sat Apr 20 08:16:04 2024 kern.info kernel: [29828.965496] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:16:05 2024 user.info usteer: station 38:8a:06:a1:81:c6 disconnected from node hostapd.Adults_2.5G
Sat Apr 20 08:16:46 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-CONNECTED 38:8a:06:a1:81:c6 auth_alg=open
Sat Apr 20 08:16:46 2024 daemon.notice hostapd: Adults_2.5G: EAPOL-4WAY-HS-COMPLETED 38:8a:06:a1:81:c6
Sat Apr 20 08:24:07 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 1c:d6:be:79:7c:47
Sat Apr 20 08:24:07 2024 kern.info kernel: [30311.414618] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:07 2024 user.info usteer: station 1c:d6:be:79:7c:47 disconnected from node hostapd.Adults_2.5G
Sat Apr 20 08:24:10 2024 daemon.notice hostapd: Adults_5g: STA-OPMODE-N_SS-CHANGED 1c:d6:be:79:7c:47 2
Sat Apr 20 08:24:10 2024 daemon.notice hostapd: Adults_2.5G: Prune association for 1c:d6:be:79:7c:47
Sat Apr 20 08:24:10 2024 daemon.notice hostapd: Adults_5g: AP-STA-CONNECTED 1c:d6:be:79:7c:47 auth_alg=open
Sat Apr 20 08:24:10 2024 daemon.notice hostapd: Adults_5g: EAPOL-4WAY-HS-COMPLETED 1c:d6:be:79:7c:47
Sat Apr 20 08:24:13 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 08:38:e6:35:2e:19
Sat Apr 20 08:24:13 2024 user.info usteer: station 08:38:e6:35:2e:19 disconnected from node hostapd.Adults_2.5G
Sat Apr 20 08:24:14 2024 kern.info kernel: [30318.284477] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:14 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 38:8a:06:a1:81:c6
Sat Apr 20 08:24:14 2024 user.info usteer: station 38:8a:06:a1:81:c6 disconnected from node hostapd.Adults_2.5G
Sat Apr 20 08:24:15 2024 daemon.notice hostapd: Adults_5g: AP-STA-DISCONNECTED e0:aa:96:57:4a:08
Sat Apr 20 08:24:16 2024 kern.info kernel: [30320.124517] ath10k_ahb a800000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:16 2024 kern.info kernel: [30320.674418] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:16 2024 user.info usteer: station e0:aa:96:57:4a:08 disconnected from node hostapd.Adults_5g
Sat Apr 20 08:24:22 2024 daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 18:5b:b3:0e:0d:d0
Sat Apr 20 08:24:22 2024 kern.info kernel: [30326.924271] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:22 2024 user.info usteer: station 18:5b:b3:0e:0d:d0 disconnected from node hostapd.Adults_2.5G
Sat Apr 20 08:24:27 2024 daemon.notice hostapd: Adults_5g: AP-STA-CONNECTED b2:c5:ed:93:df:f5 auth_alg=open
Sat Apr 20 08:24:27 2024 daemon.notice hostapd: Adults_5g: EAPOL-4WAY-HS-COMPLETED b2:c5:ed:93:df:f5
Sat Apr 20 08:24:40 2024 kern.info kernel: [30344.713870] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:40 2024 kern.info kernel: [30344.933855] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:41 2024 kern.info kernel: [30345.303853] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:42 2024 kern.info kernel: [30346.943832] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:43 2024 kern.info kernel: [30347.903803] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:47 2024 kern.info kernel: [30351.773700] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:47 2024 kern.info kernel: [30351.853691] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:24:48 2024 kern.info kernel: [30352.343707] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:25:14 2024 kern.info kernel: [30378.353091] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:25:14 2024 kern.info kernel: [30378.853089] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:25:15 2024 kern.info kernel: [30379.073076] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:13 2024 kern.info kernel: [30437.581756] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:14 2024 kern.info kernel: [30438.061749] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:18 2024 kern.info kernel: [30442.811651] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:18 2024 kern.info kernel: [30442.891640] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:19 2024 kern.info kernel: [30443.281643] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:19 2024 kern.info kernel: [30443.321675] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:19 2024 daemon.notice hostapd: handle_assoc_cb: STA 18:5b:b3:0e:0d:d0 not found
Sat Apr 20 08:26:19 2024 kern.info kernel: [30443.661641] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:26:19 2024 daemon.notice hostapd: handle_assoc_cb: STA 18:5b:b3:0e:0d:d0 not found
Sat Apr 20 08:26:28 2024 daemon.notice hostapd: Adults_5g: AP-STA-CONNECTED e0:aa:96:57:4a:08 auth_alg=open
Sat Apr 20 08:26:28 2024 daemon.notice hostapd: Adults_5g: EAPOL-4WAY-HS-COMPLETED e0:aa:96:57:4a:08
Sat Apr 20 08:28:05 2024 kern.info kernel: [30549.949232] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:28:06 2024 kern.info kernel: [30550.049223] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
Sat Apr 20 08:28:14 2024 kern.info kernel: [30558.319042] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0

It is only occurence 2 clients were connected and one of them disconnected ?roamed?

Can you collect syslog remote with wire then grep disconnects focusing on numbers?

It feels like a call for driver+fw swap, but measure before and after.

I found more of those kernel info events and i found a forum post that sugested to switch to non CT firmware with a lot of these events in the system log and it all went away:

22.03.4+ and 21.02.6+ trigger increased system/kernel log events on Archer C7 v2/v4/v5 and some others - Installing and Using OpenWrt - OpenWrt Forum

Ill try with Non CT firmware and see what happens.

1 Like

Prep command in a text editor - remove 2 packages ; install 2, better wired since your wifi is not stable

I built from scratch and it seems to be all working without issue now, do I need to match the kernel driver with the firmware and board firmware? as I have the CT driver installed with the non CT firmware and board firmware I realized it after I built the image.

only new thing I see is mac flush kernel events after disassociation now and it does have a lot of chat in the log and it drowns out the rest of the stuff.

daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 3c:15:c2:d1:1c:e4
kern.info kernel: [12475.028458] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
user.info usteer: station 3c:15:c2:d1:1c:e4 disconnected from node hostapd.Adults_2.5G
kern.info kernel: [12545.464708] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
user.info usteer: station 3c:15:c2:d1:1c:e4 disconnected from node hostapd.Adults_2.5G
daemon.notice hostapd: Adults_2.5G: AP-STA-CONNECTED 3c:15:c2:d1:1c:e4 auth_alg=open
daemon.notice hostapd: Adults_2.5G: EAPOL-4WAY-HS-COMPLETED 3c:15:c2:d1:1c:e4
daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 3c:15:c2:d1:1c:e4
kern.info kernel: [12579.292950] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
user.info usteer: station 3c:15:c2:d1:1c:e4 disconnected from node hostapd.Adults_2.5G
daemon.notice hostapd: Adults_2.5G: AP-STA-CONNECTED 3c:15:c2:d1:1c:e4 auth_alg=open
daemon.notice hostapd: Adults_2.5G: EAPOL-4WAY-HS-COMPLETED 3c:15:c2:d1:1c:e4
user.info mwan3track[2454]: Check (ping) failed for target "8.8.4.4" on interface wan (wan). Current score: 10
daemon.notice hostapd: Adults_2.5G: AP-STA-DISCONNECTED 3c:15:c2:d1:1c:e4
kern.info kernel: [14546.827711] ath10k_ahb a000000.wifi: mac flush vdev 0 drop 0 queues 0x1 ar->paused: 0x0  arvif->paused: 0x0
user.info usteer: station 3c:15:c2:d1:1c:e4 disconnected from node hostapd.Adults_2.5G

You ne€d to match ath10k-firmware-xxxxxxx and kmod-ath10k , board data is same for both

I still get the problem of the WI-FI not coming up on boot with the non CT driver and kernel plugin but I also I now get random disabling of the 2.5G radio for an unknown reason.

Sat May  4 07:31:03 2024 kern.info kernel: [   51.311326] br-adults_lan: port 2(Adults_2.5G) entered blocking state
Sat May  4 07:31:03 2024 kern.info kernel: [   51.311399] br-adults_lan: port 2(Adults_2.5G) entered disabled state
Sat May  4 07:31:03 2024 kern.info kernel: [   51.316955] ath10k_ahb a000000.wifi Adults_2.5G: entered allmulticast mode
Sat May  4 07:31:03 2024 kern.info kernel: [   51.323670] ath10k_ahb a000000.wifi Adults_2.5G: entered promiscuous mode
Sat May  4 07:31:03 2024 kern.info kernel: [   51.330407] br-adults_lan: port 2(Adults_2.5G) entered blocking state
Sat May  4 07:31:03 2024 kern.info kernel: [   51.336911] br-adults_lan: port 2(Adults_2.5G) entered forwarding state
Sat May  4 07:31:03 2024 daemon.crit dnsmasq[1]: failed to create listening socket for 192.168.2.1: Address in use
Sat May  4 07:31:03 2024 daemon.crit dnsmasq[1]: FAILED to start up
Sat May  4 07:31:03 2024 daemon.notice hostapd: Adults_2.5G: interface state UNINITIALIZED->COUNTRY_UPDATE
Sat May  4 07:31:03 2024 kern.info kernel: [   51.350226] br-adults_lan: port 2(Adults_2.5G) entered disabled state
Sat May  4 07:31:03 2024 daemon.notice netifd: Interface 'wan' is now up
Sat May  4 07:31:03 2024 kern.info kernel: [   52.000326] br-adults_lan: port 2(Adults_2.5G) entered blocking state
Sat May  4 07:31:03 2024 kern.info kernel: [   52.000407] br-adults_lan: port 2(Adults_2.5G) entered forwarding state
Sat May  4 07:31:03 2024 daemon.notice netifd: Network device 'Adults_2.5G' link is up
Sat May  4 07:31:03 2024 user.info usteer: Creating local node hostapd.Adults_2.5G
Sat May  4 07:31:03 2024 user.notice ucitrack: Setting up /etc/config/dhcp reload dependency on /etc/config/network
Sat May  4 07:31:04 2024 kern.info kernel: [   52.798150] br-kids_lan: port 1(Kids_2.5g) entered blocking state
Sat May  4 07:31:04 2024 kern.info kernel: [   52.798246] br-kids_lan: port 1(Kids_2.5g) entered disabled state
Sat May  4 07:31:04 2024 kern.info kernel: [   52.803352] ath10k_ahb a000000.wifi Kids_2.5g: entered allmulticast mode
Sat May  4 07:31:04 2024 kern.info kernel: [   52.810026] ath10k_ahb a000000.wifi Kids_2.5g: entered promiscuous mode
Sat May  4 07:31:04 2024 kern.info kernel: [   52.823237] br-kids_lan: port 1(Kids_2.5g) entered blocking state
Sat May  4 07:31:04 2024 kern.info kernel: [   52.823319] br-kids_lan: port 1(Kids_2.5g) entered forwarding state
Sat May  4 07:31:04 2024 kern.info kernel: [   52.832227] ath10k_ahb a000000.wifi Kids_2.5g: left allmulticast mode
Sat May  4 07:31:04 2024 kern.info kernel: [   52.834936] ath10k_ahb a000000.wifi Kids_2.5g: left promiscuous mode
Sat May  4 07:31:04 2024 kern.info kernel: [   52.841602] br-kids_lan: port 1(Kids_2.5g) entered disabled state
Sat May  4 07:31:04 2024 daemon.notice netifd: Interface 'kids_lan' is now down
Sat May  4 07:31:04 2024 daemon.info ModemManager[5541]: hotplug: add network interface Kids_2.5g: event processed
Sat May  4 07:31:05 2024 daemon.err hostapd: l2_packet_init: ioctl[SIOCGIFHWADDR]: No such device
Sat May  4 07:31:05 2024 daemon.err hostapd: DHCP snooping initialization failed
Sat May  4 07:31:05 2024 daemon.info ModemManager[5603]: hotplug: remove network interface br-kids_lan: event processed
Sat May  4 07:31:05 2024 kern.warn kernel: [   53.204272] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 2
Sat May  4 07:31:05 2024 daemon.notice netifd: Interface 'kids_lan' is disabled
Sat May  4 07:31:05 2024 user.notice ucitrack: Setting up /etc/config/sqm reload dependency on /etc/config/sqm
Sat May  4 07:31:05 2024 daemon.info ModemManager[5644]: hotplug: remove network interface Kids_2.5g: event processed
Sat May  4 07:31:05 2024 daemon.notice hostapd: nl80211: Failed to remove interface Kids_2.5g from bridge br-kids_lan: No such device
Sat May  4 07:31:05 2024 daemon.notice [4423]: <msg> [base-manager] port Kids_2.5g released by device '/sys/devices/platform/soc/a000000.wifi'
Sat May  4 07:31:05 2024 daemon.warn [4423]: <wrn> [plugin-manager] task 0,Kids_2.5g: failed: Operation was cancelled
Sat May  4 07:31:05 2024 user.notice nlbwmon: Reloading nlbwmon due to ifup of adults_lan (br-adults_lan)
Sat May  4 07:31:05 2024 daemon.info ModemManager[5702]: hotplug: add network interface br-kids_lan: event processed
Sat May  4 07:31:05 2024 user.notice ucitrack: Setting up /etc/config/system reload trigger for non-procd /etc/init.d/led
Sat May  4 07:31:05 2024 daemon.err hostapd: Interface initialization failed
Sat May  4 07:31:05 2024 daemon.notice hostapd: Adults_2.5G: interface state COUNTRY_UPDATE->DISABLED
Sat May  4 07:31:05 2024 daemon.notice hostapd: Adults_2.5G: AP-DISABLED
Sat May  4 07:31:05 2024 daemon.err hostapd: Adults_2.5G: Unable to setup interface.
Sat May  4 07:31:05 2024 daemon.notice hostapd: nl80211: deinit ifname=Adults_2.5G disabled_11b_rates=0
Sat May  4 07:31:05 2024 kern.info kernel: [   53.821151] ath10k_ahb a000000.wifi Adults_2.5G: left allmulticast mode
Sat May  4 07:31:05 2024 kern.info kernel: [   53.821242] ath10k_ahb a000000.wifi Adults_2.5G: left promiscuous mode
Sat May  4 07:31:05 2024 kern.info kernel: [   53.826902] br-adults_lan: port 2(Adults_2.5G) entered disabled state
Sat May  4 07:31:05 2024 user.notice ucitrack: Setting up /etc/config/luci_statistics reload dependency on /etc/config/system
Sat May  4 07:31:05 2024 kern.warn kernel: [   53.926864] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 1
Sat May  4 07:31:05 2024 kern.warn kernel: [   53.926966] ath10k_ahb a000000.wifi: peer-unmap-event: unknown peer id 1
Sat May  4 07:31:05 2024 daemon.err hostapd: rmdir[ctrl_interface=/var/run/hostapd]: Permission denied
Sat May  4 07:31:05 2024 daemon.notice hostapd: Adults_2.5G: CTRL-EVENT-TERMINATING
Sat May  4 07:31:05 2024 daemon.err hostapd: hostapd_free_hapd_data: Interface Adults_2.5G wasn't started
Sat May  4 07:31:05 2024 daemon.err hostapd: rmdir[ctrl_interface=/var/run/hostapd]: Permission denied
Sat May  4 07:31:05 2024 daemon.notice hostapd: Kids_2.5g: CTRL-EVENT-TERMINATING
Sat May  4 07:31:05 2024 daemon.err hostapd: hostapd_free_hapd_data: Interface Kids_2.5g wasn't started
Sat May  4 07:31:05 2024 daemon.notice hostapd: hostapd.add_iface failed for phy phy0 ifname=Adults_2.5G
Sat May  4 07:31:05 2024 user.notice ucitrack: Setting up /etc/config/dhcp reload dependency on /etc/config/system
Sat May  4 07:31:05 2024 daemon.notice hostapd: Set new config for phy phy1: /var/run/hostapd-phy1.conf
Sat May  4 07:31:05 2024 daemon.notice hostapd: Restart interface for phy phy1
Sat May  4 07:31:05 2024 user.info usteer: Found nl80211 phy on wdev hostapd.Adults_2.5G, ssid=
Sat May  4 07:31:05 2024 user.info usteer: Connecting to local node hostapd.Adults_2.5G
Sat May  4 07:31:06 2024 daemon.notice hostapd: Configuration file: data: driver=nl80211 logger_syslog=127 logger_syslog_level=4 logger_stdout=127 logger_stdout_level=4 country_code=NZ ieee80211d=1 ieee80211h=1 hw_mode=a beacon_int=100 vendor_elements=DD080050F21102000200 chanlist=36 tx_queue_data2_burst=2.0 #num_global_macaddr=1 ieee80211n=1 ht_coex=0 ht_capab=[HT40+][LDPC][SHORT-GI-20][SHORT-GI-40][TX-STBC][RX-STBC1][MAX-AMSDU-7935][DSSS_CCK-40] ieee80211ac=1 vht_oper_chwidth=1 vht_oper_centr_freq_seg0_idx=42 vht_capab=[RXLDPC][SHORT-GI-80][TX-STBC-2BY1][SU-BEAMFORMER][SU-BEAMFORMEE][MU-BEAMFORMER][MU-BEAMFORMEE][RX-ANTENNA-PATTERN][TX-ANTENNA-PATTERN][RX-STBC-1][SOUNDING-DIMENSION-2][BF-ANTENNA-3][MAX-MPDU-11454][MAX-A-MPDU-LEN-EXP7] channel=36  interface=Adults_5g bssid=c4:4b:d1:00:47:4f ctrl_interface=/var/run/hostapd ap_isolate=1 bss_load_update_period=60 chan_util_avg_period=600 disassoc_low_ack=1 skip_inactivity_poll=0 preamble=1 wmm_enabled=1 ignore_broadcast_ssid=0 uapsd_advertisement_enabled=1 utf8_ssid=1 multi_ap=0