[OpenWrt-Devel] Wifi is broken

e9hack e9hack at gmail.com
Sat Nov 16 03:17:08 EST 2019


Hi,

this commit

commit	000b7687bc50be5b0f1161f4bf8ceb85c495c395
mac80211: restore mac80211_interface_cleanup()

breaks wifi on my tp-link archer C7 router. After update, only the 5G wifi will be activated. The 2.4G wifi doesn't start. I try to recover from this by shuting down and restart wifi by executing 'wifi down; sleep 30; wifi &'. Afterwards, wifi doesn't start anymore. I modify mac80211.sh to get some more log entries:

diff U3 D:/Download/carambola/mac80211.sh.old D:/Download/carambola/mac80211.sh
--- D:/Download/carambola/mac80211.sh.old	Fri Nov 15 07:52:57 2019
+++ D:/Download/carambola/mac80211.sh	Sat Nov 16 07:46:19 2019
@@ -810,15 +810,23 @@
 mac80211_interface_cleanup() {
 	local phy="$1"
 	local primary_ap=$(uci -q -P /var/state get wireless._${phy}.aplist)
+	logger -t "hostapd-test-1" "primary_ap: '$primary_ap'"
 	primary_ap=${primary_ap%% *}
+	logger -t "hostapd-test-2" "primary_ap: '$primary_ap'"
 
+	logger -t "hostapd-test-3" "mac80211_vap_cleanup hostapd \"${primary_ap}\""
 	mac80211_vap_cleanup hostapd "${primary_ap}"
+	logger -t "hostapd-test-4" "mac80211_vap_cleanup wpa_supplicant \"$(uci -q -P /var/state get wireless._${phy}.splist)\""
 	mac80211_vap_cleanup wpa_supplicant "$(uci -q -P /var/state get wireless._${phy}.splist)"
 	for wdev in $(list_phy_interfaces "$phy"); do
 		local wdev_phy="$(readlink /sys/class/net/${wdev}/phy80211)"
+		logger -t "hostapd-test-5" "wdev_phy: '$wdev_phy'"
 		wdev_phy="$(basename "$wdev_phy")"
+		logger -t "hostapd-test-6" "wdev_phy: '$wdev_phy' phy: '$phy'"
 		[ -n "$wdev_phy" -a "$wdev_phy" != "$phy" ] && continue
+		logger -t "hostapd-test-7" "ip link set dev \"$wdev\" down 2>/dev/null"
 		ip link set dev "$wdev" down 2>/dev/null
+		logger -t "hostapd-test-8" "iw dev \"$wdev\" del"
 		iw dev "$wdev" del
 	done
 }
 
If I disable the ip and iw command in the loop, both wifi does start. 

This is stripped log file till the first client is connected to the 5G wifi and 2.4G didn't start:

Fri Nov 15 07:55:28 2019 kern.notice kernel: [    0.000000] Linux version 4.19.82 (I at my-vbox) (gcc version 9.2.0 (OpenWrt GCC 9.2.0 r11467-3ff3b044c0)) #0 Tue Nov 12 15:43:14 2019
Fri Nov 15 07:55:28 2019 kern.info kernel: [   24.994537] ath10k 4.19 driver, optimized for CT firmware, probing pci device: 0x3c.
Fri Nov 15 07:55:28 2019 kern.info kernel: [   25.003619] ath10k_pci 0000:00:00.0: enabling device (0000 -> 0002)
Fri Nov 15 07:55:28 2019 kern.info kernel: [   25.012275] ath10k_pci 0000:00:00.0: pci irq legacy oper_irq_mode 1 irq_mode 0 reset_mode 0
Fri Nov 15 07:55:28 2019 kern.err kernel: [   25.493698] firmware ath10k!fwcfg-pci-0000:00:00.0.txt: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.err kernel: [   25.816942] firmware ath10k!pre-cal-pci-0000:00:00.0.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.err kernel: [   26.144589] firmware ath10k!QCA988X!hw2.0!ct-firmware-5.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.err kernel: [   26.469953] firmware ath10k!QCA988X!hw2.0!ct-firmware-2.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.err kernel: [   26.796028] firmware ath10k!QCA988X!hw2.0!firmware-6.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.err kernel: [   27.120785] firmware ath10k!QCA988X!hw2.0!firmware-5.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.err kernel: [   27.445941] firmware ath10k!QCA988X!hw2.0!firmware-4.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.err kernel: [   27.773006] firmware ath10k!QCA988X!hw2.0!firmware-3.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.info kernel: [   27.786068] ath10k_pci 0000:00:00.0: qca988x hw2.0 target 0x4100016c chip_id 0x043202ff sub 0000:0000
Fri Nov 15 07:55:28 2019 kern.info kernel: [   27.795472] ath10k_pci 0000:00:00.0: kconfig debug 0 debugfs 0 tracing 0 dfs 1 testmode 0
Fri Nov 15 07:55:28 2019 kern.info kernel: [   27.807607] ath10k_pci 0000:00:00.0: firmware ver 10.1-ct-8x-__fW-022-64cc8007 api 2 features wmi-10.x,has-wmi-mgmt-tx,mfp,txstatus-noack,wmi-10.x-CT,ratemask-CT,txrate-CT,get-temp-CT,tx-rc-CT,cust-stats-CT,retry-gt2-CT,txrate2-CT,beacon-cb-CT,wmi-block-ack-CT crc32 156478f0
Fri Nov 15 07:55:28 2019 kern.err kernel: [   28.173606] firmware ath10k!QCA988X!hw2.0!board-2.bin: firmware_loading_store: map pages failed
Fri Nov 15 07:55:28 2019 kern.info kernel: [   28.182884] ath10k_pci 0000:00:00.0: board_file api 1 bmi_id N/A crc32 bebc7c08
Fri Nov 15 07:55:28 2019 kern.warn kernel: [   29.185196] ath10k_pci 0000:00:00.0: 10.1 wmi init: vdevs: 16  peers: 127  tid: 256
Fri Nov 15 07:55:28 2019 kern.info kernel: [   29.201963] ath10k_pci 0000:00:00.0: wmi print 'P 128 V 8 T 410'
Fri Nov 15 07:55:28 2019 kern.info kernel: [   29.208264] ath10k_pci 0000:00:00.0: wmi print 'msdu-desc: 1424  sw-crypt: 0 ct-sta: 0'
Fri Nov 15 07:55:28 2019 kern.info kernel: [   29.216407] ath10k_pci 0000:00:00.0: wmi print 'alloc rem: 20904 iram: 26072'
Fri Nov 15 07:55:28 2019 kern.info kernel: [   29.266256] ath10k_pci 0000:00:00.0: htt-ver 2.1 wmi-op 2 htt-op 2 cal file max-sta 128 raw 0 hwcrypto 1
Fri Nov 15 07:55:28 2019 kern.info kernel: [   29.279137] ath10k_pci 0000:00:00.0: NOTE:  Firmware DBGLOG output disabled in debug_mask: 0x10000000
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.414157] ath: EEPROM regdomain: 0x0
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.414164] ath: EEPROM indicates default country code should be used
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.414167] ath: doing EEPROM country->regdmn map search
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.414179] ath: country maps to regdmn code: 0x3a
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.414184] ath: Country alpha2 being used: US
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.414188] ath: Regpair used: 0x3a
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.510070] ath: EEPROM regdomain: 0x0
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.510077] ath: EEPROM indicates default country code should be used
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.510080] ath: doing EEPROM country->regdmn map search
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.510093] ath: country maps to regdmn code: 0x3a
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.510098] ath: Country alpha2 being used: US
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.510101] ath: Regpair used: 0x3a
Fri Nov 15 07:55:28 2019 kern.debug kernel: [   29.527531] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
Fri Nov 15 07:55:28 2019 kern.info kernel: [   29.528563] ieee80211 phy1: Atheros AR9550 Rev:0 mem=0xb8100000, irq=12
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   55.974052] ath: EEPROM regdomain: 0x8114
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   55.978127] ath: EEPROM indicates we should expect a country code
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   55.984349] ath: doing EEPROM country->regdmn map search
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   55.989734] ath: country maps to regdmn code: 0x37
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   55.994608] ath: Country alpha2 being used: DE
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   55.999114] ath: Regpair used: 0x37
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.002664] ath: regdomain 0x8114 dynamically updated by user
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.008562] ath: EEPROM regdomain: 0x8114
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.012638] ath: EEPROM indicates we should expect a country code
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.018822] ath: doing EEPROM country->regdmn map search
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.024215] ath: country maps to regdmn code: 0x37
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.029074] ath: Country alpha2 being used: DE
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.033583] ath: Regpair used: 0x37
Fri Nov 15 07:55:50 2019 kern.debug kernel: [   56.037121] ath: regdomain 0x8114 dynamically updated by user
Fri Nov 15 07:55:54 2019 daemon.notice netifd: radio0 (2161): command failed: Too many open files in system (-23)
Fri Nov 15 07:55:54 2019 user.notice mac80211: Failed command: iw phy phy0 interface add wlan0 type __ap
Fri Nov 15 07:55:54 2019 daemon.notice hostapd: Configuration file: /var/run/hostapd-phy0.conf (phy wlan0) --> new PHY
Fri Nov 15 07:55:56 2019 kern.warn kernel: [   62.040719] ath10k_pci 0000:00:00.0: 10.1 wmi init: vdevs: 16  peers: 127  tid: 256
Fri Nov 15 07:55:56 2019 kern.info kernel: [   62.057521] ath10k_pci 0000:00:00.0: wmi print 'P 128 V 8 T 410'
Fri Nov 15 07:55:56 2019 kern.info kernel: [   62.063949] ath10k_pci 0000:00:00.0: wmi print 'msdu-desc: 1424  sw-crypt: 0 ct-sta: 0'
Fri Nov 15 07:55:56 2019 kern.info kernel: [   62.072122] ath10k_pci 0000:00:00.0: wmi print 'alloc rem: 20904 iram: 26072'
Fri Nov 15 07:55:57 2019 kern.warn kernel: [   62.163141] ath10k_pci 0000:00:00.0: pdev param 0 not supported by firmware
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.182317] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Fri Nov 15 07:55:57 2019 daemon.notice netifd: radio1 (2181): command failed: Too many open files in system (-23)
Fri Nov 15 07:55:57 2019 user.notice mac80211: Failed command: iw phy phy1 interface add wlan1 type __ap
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.314691] br-lan: port 2(wlan0) entered blocking state
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.320087] br-lan: port 2(wlan0) entered disabled state
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.325793] device wlan0 entered promiscuous mode
Fri Nov 15 07:55:57 2019 daemon.notice hostapd: Configuration file: /var/run/hostapd-phy1.conf (phy wlan1) --> new PHY
Fri Nov 15 07:55:57 2019 daemon.notice hostapd: wlan0: interface state UNINITIALIZED->COUNTRY_UPDATE
Fri Nov 15 07:55:57 2019 daemon.notice hostapd: ACS: Automatic channel selection started, this may take a bit
Fri Nov 15 07:55:57 2019 daemon.notice hostapd: wlan0: interface state COUNTRY_UPDATE->ACS
Fri Nov 15 07:55:57 2019 daemon.notice hostapd: wlan0: ACS-STARTED
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.502671] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.736915] br-lan: port 3(wlan1) entered blocking state
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.742354] br-lan: port 3(wlan1) entered disabled state
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.748022] device wlan1 entered promiscuous mode
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.752922] br-lan: port 3(wlan1) entered blocking state
Fri Nov 15 07:55:57 2019 kern.info kernel: [   62.758309] br-lan: port 3(wlan1) entered forwarding state
Fri Nov 15 07:55:57 2019 daemon.notice hostapd: wlan1: interface state UNINITIALIZED->COUNTRY_UPDATE
Fri Nov 15 07:55:57 2019 daemon.err hostapd: Using interface wlan1 with hwaddr xx:xx:xx:xx:xx:xx and ssid "WLAN-01"
Fri Nov 15 07:55:58 2019 user.notice root: ip link set dev wlan0 up
Fri Nov 15 07:55:58 2019 user.notice root: ip link set dev wlan0-1 up
Fri Nov 15 07:55:59 2019 kern.info kernel: [   64.431080] br-lan: port 3(wlan1) entered disabled state
Fri Nov 15 07:55:59 2019 daemon.notice netifd: radio0 (2161): Cannot find device "wlan0-1"
Fri Nov 15 07:55:59 2019 daemon.notice netifd: radio0 (2161): Interface 1 setup failed: IFUP_ERROR
Fri Nov 15 07:55:59 2019 user.notice root: ip link set dev wlan0-2 up
Fri Nov 15 07:56:00 2019 daemon.notice netifd: radio0 (2161): Cannot find device "wlan0-2"
Fri Nov 15 07:56:00 2019 daemon.notice netifd: radio0 (2161): Interface 2 setup failed: IFUP_ERROR
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing noise floor
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing channel time
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: ACS: Survey is missing RX and busy time (at least one is required)
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: wlan0: ACS-COMPLETED freq=5580 channel=116
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: wlan0: interface state ACS->HT_SCAN
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: wlan0: interface state HT_SCAN->DFS
Fri Nov 15 07:56:09 2019 daemon.notice hostapd: wlan0: DFS-CAC-START freq=5580 chan=116 sec_chan=1, width=1, seg0=122, seg1=0, cac_time=60s
Fri Nov 15 07:56:27 2019 daemon.notice netifd: radio1 (2181): Command failed: Request timed out
Fri Nov 15 07:56:27 2019 daemon.notice netifd: radio1 (2181): Device setup failed: HOSTAPD_START_FAILED
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-1: primary_ap: ''
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-2: primary_ap: ''
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-3: mac80211_vap_cleanup hostapd ""
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-4: mac80211_vap_cleanup wpa_supplicant ""
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-5: wdev_phy: '../../ieee80211/phy1'
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-6: wdev_phy: 'phy1' phy: 'phy1'
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-7: ip link set dev "wlan1" down 2>/dev/null
Fri Nov 15 07:56:29 2019 kern.info kernel: [   94.739161] br-lan: port 3(wlan1) entered disabled state
Fri Nov 15 07:56:29 2019 user.notice hostapd-test-8: iw dev "wlan1" del
Fri Nov 15 07:56:29 2019 kern.info kernel: [   95.016035] device wlan1 left promiscuous mode
Fri Nov 15 07:56:29 2019 kern.info kernel: [   95.020554] br-lan: port 3(wlan1) entered disabled state
Sat Nov 16 08:01:59 2019 daemon.notice hostapd: wlan0: DFS-CAC-COMPLETED success=1 freq=5580 ht_enabled=0 chan_offset=0 chan_width=3 cf1=5610 cf2=0
Sat Nov 16 08:01:59 2019 daemon.err hostapd: Using interface wlan0 with hwaddr xx:xx:xx:xx:xx:xx and ssid "WLAN-02"
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.076820] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.083515] br-lan: port 2(wlan0) entered blocking state
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.088906] br-lan: port 2(wlan0) entered forwarding state
Sat Nov 16 08:02:00 2019 daemon.notice netifd: Network device 'wlan0' link is up
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.122541] br-xxx: port 1(wlan0-1) entered blocking state
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.128109] br-xxx: port 1(wlan0-1) entered disabled state
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.134009] device wlan0-1 entered promiscuous mode
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.198674] IPv6: ADDRCONF(NETDEV_UP): wlan0-1: link is not ready
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.204996] br-xxx: port 1(wlan0-1) entered blocking state
Sat Nov 16 08:02:00 2019 kern.info kernel: [  137.210565] br-xxx: port 1(wlan0-1) entered forwarding state
Sat Nov 16 08:02:00 2019 daemon.err hostapd: Using interface wlan0-1 with hwaddr xx:xx:xx:xx:xx:xx and ssid "WLAN-03"
Sat Nov 16 08:02:01 2019 kern.info kernel: [  137.551443] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0-1: link becomes ready
Sat Nov 16 08:02:01 2019 kern.info kernel: [  137.581574] br-lan: port 3(wlan0-2) entered blocking state
Sat Nov 16 08:02:01 2019 kern.info kernel: [  137.587332] br-lan: port 3(wlan0-2) entered disabled state
Sat Nov 16 08:02:01 2019 kern.info kernel: [  137.593255] device wlan0-2 entered promiscuous mode
Sat Nov 16 08:02:01 2019 kern.info kernel: [  137.631446] IPv6: ADDRCONF(NETDEV_UP): wlan0-2: link is not ready
Sat Nov 16 08:02:01 2019 kern.info kernel: [  137.637662] br-lan: port 3(wlan0-2) entered blocking state
Sat Nov 16 08:02:01 2019 kern.info kernel: [  137.643251] br-lan: port 3(wlan0-2) entered forwarding state
Sat Nov 16 08:02:01 2019 daemon.err hostapd: Using interface wlan0-2 with hwaddr xx:xx:xx:xx:xx:xx and ssid "WLAN-01"
Sat Nov 16 08:02:01 2019 kern.info kernel: [  138.081336] br-lan: port 3(wlan0-2) entered disabled state
Sat Nov 16 08:03:55 2019 daemon.err hostapd: Failed to set beacon parameters
Sat Nov 16 08:03:55 2019 daemon.warn hostapd: wlan1: Could not connect to kernel driver
Sat Nov 16 08:03:57 2019 daemon.err hostapd: Interface initialization failed
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1: interface state COUNTRY_UPDATE->DISABLED
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1: AP-DISABLED
Sat Nov 16 08:03:57 2019 daemon.err hostapd: wlan1: Unable to setup interface.
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: nl80211: deinit ifname=wlan1 disabled_11b_rates=0
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: nl80211: Failed to remove interface wlan1 from bridge br-lan: No such device
Sat Nov 16 08:03:57 2019 daemon.err hostapd: Could not read interface wlan1 flags: No such device
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1: CTRL-EVENT-TERMINATING
Sat Nov 16 08:03:57 2019 daemon.err hostapd: hostapd_free_hapd_data: Interface wlan1 wasn't started
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1-1: CTRL-EVENT-TERMINATING
Sat Nov 16 08:03:57 2019 daemon.err hostapd: hostapd_free_hapd_data: Interface wlan1-1 wasn't started
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1-2: CTRL-EVENT-TERMINATING
Sat Nov 16 08:03:57 2019 daemon.err hostapd: hostapd_free_hapd_data: Interface wlan1-2 wasn't started
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1-3: CTRL-EVENT-TERMINATING
Sat Nov 16 08:03:57 2019 daemon.err hostapd: hostapd_free_hapd_data: Interface wlan1-3 wasn't started
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1-4: CTRL-EVENT-TERMINATING
Sat Nov 16 08:03:57 2019 daemon.err hostapd: hostapd_free_hapd_data: Interface wlan1-4 wasn't started
Sat Nov 16 08:03:57 2019 daemon.notice hostapd: wlan1-5: CTRL-EVENT-TERMINATING
Sat Nov 16 08:03:57 2019 daemon.err hostapd: hostapd_free_hapd_data: Interface wlan1-5 wasn't started
Sat Nov 16 08:04:18 2019 kern.info kernel: [  274.841981] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0-2: link becomes ready
Sat Nov 16 08:04:18 2019 kern.info kernel: [  274.848883] br-lan: port 3(wlan0-2) entered blocking state
Sat Nov 16 08:04:18 2019 kern.info kernel: [  274.854491] br-lan: port 3(wlan0-2) entered forwarding state
Sat Nov 16 08:04:18 2019 daemon.notice hostapd: wlan0: interface state DFS->ENABLED
Sat Nov 16 08:04:18 2019 daemon.notice hostapd: wlan0: AP-ENABLED
Sat Nov 16 08:04:25 2019 daemon.info hostapd: wlan0-2: STA xx:xx:xx:xx:xx:xx IEEE 802.11: authenticated
Sat Nov 16 08:04:25 2019 daemon.info hostapd: wlan0-2: STA xx:xx:xx:xx:xx:xx IEEE 802.11: associated (aid 1)
Sat Nov 16 08:04:25 2019 daemon.notice hostapd: wlan0-2: CTRL-EVENT-EAP-STARTED xx:xx:xx:xx:xx:xx
Sat Nov 16 08:04:25 2019 daemon.notice hostapd: wlan0-2: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=1
Sat Nov 16 08:04:28 2019 daemon.notice hostapd: wlan0-2: CTRL-EVENT-EAP-RETRANSMIT xx:xx:xx:xx:xx:xx
Sat Nov 16 08:04:28 2019 daemon.notice hostapd: wlan0-2: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=25
Sat Nov 16 08:04:31 2019 daemon.notice hostapd: wlan0-2: CTRL-EVENT-EAP-RETRANSMIT xx:xx:xx:xx:xx:xx
Sat Nov 16 08:04:31 2019 daemon.notice hostapd: EAP-PEAP: TLV Result - Success - requested Success
Sat Nov 16 08:04:31 2019 daemon.notice hostapd: wlan0-2: CTRL-EVENT-EAP-SUCCESS xx:xx:xx:xx:xx:xx
Sat Nov 16 08:04:31 2019 daemon.info hostapd: wlan0-2: STA xx:xx:xx:xx:xx:xx WPA: pairwise key handshake completed (RSN)
Sat Nov 16 08:04:31 2019 daemon.notice hostapd: wlan0-2: AP-STA-CONNECTED xx:xx:xx:xx:xx:xx
Sat Nov 16 08:04:31 2019 daemon.info hostapd: wlan0-2: STA xx:xx:xx:xx:xx:xx RADIUS: starting accounting session 9A799A3ABAF7BA35
Sat Nov 16 08:04:31 2019 daemon.info hostapd: wlan0-2: STA xx:xx:xx:xx:xx:xx IEEE 802.1X: authenticated - EAP type: 0 (unknown)

Regards,
Hartmut





_______________________________________________
openwrt-devel mailing list
openwrt-devel at lists.openwrt.org
https://lists.openwrt.org/mailman/listinfo/openwrt-devel



More information about the openwrt-devel mailing list