Guest User!

You are not Sophos Staff.

[8.270][NOTABUG][CLOSED] Wi-Fi (AP30) Dropout

Greetings,

I've been having a number of Wi-Fi restarts that I don't understand. Here's a copy of the log event for Wi-Fi during the trouble. The client machines were disconnected, and then they didn't see the SSID's for a couple of minutes and then they reconnected automatically.

Running v8.270

Any thoughts?

Mark


2011:11:17-15:37:40 vpn awed[5811]: send msg: ip:'192.168.1.56', id:'A40001F8E5C31D3', type:'3', length:'48'
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan0: WPA rekeying GTK
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan0: STA 00:23:08:cc:0b:13 WPA: sending 1/2 msg of Group Key Handshake
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan0: STA 00:13:02:2b:9e:f8 WPA: sending 1/2 msg of Group Key Handshake
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan1: WPA rekeying GTK
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan0: STA 00:23:08:cc:0b:13 WPA: received EAPOL-Key frame (2/2 Group)
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan0: STA 00:23:08:cc:0b:13 WPA: group key handshake completed (RSN)
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan0: STA 00:13:02:2b:9e:f8 WPA: received EAPOL-Key frame (2/2 Group)
2011:11:17-15:37:40 192.168.1.56 hostapd: wlan0: STA 00:13:02:2b:9e:f8 WPA: group key handshake completed (RSN)
2011:11:17-15:37:44 vpn awed[5811]: send msg: ip:'192.168.1.53', id:'A4000128ECB006A', type:'3', length:'48'
2011:11:17-15:37:48 vpn awed[5811]: send msg: ip:'192.168.1.52', id:'A4000155877F942', type:'3', length:'48'
2011:11:17-15:37:51 192.168.1.53 hostapd: wlan0: WPA rekeying GTK
2011:11:17-15:37:51 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: sending 1/2 msg of Group Key Handshake
2011:11:17-15:37:51 192.168.1.53 hostapd: wlan1: WPA rekeying GTK
2011:11:17-15:37:51 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: EAPOL-Key timeout
2011:11:17-15:37:51 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: sending 1/2 msg of Group Key Handshake
2011:11:17-15:37:52 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: EAPOL-Key timeout
2011:11:17-15:37:52 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: sending 1/2 msg of Group Key Handshake
2011:11:17-15:37:53 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: EAPOL-Key timeout
2011:11:17-15:37:53 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: sending 1/2 msg of Group Key Handshake
2011:11:17-15:37:54 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: EAPOL-Key timeout
2011:11:17-15:37:54 192.168.1.53 awelogger[1256]: id="4105" severity="info" sys="System" sub="WiFi" name="STA WPA failure" ssid="McCoy" ssid_id="WLAN0.0" bssid="00:1a:8c:08:9e:20" sta="00:15:e9:89[:D]5:5d" reason_code="2"
2011:11:17-15:37:54 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.1X: unauthorizing port
2011:11:17-15:37:54 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.11: deauthenticated due to local deauth request
2011:11:17-15:37:55 vpn awed[5811]: send msg: ip:'192.168.1.56', id:'A40001F8E5C31D3', type:'3', length:'48'
2011:11:17-15:37:59 vpn awed[5811]: send msg: ip:'192.168.1.53', id:'A4000128ECB006A', type:'3', length:'48'
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.11: authentication OK (open system)
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d MLME: MLME-AUTHENTICATE.indication(00:15:e9:89[:D]5:5d, OPEN_SYSTEM)
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d MLME: MLME-DELETEKEYS.request(00:15:e9:89[:D]5:5d)
2011:11:17-15:38:00 192.168.1.53 awelogger[1256]: id="4103" severity="info" sys="System" sub="WiFi" name="STA authentication" ssid="McCoy" ssid_id="WLAN0.0" bssid="00:1a:8c:08:9e:20" sta="00:15:e9:89[:D]5:5d" status_code="0"
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.11: authenticated
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.11: association OK (aid 1)
2011:11:17-15:38:00 192.168.1.53 awelogger[1256]: id="4104" severity="info" sys="System" sub="WiFi" name="STA association" ssid="McCoy" ssid_id="WLAN0.0" bssid="00:1a:8c:08:9e:20" sta="00:15:e9:89[:D]5:5d" status_code="0"
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.11: associated (aid 1)
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d MLME: MLME-ASSOCIATE.indication(00:15:e9:89[:D]5:5d)
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d MLME: MLME-DELETEKEYS.request(00:15:e9:89[:D]5:5d)
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: event 1 notification
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: start authentication
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.1X: unauthorizing port
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: sending 1/4 msg of 4-Way Handshake
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: received EAPOL-Key frame (2/4 Pairwise)
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: sending 3/4 msg of 4-Way Handshake
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: received EAPOL-Key frame (4/4 Pairwise)
2011:11:17-15:38:00 192.168.1.53 awelogger[1256]: id="4101" severity="info" sys="System" sub="WiFi" name="STA connected" ssid="McCoy" ssid_id="WLAN0.0" bssid="00:1a:8c:08:9e:20" sta="00:15:e9:89[:D]5:5d"
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d IEEE 802.1X: authorizing port
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d RADIUS: starting accounting session 4EC434BF-00000001
2011:11:17-15:38:00 192.168.1.53 hostapd: wlan0: STA 00:15:e9:89[:D]5:5d WPA: pairwise key handshake completed (RSN)
2011:11:17-15:38:03 vpn awed[5811]: send msg: ip:'192.168.1.52', id:'A4000155877F942', type:'3', length:'48'
2011:11:17-15:38:07 vpn awed[5811]: Client 00:1f:3b:25:e5:25 timed out after 61 seconds
2011:11:17-15:38:07 192.168.1.56 hostapd: wlan0: STA 00:16:44:91[:D]9:e4 IEEE 802.11: authentication OK (open system)
2011:11:17-15:38:07 192.168.1.56 hostapd: wlan0: STA 00:16:44:91[:D]9:e4 MLME: MLME-AUTHENTICATE.indication(00:16:44:91[:D]9:e4, OPEN_SYSTEM)
2011:11:17-15:38:07 192.168.1.56 hostapd: wlan0: STA 00:16:44:91[:D]9:e4 MLME: MLME-DELETEKEYS.request(00:16:44:91[:D]9:e4)
2011:11:17-15:38:07 192.168.1.56 awelogger[1371]: id="4103" severity="info" sys="System" sub="WiFi" name="STA authentication" ssid="McCoy" ssid_id="WLAN0.0" bssid="00:1a:8c:07:f4[:D]0" sta="00:16:44:91[:D]9:e4" status_code="0"
2011:11:17-15:38:07 192.168.1.56 hostapd: wlan0: STA 00:16:44:91[:D]9:e4 IEEE 802.11: authenticated
2011:11:17-15:38:07 192.168.1.56 hostapd: wlan0: STA 00:16:44:91[:D]9:e4 IEEE 802.11: association OK (aid 3)
2011:11:17-15:38:07 192.168.1.56 awelogger[1371]: id="4104" severity="info" sys="System" sub="WiFi" name="STA association" ssid="McCoy" ssid_id="WLAN0.0" bssid="00:1a:8c:07:f4[:D]0" sta="00:16:44:91[:D]9:e4" status_code="0"
2011:11:17-15:38:07 192.168.1.56 hostapd: wlan0: STA 00:16:44:91[:D]9:e4 IEEE 802.11: associated (aid 3)