[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) 
  • Haven't got that far yet, but past experience says they sometimes need to be power cycled (note the ISP term) after an update.

    Ian
  • is that a normal unplug,leave it for min and plug it back?
  • Hi,
    I use an AP50 on my {ASG|UTM}120 and it still works fine, triggered the system update via WLAN and reconnected after the reboot.

    Which AP do you use?
  • it seems that the clients can see the SSID but when the try to connect it takes forever and eventually they don't

    The guest wireless(vlan 20) is normal WPA2
    The primary wireless (vlan 10) is via radius

    neither of them work.However, according to the ASG users are logged in  [:)]

    According to the pc they are not getting an IP from the DHCP server
  • Please try to disable the HTML5 VPN Portal, as there is a bug the prevents adding all needed packetfilter rules, does that help?
  • I have disabled it and I have also deleted the AP and reboot it. The AP is now back but I am getting the following error message

    2012:03:19-22:21:38 *** awed[10880]: [MASTER] SIGTERM received, sending SIGTERM to siblings, exiting
    2012:03:19-22:21:38 ap-10 sysinit: read_awed(): reading message header failed, errno 131
    2012:03:19-22:21:38 ap-10 init: starting pid 3336, tty '': '/etc/init.d/rcS K shutdown'

    2012:03:19-22:22:34 ***** awed[21096]: [MASTER] awed_ng starting
    2012:03:19-22:22:34 ***** awed[21096]: [MASTER] access point firmware available: AP10:3017 AP50:3017 AP5:1 AP30:3017
    2012:03:19-22:22:41 **** awed[21096]: [MASTER] new connection from 192.168.2.1:52457


    and 

    2012:03:19-22:26:03 ap-10 sysinit: Channel 6 busy time 80/231ms, 34%
    2012:03:19-22:26:04 ****  awed[21096]: [MASTER] updating confd object for AP A40000D709AC807
    2012:03:19-22:26:04 ap-10 sysinit: Channel 7 busy time 49/230ms, 21%
    2012:03:19-22:26:04 ap-10 sysinit: Channel 8 busy time 8/230ms, 3%
    2012:03:19-22:26:04 ap-10 sysinit: Channel 9 busy time 21/231ms, 9%
    2012:03:19-22:26:05 ap-10 sysinit: Channel 10 busy time 31/230ms, 13%
    2012:03:19-22:26:05 ap-10 sysinit: Channel 11 busy time 56/231ms, 24%
    2012:03:19-22:26:06 ap-10 sysinit: Select channel 1
    2012:03:19-22:26:07 ap-10 sysinit: 192.168.2.100 = 192.168.2.100
    2012:03:19-22:26:07 ap-10 sysinit: Interface type not supported.
    2012:03:19-22:26:31 ****  awed[21096]: [MASTER] AP A40000D709AC807: Configuration change detected
    2012:03:19-22:26:32 ****  awed[21810]: [AP10 A40000D709AC807] (Re-)loaded identity and/or configuration
    2012:03:19-22:26:33 ap-10 sysinit: main(REGISTERED_CONTACT): config dumped to /tmp/cfg, forking /usr/bin/astaro-cfg.sh
    2012:03:19-22:26:34 ****  awed[21096]: [MASTER] updating confd object for AP A40000D709AC807
    2012:03:19-22:26:34 ap-10 kernel: [ 53.430000] RED: red_tunnel_release: freeing tunnel 800
    2012:03:19-22:26:34 ap-10 sysinit: 192.168.2.100 = 192.168.2.100
    2012:03:19-22:26:34 ap-10 kernel: [ 53.470000] RED: tunnel id 800, use_crypto was set to 0
    2012:03:19-22:26:35 ap-10 sysinit: Interface type not supported.
    2012:03:19-22:26:35 ap-10 kernel: [ 54.600000] cfg80211: Calling CRDA for country: GB
    2012:03:19-22:26:36 ap-10 sysinit: command failed: No such device (-19)
    2012:03:19-22:26:37 ap-10 kernel: [ 56.020000] device eth0.101 entered promiscuous mode
    2012:03:19-22:26:37 ap-10 kernel: [ 56.220000] phy0 -> rt2x00mac_conf_tx: Info - Configured TX queue 0 - CWmin: 3, CWmax: 4, Aifs: 2, TXop: 102.
    2012:03:19-22:26:37 ap-10 kernel: [ 56.220000] phy0 -> rt2x00mac_conf_tx: Info - Configured TX queue 1 - CWmin: 4, CWmax: 5, Aifs: 2, TXop: 188.
  • It seems that the clients are authenticated to the Radius server but can't get an ip

    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 RADIUS: Received RADIUS packet matched with a pending request, round trip time 0.00 sec
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 IEEE 802.1X: old identity 'wingman' updated with User-Name from Access-Accept 'wingman'
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 IEEE 802.1X: decapsulated EAP packet (code=3 id=176 len=4) from RADIUS server: EAP Success
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 IEEE 802.1X: Sending EAP Packet (identifier 176)
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 WPA: sending 1/4 msg of 4-Way Handshake
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 WPA: received EAPOL-Key frame (2/4 Pairwise)
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 WPA: sending 3/4 msg of 4-Way Handshake
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 WPA: received EAPOL-Key frame (4/4 Pairwise)
    2012:03:19-22:31:51 ap-10 hostapd: wlan1: STA 68:a8:6d:cd:2e:07 WPA: pairwise key handshake completed (RSN)
  • Also I am getting a lot of

    2012:03:19-22:11:26 *****  [local0:info] [4389]: CIpRepCache::Save() - Saved to file /tmp/ctipd.cache_v6
    2012:03:19-22:11:26 *****  [local0:info] [4389]: CIpRepCache::Save() - Saved to file /tmp/ctipd.cache
    2012:03:19-22:11:30 *****  [local0:err] [4389]: CEnginesContainer::GetCacheDelta - HttpError: 400
    2012:03:19-22:11:30 *****  [local0:info] [4389]: CEnginesContainer::UpdateSettings() - Updating
    2012:03:19-22:11:30 *****  [local0:info] [4389]: CEnginesContainer::UpdateSettings() - Updating
    2012:03:19-22:11:30 *****  [local0:err] [4389]: Counters - can't open cache file /tmp/ctipd.DM_counters
    2012:03:19-22:11:30 *****  [local0:err] [4389]: Counters - can't open cache file /tmp/ctipd.DM_counters_v6
    2012:03:19-22:12:15 *****  [daemon:err] RPC: [[[:P]]]lClient[4857]: Cannot connect: Interrupted system call
    2012:03:19-22:18:21 *****  [daemon:err] RPC: [[[:P]]]lClient[4857]: Cannot connect: Interrupted system call
    2012:03:19-22:38:13 *****  [daemon:err] RPC: [[[:P]]]lClient[4857]: Cannot connect: Interrupted system call
  • I 've rebuild using 8.910 iso and I am still having the same issues. Not able to connect to both wireless networks
    Guest network (vlan 20) 
    Priate network (vlan 10) using Radius

    I have attached the logs as well

    Any hints?

    Thanks
    wireless.zip
  • Hi Wingman, all,

    i have the same issue, after the update all wireless networks apper, the client can connect to that network but don't get an IP. Manual IP assignment don't work too, seems that all traffic on that interfaces get blocked but not logged...

    Robert