Date: Wed, 14 Sep 2016 17:27:42 +0200 From: Michael Reifenberger <mike@reifenberger.com> To: adrian@freebsd.org Cc: freebsd-wireless@freebsd.org Subject: More than one SSID doesn't fully work with AR9280 (ath or hostapd bug?) Message-ID: <20160914172742.Horde.ZL9ZWdGKhIB9Qt9HS2O7rhE@mail.eeeit.de>
next in thread | raw e-mail | index | archive | help
Hi,
I'm using pfsense (FreeBSD fw.rm-i.net 10.3-RELEASE-p7 FreeBSD
10.3-RELEASE-p7 #0 a0a18f4(stable/16.7): Mon Aug 15 06:35:28 CEST 2016
root@sensey64:/usr/obj/usr/src/sys/SMP amd64) and a Ubiquiti
SR71-E on a APU.2C4 to get the following:
I want two interfaces ath0_wlan1 and ath0_wlan2 with different SSID's
and PSK's in order to implement
two different access filters.
The configuration works. I see:
ath0: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> metric 0 mtu 2290
ether 00:15:6d:85:e3:00
nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
media: IEEE 802.11 Wireless Ethernet autoselect mode 11ng <hostap>
status: running
ath0_wlan1: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> metric
0 mtu 1500
ether 00:15:6d:85:e3:00
inet6 fe80::215:6dff:fe85:e300%ath0_wlan1 prefixlen 64 scopeid 0x9
inet 10.0.4.1 netmask 0xffffff00 broadcast 10.0.4.255
nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
media: IEEE 802.11 Wireless Ethernet autoselect mode 11ng <hostap>
status: running
ssid WL1 channel 2 (2417 MHz 11g ht/40+) bssid 00:15:6d:85:e3:00
country US ecm authmode WPA2/802.11i privacy MIXED deftxkey 2
AES-CCM 2:128-bit AES-CCM 3:128-bit txpower 27 scanvalid 60
protmode RTSCTS ampdulimit 64k ampdudensity 8 shortgi wme burst
-apbridge dtimperiod 1 -dfs
ath0_wlan2: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> metric
0 mtu 1500
ether 06:15:6d:85:e3:00
inet6 fe80::415:6dff:fe85:e300%ath0_wlan2 prefixlen 64 scopeid 0xa
inet 10.0.5.1 netmask 0xffffff00 broadcast 10.0.5.255
nd6 options=21<PERFORMNUD,AUTO_LINKLOCAL>
media: IEEE 802.11 Wireless Ethernet autoselect mode 11ng <hostap>
status: running
ssid WL2 channel 2 (2417 MHz 11g ht/40+) bssid 06:15:6d:85:e3:00
country US ecm authmode WPA2/802.11i privacy MIXED deftxkey 2
AES-CCM 2:128-bit AES-CCM 3:128-bit txpower 27 scanvalid 60
protmode RTSCTS ampdulimit 64k ampdudensity 8 shortgi wme burst
-apbridge dtimperiod 1 -dfs
Both hostapd.conf's seem reasonable:
root@fw:/var/etc # diff -u2 hostapd_ath0_wlan1.conf hostapd_ath0_wlan2.conf
--- hostapd_ath0_wlan1.conf 2016-03-07 02:00:58.528705000 +0100
+++ hostapd_ath0_wlan2.conf 2016-03-07 02:01:00.348875000 +0100
@@ -1,3 +1,3 @@
-interface=ath0_wlan1
+interface=ath0_wlan2
driver=bsd
logger_syslog=-1
@@ -5,11 +5,11 @@
logger_stdout=-1
logger_stdout_level=0
-dump_file=/tmp/hostapd_ath0_wlan1.dump
+dump_file=/tmp/hostapd_ath0_wlan2.dump
ctrl_interface=/var/run/hostapd
ctrl_interface_group=wheel
-#accept_mac_file=/tmp/hostapd_ath0_wlan1.accept
-#deny_mac_file=/tmp/hostapd_ath0_wlan1.deny
+#accept_mac_file=/tmp/hostapd_ath0_wlan2.accept
+#deny_mac_file=/tmp/hostapd_ath0_wlan2.deny
#macaddr_acl=
-ssid=WL1
+ssid=WL2
debug=
auth_algs=1
The problem:
Only one of the interfaces works fully at the same time
Either the first one or the second one, but not both together.
If enabling both at the same time, I see both SSID's on the WLAN,
can authenticate to one of the interfaces (probably the first
configured one) but not
to the other. The other allways gives an authentification failure.
How can I debug this issue further?
BTW (if it's related):
Over time I see some of the following errors in dmesg:
...
ath0: stuck beacon; resetting (bmiss count 4)
ath0: stuck beacon; resetting (bmiss count 4)
ath0: stuck beacon; resetting (bmiss count 4)
ath0: stuck beacon; resetting (bmiss count 4)
ath0: stuck beacon; resetting (bmiss count 4)
....
In the wireless logfile I see during an unsuccessfull authentification:
...
Sep 14 17:19:53 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:19:53 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:19:53 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 1 notification
Sep 14 17:19:53 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
start authentication
Sep 14 17:19:53 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:19:53 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:19:54 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:19:54 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:19:55 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:19:55 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:19:56 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:19:56 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
PTKSTART: Retry limit 4 reached
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 3 notification
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DEAUTHENTICATE.indication(c4:85:08:3a:cf:f0, 2)
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DELETEKEYS.request(c4:85:08:3a:cf:f0)
Sep 14 17:19:57 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 2 notification
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:19:57 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 1 notification
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
start authentication
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:19:57 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:19:58 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:19:58 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:19:59 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:19:59 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:00 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:00 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
PTKSTART: Retry limit 4 reached
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 3 notification
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DEAUTHENTICATE.indication(c4:85:08:3a:cf:f0, 2)
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DELETEKEYS.request(c4:85:08:3a:cf:f0)
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:01 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 2 notification
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:01 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 1 notification
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
start authentication
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:01 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:02 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:02 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:03 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:03 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:04 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:04 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
PTKSTART: Retry limit 4 reached
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 3 notification
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DEAUTHENTICATE.indication(c4:85:08:3a:cf:f0, 2)
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DELETEKEYS.request(c4:85:08:3a:cf:f0)
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 2 notification
Sep 14 17:20:05 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:05 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 1 notification
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
start authentication
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:05 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:06 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:06 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:07 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:07 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:08 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:08 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
PTKSTART: Retry limit 4 reached
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 3 notification
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:09 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DEAUTHENTICATE.indication(c4:85:08:3a:cf:f0, 2)
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DELETEKEYS.request(c4:85:08:3a:cf:f0)
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 2 notification
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:20:09 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: associated
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 1 notification
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
start authentication
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:09 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:10 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:10 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:11 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:11 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:12 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:12 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
sending 1/4 msg of 4-Way Handshake
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
EAPOL-Key timeout
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
PTKSTART: Retry limit 4 reached
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 3 notification
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DEAUTHENTICATE.indication(c4:85:08:3a:cf:f0, 2)
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 MLME:
MLME-DELETEKEYS.request(c4:85:08:3a:cf:f0)
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:13 fw hostapd: ath0_wlan1: STA c4:85:08:3a:cf:f0 IEEE
802.11: disassociated
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 WPA:
event 2 notification
Sep 14 17:20:13 fw hostapd: ath0_wlan2: STA c4:85:08:3a:cf:f0 IEEE
802.1X: unauthorizing port
...
Any clues?
Thanks in advance!
---
mike mr@freebsd.org
Gruß
---
Michael Reifenberger
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20160914172742.Horde.ZL9ZWdGKhIB9Qt9HS2O7rhE>