Guest User!

You are not Sophos Staff.

[8.910][BUG] Wireless in not working after update

Hi All

It seems that the wireless is not working anymore after the update to client 8.910. Users are not able to connect to either the guest networks or the primary network (different vlan)

Anyone else experiencing the same issues with 8.910?

Thanks


2012:03:19-21:33:43 ap-10 hostapd: wlan1: RADIUS Received RADIUS message
2012:03:19-21:33:43 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 RADIUS: Received RADIUS packet matched with a pending request, round trip time 0.00 sec
2012:03:19-21:33:43 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: decapsulated EAP packet (code=1 id=204 len=43) from RADIUS server: EAP-Request-(null) (25)
2012:03:19-21:33:43 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: Sending EAP Packet (identifier 204)
2012:03:19-21:33:43 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: received EAP packet (code=2 id=204 len=43) from STA: EAP Response-(null) (25)
2012:03:19-21:33:43 ap-10 hostapd: wlan1: RADIUS Sending RADIUS message to authentication server
2012:03:19-21:33:43 ap-10 hostapd: wlan1: RADIUS Next RADIUS client retransmit in 3 seconds
2012:03:19-21:33:43 ap-10 hostapd: wlan1: RADIUS Received 133 bytes from RADIUS server
2012:03:19-21:33:43 ap-10 hostapd: wlan1: RADIUS Received RADIUS message
2012:03:19-21:33:43 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 RADIUS: Received RADIUS packet matched with a pending request, round trip time 0.00 sec
2012:03:19-21:33:43 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: decapsulated EAP packet (code=1 id=205 len=75) from RADIUS server: EAP-Request-(null) (25)
2012:03:19-21:33:43 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: Sending EAP Packet (identifier 205)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: received EAP packet (code=2 id=205 len=107) from STA: EAP Response-(null) (25)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Sending RADIUS message to authentication server
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Next RADIUS client retransmit in 3 seconds
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Received 149 bytes from RADIUS server
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Received RADIUS message
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 RADIUS: Received RADIUS packet matched with a pending request, round trip time 0.00 sec
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: decapsulated EAP packet (code=1 id=206 len=91) from RADIUS server: EAP-Request-(null) (25)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: Sending EAP Packet (identifier 206)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: received EAP packet (code=2 id=206 len=43) from STA: EAP Response-(null) (25)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Sending RADIUS message to authentication server
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Next RADIUS client retransmit in 3 seconds
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Received 101 bytes from RADIUS server
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Received RADIUS message
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 RADIUS: Received RADIUS packet matched with a pending request, round trip time 0.00 sec
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: decapsulated EAP packet (code=1 id=207 len=43) from RADIUS server: EAP-Request-(null) (25)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: Sending EAP Packet (identifier 207)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: received EAP packet (code=2 id=207 len=43) from STA: EAP Response-(null) (25)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Sending RADIUS message to authentication server
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Next RADIUS client retransmit in 3 seconds
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Received 170 bytes from RADIUS server
2012:03:19-21:33:44 ap-10 hostapd: wlan1: RADIUS Received RADIUS message
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 RADIUS: Received RADIUS packet matched with a pending request, round trip time 0.00 sec
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: old identity 'geostuff' updated with User-Name from Access-Accept 'geostuff'
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: decapsulated EAP packet (code=3 id=207 len=4) from RADIUS server: EAP Success
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: Sending EAP Packet (identifier 207)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 WPA: sending 1/4 msg of 4-Way Handshake
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 WPA: received EAPOL-Key frame (2/4 Pairwise)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 WPA: sending 3/4 msg of 4-Way Handshake
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 WPA: received EAPOL-Key frame (4/4 Pairwise)
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 WPA: pairwise key handshake completed (RSN)
2012:03:19-21:33:44 ap-10 awelogger[3087]: id="4101" severity="info" sys="System" sub="WiFi" name="STA connected" ssid="Stoufospito" ssid_id="WLAN2.0" bssid="00:1a:8c:06:13:51" sta="00:1d:e0:72:09:a9"
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: authorizing port
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 RADIUS: starting accounting session 4F67A5F0-00000000
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 IEEE 802.1X: authenticated - EAP type: 25 ((null))
2012:03:19-21:33:44 ap-10 hostapd: wlan1: STA 00:1d:e0:72:09:a9 WPA: Added PMKSA cache entry (IEEE 802.1X)
2012:03:19-21:34:23 ap-10 awelogger[3081]: id="4102" severity="info" sys="System" sub="WiFi" name="STA disconnected" ssid="StoufoGuest" ssid_id="WLAN1.0" bssid="00:1a:8c:06:13:50" sta="68:a8:6d:cd:2e:07"
2012:03:19-21:34:23 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.1X: unauthorizing port
2012:03:19-21:34:23 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.11: disassociated
2012:03:19-21:34:23 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-DISASSOCIATE.indication(68:a8:6d:cd:2e:07, 8)
2012:03:19-21:34:23 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-DELETEKEYS.request(68:a8:6d:cd:2e:07)
2012:03:19-21:34:24 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.11: deauthenticated due to inactivity
2012:03:19-21:34:24 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-DEAUTHENTICATE.indication(68:a8:6d:cd:2e:07, 2)
2012:03:19-21:34:24 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-DELETEKEYS.request(68:a8:6d:cd:2e:07)
2012:03:19-21:34:24 ap-10 awelogger[3081]: id="4102" severity="info" sys="System" sub="WiFi" name="STA disconnected" ssid="StoufoGuest" ssid_id="WLAN1.0" bssid="00:1a:8c:06:13:50" sta="68:a8:6d:cd:2e:07"
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.11: authentication OK (open system)
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-AUTHENTICATE.indication(68:a8:6d:cd:2e:07, OPEN_SYSTEM)
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-DELETEKEYS.request(68:a8:6d:cd:2e:07)
2012:03:19-21:34:25 ap-10 awelogger[3081]: id="4103" severity="info" sys="System" sub="WiFi" name="STA authentication" ssid="StoufoGuest" ssid_id="WLAN1.0" bssid="00:1a:8c:06:13:50" sta="68:a8:6d:cd:2e:07" status_code="0"
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.11: authenticated
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.11: association OK (aid 1)
2012:03:19-21:34:25 ap-10 awelogger[3081]: id="4104" severity="info" sys="System" sub="WiFi" name="STA association" ssid="StoufoGuest" ssid_id="WLAN1.0" bssid="00:1a:8c:06:13:50" sta="68:a8:6d:cd:2e:07" status_code="0"
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.11: associated (aid 1)
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-ASSOCIATE.indication(68:a8:6d:cd:2e:07)
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 MLME: MLME-DELETEKEYS.request(68:a8:6d:cd:2e:07)
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 WPA: event 1 notification
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 WPA: start authentication
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.1X: unauthorizing port
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 WPA: sending 1/4 msg of 4-Way Handshake
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 WPA: received EAPOL-Key frame (2/4 Pairwise)
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 WPA: sending 3/4 msg of 4-Way Handshake
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 WPA: received EAPOL-Key frame (4/4 Pairwise)
2012:03:19-21:34:25 ap-10 awelogger[3081]: id="4101" severity="info" sys="System" sub="WiFi" name="STA connected" ssid="StoufoGuest" ssid_id="WLAN1.0" bssid="00:1a:8c:06:13:50" sta="68:a8:6d:cd:2e:07"
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 IEEE 802.1X: authorizing port
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 RADIUS: starting accounting session 4F67A5F0-00000002
2012:03:19-21:34:25 ap-10 hostapd: wlan0: STA 68:a8:6d:cd:2e:07 WPA: pairwise key handshake completed (RSN) 
Parents
  • I 've create a new install using 8.301 configuration. I've used an empty interface with no vlan and AP worked fine. (I've created a test SSID 123123123 with no encryption,so users where able to connect)-attached

    However, When I unplugged the AP ,restored the config ,re associated the AP and selected vlan tagging..I stopped getting any new info on the log

    The AP is inactive but nothing in the logs. I am afraid that it might be related to the attached pic (can't find the interfaces ) log:


    2012:03:20-18:07:47 *****  awed[4030]: [MASTER] updating confd object for AP A40000D709AC807
    2012:03:20-18:07:47 ap-10 sysinit: Channel 2 busy time 49/259ms, 18%
    2012:03:20-18:07:47 ap-10 sysinit: interface not found.
    2012:03:20-18:07:47 ap-10 sysinit: Channel 3 busy time 4/238ms, 1%
    2012:03:20-18:07:47 ap-10 sysinit: Channel 4 busy time 5/251ms, 1%
    2012:03:20-18:08:42 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected
    2012:03:20-18:08:46 *****  awed[24928]: [AP10 A40000D709AC807] disconnected. Close socket and kill process.
    2012:03:20-18:08:55 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected
    2012:03:20-18:18:10 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected
    2012:03:20-18:18:35 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected 


    I waited for about 15 minutes/reboot but no logs,so I decided to delete the inactive AP and see it will detect it again. Unfortunately this didn't happen

    There seems to be a bug with vlan tagging somehow and once you enable vlan tagging on the AP it losses the connection
Reply
  • I 've create a new install using 8.301 configuration. I've used an empty interface with no vlan and AP worked fine. (I've created a test SSID 123123123 with no encryption,so users where able to connect)-attached

    However, When I unplugged the AP ,restored the config ,re associated the AP and selected vlan tagging..I stopped getting any new info on the log

    The AP is inactive but nothing in the logs. I am afraid that it might be related to the attached pic (can't find the interfaces ) log:


    2012:03:20-18:07:47 *****  awed[4030]: [MASTER] updating confd object for AP A40000D709AC807
    2012:03:20-18:07:47 ap-10 sysinit: Channel 2 busy time 49/259ms, 18%
    2012:03:20-18:07:47 ap-10 sysinit: interface not found.
    2012:03:20-18:07:47 ap-10 sysinit: Channel 3 busy time 4/238ms, 1%
    2012:03:20-18:07:47 ap-10 sysinit: Channel 4 busy time 5/251ms, 1%
    2012:03:20-18:08:42 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected
    2012:03:20-18:08:46 *****  awed[24928]: [AP10 A40000D709AC807] disconnected. Close socket and kill process.
    2012:03:20-18:08:55 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected
    2012:03:20-18:18:10 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected
    2012:03:20-18:18:35 *****  awed[4030]: [MASTER] AP A40000D709AC807: Configuration change detected 


    I waited for about 15 minutes/reboot but no logs,so I decided to delete the inactive AP and see it will detect it again. Unfortunately this didn't happen

    There seems to be a bug with vlan tagging somehow and once you enable vlan tagging on the AP it losses the connection
Children
No Data