[OpenWrt-Devel] Wifi is broken
Dirk Brenken
dev at brenken.org
Sat Nov 16 10:50:24 EST 2019
On Sat, 2019-11-16 at 09:17 +0100, e9hack wrote:
> 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
>
>
Same symptoms here with a GL-AR300M (single radio 2.4G, travel router)
and travelmate.
Regards,
Dirk
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 833 bytes
Desc: This is a digitally signed message part
URL: <http://lists.infradead.org/pipermail/openwrt-devel/attachments/20191116/720adc1d/attachment.sig>
-------------- next part --------------
_______________________________________________
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