You are not logged in.

#1 2011-11-17 23:53:54

mr.schyte
Member
Registered: 2011-03-05
Posts: 11

wpa_supplicant times out; no RX EAPOL

Hi!

I'm trying to connect to a wpa enterprise network, but I always get an authentication timeout after wpa_supplicant sends an eapol request. The strange thing is that I can connect with the same config (with the same version of wpa_supplicant) on a different machine. The wlan card is a Marvell 8688.

wpa_supplicant.conf:

network={
    ssid="wifi"
    scan_ssid=1
    key_mgmt=WPA-EAP IEEE8021X
    eap=PEAP
    identity="user"
    password="pass"
    phase2="auth=MSCHAPV2"
    priority=12
}

Debug log:

Authentication with c0:c1:c0:8c:08:3b timed out.
BSSID c0:c1:c0:8c:08:3b blacklist count incremented to 2
wpa_driver_wext_disassociate
No keys have been configured - skip key clearing
State: ASSOCIATED -> DISCONNECTED
CTRL-EVENT-STATE-CHANGE id=1 state=0 BSSID=00:00:00:00:00:00
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
EAPOL: External notification - portEnabled=0
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: SUPP_BE entering state INITIALIZE
EAP: EAP entering state DISABLED
EAPOL: External notification - portValid=0
Setting scan request: 0 sec 0 usec
State: DISCONNECTED -> SCANNING
CTRL-EVENT-STATE-CHANGE id=-1 state=2 BSSID=00:00:00:00:00:00
Starting AP scan (broadcast SSID)
wpa_driver_wext_scan: specific scan = 0
Scan requested (ret=0) - scan timeout 30 seconds
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
Wireless event: cmd=0x8b15 len=20
Wireless event: new AP: 00:00:00:00:00:00
BSSID 00:00:00:00:00:00 blacklist count incremented to 11
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
State: SCANNING -> DISCONNECTED
CTRL-EVENT-STATE-CHANGE id=-1 state=0 BSSID=00:00:00:00:00:00
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
Wireless event: cmd=0x8b19 len=8
Received 1866 bytes of scan results (6 BSSes)
New scan results available
Selecting BSS from priority group 13
Try to find WPA-enabled AP
0: 00:23:69:8f:6b:16 ssid='wifi' wpa_ie_len=0 rsn_ie_len=24 caps=0x11
   skip - blacklisted
1: 00:23:69:2a:44:4f ssid='wifi' wpa_ie_len=0 rsn_ie_len=24 caps=0x11
   skip - blacklisted
2: 00:23:69:8f:6a:d7 ssid='wifi' wpa_ie_len=0 rsn_ie_len=24 caps=0x11
   skip - blacklisted
3: 00:23:69:8f:6a:d4 ssid='wifi' wpa_ie_len=0 rsn_ie_len=24 caps=0x11
   skip - blacklisted
4: c0:c1:c0:8c:08:3b ssid='wifi' wpa_ie_len=0 rsn_ie_len=24 caps=0x11
   skip - blacklisted
5: 00:23:69:29:ef:6b ssid='wifi' wpa_ie_len=0 rsn_ie_len=24 caps=0x11
   selected based on RSN IE
   selected WPA AP 00:23:69:29:ef:6b ssid='wifi'
Trying to associate with 00:23:69:29:ef:6b (SSID='wifi' freq=2422 MHz)
Cancelling scan request
WPA: clearing own WPA/RSN IE
Automatic auth_alg selection: 0x1
Overriding auth_alg selection: 0x1
RSN: using IEEE 802.11i/D9.0
WPA: Selected cipher suites: group 8 pairwise 24 key_mgmt 1 proto 2
WPA: clearing AP WPA IE
WPA: using GTK TKIP
WPA: using PTK CCMP
WPA: using KEY_MGMT 802.1X
No keys have been configured - skip key clearing
wpa_driver_wext_set_drop_unencrypted
State: DISCONNECTED -> ASSOCIATING
CTRL-EVENT-STATE-CHANGE id=-1 state=3 BSSID=00:23:69:29:ef:6b
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
wpa_driver_wext_associate
wpa_driver_wext_set_psk
Association request to the driver failed
Setting authentication timeout: 5 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
RSN: Ignored PMKID candidate without preauth flag
RSN: Ignored PMKID candidate without preauth flag
RSN: Ignored PMKID candidate without preauth flag
RSN: Ignored PMKID candidate without preauth flag
RSN: Ignored PMKID candidate without preauth flag
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
Wireless event: cmd=0x8b06 len=8
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
Wireless event: cmd=0x8b04 len=12
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
Wireless event: cmd=0x8b15 len=20
Wireless event: new AP: 00:23:69:8f:6b:16
State: ASSOCIATING -> ASSOCIATED
CTRL-EVENT-STATE-CHANGE id=1 state=4 BSSID=00:23:69:29:ef:6b
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
Associated to a new BSS: BSSID=00:23:69:8f:6b:16
No keys have been configured - skip key clearing
Associated with 00:23:69:8f:6b:16
WPA: Association event - clear replay counter
WPA: Clear old PTK
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - portEnabled=1
EAPOL: SUPP_PAE entering state CONNECTING
EAPOL: SUPP_BE entering state IDLE
EAP: EAP entering state INITIALIZE
EAP: EAP entering state IDLE
Setting authentication timeout: 10 sec 0 usec
Cancelling scan request
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
Wireless event: cmd=0x8b1a len=12
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'mlan0' added
EAPOL: startWhen --> 0
EAPOL: SUPP_PAE entering state CONNECTING
EAPOL: txStart
TX EAPOL: dst=00:23:69:8f:6b:16
Authentication with 00:23:69:8f:6b:16 timed out.
BSSID 00:23:69:8f:6b:16 blacklist count incremented to 4
wpa_driver_wext_disassociate
No keys have been configured - skip key clearing
State: ASSOCIATED -> DISCONNECTED
CTRL-EVENT-STATE-CHANGE id=1 state=0 BSSID=00:00:00:00:00:00
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
EAPOL: External notification - portEnabled=0
EAPOL: SUPP_PAE entering state DISCONNECTED

Last edited by mr.schyte (2011-11-18 08:58:37)

Offline

#2 2011-11-17 23:59:56

karol
Archivist
Registered: 2009-05-06
Posts: 25,440

Re: wpa_supplicant times out; no RX EAPOL

mr.schyte, please edit your post.
When pasting code, please use [ code ] tags, not [ quote ] tags https://bbs.archlinux.org/help.php#bbcode

like this

It makes the code more readable and more convenient to scroll through.

Offline

#3 2011-11-18 10:35:09

mr.schyte
Member
Registered: 2011-03-05
Posts: 11

Re: wpa_supplicant times out; no RX EAPOL

I've captured the authentication using tshark and it seems that wpa_supplicant ignores the identity requests:

21043   7.653254 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]
23617   8.618366 Azurewav_33:62:f2 -> Cisco-Li_8f:6b:16 EAPOL 54 Start
23631   8.621801 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]
28894  10.639204 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]
47517  16.646363 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]
62544  21.826867 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]
65885  22.806460 Azurewav_33:62:f2 -> Cisco-Li_8f:6b:16 EAPOL 54 Start
65886  22.806995 Azurewav_33:62:f2 -> Cisco-Li_8f:6b:16 EAPOL 54 Start
65908  22.814801 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]
72079  24.819307 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]
90661  30.827557 Cisco-Li_8f:6b:16 -> Azurewav_33:62:f2 EAP 61 Request, Identity [RFC3748]

Any ideas?

Offline

Board footer

Powered by FluxBB