ath9k_htc + wpa_supplicant : authentication timeout

raghunathan.kailasanathan at wipro.com raghunathan.kailasanathan
Sun Feb 20 23:43:12 PST 2011


Hi all,
I have PowerPC big-endian host with ath9k_htc (Atheros AR9271) USB dongle 
and am using wpa_supplicant/nl08211 to connect to a non-secure AP. The wpa_supplicant 
keeps reporting "SME: Authentication timed out". Please find logs below.
Using wpa_cli to increase the authentication timeout did not help. Using
-Dwext gives the same result and using just iwconfig I am not able to associate 
with the AP.

At the same time I also see the following output from dmesg -
[  457.374112] wlan0: direct probe to ef8bf5e8 (try 1)
[  457.572779] wlan0: direct probe to ef8bf5e8 (try 2)
[  458.072669] wlan0: direct probe to ef8bf5e8 (try 3)
[  458.272676] wlan0: direct probe to ef8bf5e8 timed out

..which is probably from the kernel compat-wireless package I am using.

Any pointers on where I could look at what's going wrong ?

Regards
Raghu

wpa_supplicant logs
--------------------

Initializing interface 'wlan0' conf './wpa_supplicant.conf' driver 'nl80211' ctrl_interface 'N/A' bridge 'N/A'
Configuration file './wpa_supplicant.conf' -> '/raghu/wpa/./wpa_supplicant.conf'
Reading configuration file '/raghu/wpa/./wpa_supplicant.conf'
ctrl_interface='/var/run/wpa_supplicant'
Line: 2 - start of a new network block
ssid - hexdump_ascii(len=13):
     47 75 65 73 74 49 6e 74 65 72 6e 65 74            GuestInternet   
key_mgmt: 0x4
Priority group 0
   id=0 ssid='GuestInternet'
netlink: Operstate: linkmode=1, operstate=5
nl80211: Register Action command failed: ret=-114 (Operation already in progress)
nl80211: Register Action match - hexdump(len=1): 06
nl80211: Failed to register Action frame processing - ignore for now
Own MAC address: 00:03:7f:0f:a5:84
wpa_driver_nl80211_set_key: ifindex=7 alg=0 addr=0x1004e228 key_idx=0 set_tx=0 seq_len=0 key_len=0
wpa_driver_nl80211_set_key: ifindex=7 alg=0 addr=0x1004e228 key_idx=1 set_tx=0 seq_len=0 key_len=0
wpa_driver_nl80211_set_key: ifindex=7 alg=0 addr=0x1004e228 key_idx=2 set_tx=0 seq_len=0 key_len=0
wpa_driver_nl80211_set_key: ifindex=7 alg=0 addr=0x1004e228 key_idx=3 set_tx=0 seq_len=0 key_len=0
RSN: flushing PMKID list in the driver
Setting scan request: 0 sec 100000 usec
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: Supplicant port status: Unauthorized
EAPOL: KEY_RX entering state NO_KEY_RECEIVE
EAPOL: SUPP_BE entering state INITIALIZE
EAP: EAP entering state DISABLED
EAPOL: Supplicant port status: Unauthorized
EAPOL: Supplicant port status: Unauthorized
Added interface wlan0
State: DISCONNECTED -> SCANNING
Starting AP scan for wildcard SSID
nl80211: Scan SSID - hexdump_ascii(len=0): [NULL]
Scan requested (ret=0) - scan timeout 10 seconds
nl80211: Event message available
nl80211: Scan trigger
EAPOL: disable timer tick
EAPOL: Supplicant port status: Unauthorized
nl80211: Event message available
nl80211: New scan results available
Received scan results (4 BSSes)
BSS: Start scan result update 1
BSS: Add new id 0 BSSID 68:7f:74:96:57:f4 SSID 'wipro'
BSS: Add new id 1 BSSID 00:11:20:f0:3e:51 SSID ''
BSS: Add new id 2 BSSID 26:37:77:2e:0d:41 SSID 'try'
BSS: Add new id 3 BSSID 00:11:20:f0:3e:53 SSID 'GuestInternet'
New scan results available
Selecting BSS from priority group 0
Try to find WPA-enabled AP
0: 68:7f:74:96:57:f4 ssid='wipro' wpa_ie_len=0 rsn_ie_len=20 caps=0x411
   skip - SSID mismatch
1: 00:11:20:f0:3e:51 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
2: 26:37:77:2e:0d:41 ssid='try' wpa_ie_len=0 rsn_ie_len=0 caps=0x2
   skip - no WPA/RSN IE
3: 00:11:20:f0:3e:53 ssid='GuestInternet' wpa_ie_len=0 rsn_ie_len=0 caps=0x421
   skip - no WPA/RSN IE
Try to find non-WPA AP
0: 68:7f:74:96:57:f4 ssid='wipro' wpa_ie_len=0 rsn_ie_len=20 caps=0x411
   skip - SSID mismatch
1: 00:11:20:f0:3e:51 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
2: 26:37:77:2e:0d:41 ssid='try' wpa_ie_len=0 rsn_ie_len=0 caps=0x2
   skip - SSID mismatch
3: 00:11:20:f0:3e:53 ssid='GuestInternet' wpa_ie_len=0 rsn_ie_len=0 caps=0x421
   selected non-WPA AP 00:11:20:f0:3e:53 ssid='GuestInternet'
Automatic auth_alg selection: 0x1
WPA: clearing AP WPA IE
WPA: clearing AP RSN IE
WPA: clearing own WPA/RSN IE
Cancelling scan request
Trying to authenticate with 00:11:20:f0:3e:53 (SSID='GuestInternet' freq=2462 MHz)
No keys have been configured - skip key clearing
State: SCANNING -> AUTHENTICATING
EAPOL: External notification - EAP success=0
EAPOL: Supplicant port status: Unauthorized
EAPOL: External notification - EAP fail=0
EAPOL: Supplicant port status: Unauthorized
EAPOL: External notification - portControl=ForceAuthorized
EAPOL: Supplicant port status: Unauthorized
nl80211: Authenticate (ifindex=7)
  * bssid=00:11:20:f0:3e:53
  * freq=2462
  * SSID - hexdump_ascii(len=13):
     47 75 65 73 74 49 6e 74 65 72 6e 65 74            GuestInternet   
  * IEs - hexdump(len=0): [NULL]
  * Auth Type 0
nl80211: Authentication request send successfully
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
nl80211: Event message available
nl80211: MLME event 37; timeout with 00:11:20:f0:3e:53
SME: Authentication timed out
Setting scan request: 5 sec 0 usec
Starting AP scan for wildcard SSID
nl80211: Scan SSID - hexdump_ascii(len=0): [NULL]
Scan requested (ret=0) - scan timeout 30 seconds
nl80211: Event message available
nl80211: Scan trigger
nl80211: Event message available
nl80211: New scan results available
Received scan results (6 BSSes)
BSS: Start scan result update 2
BSS: Add new id 4 BSSID 00:11:20:f0:3e:52 SSID ''
BSS: Add new id 5 BSSID 00:11:20:f0:3e:54 SSID ''
New scan results available
Selecting BSS from priority group 0
Try to find WPA-enabled AP
0: 68:7f:74:96:57:f4 ssid='wipro' wpa_ie_len=0 rsn_ie_len=20 caps=0x411
   skip - SSID mismatch
1: 00:11:20:f0:3e:52 ssid='' wpa_ie_len=24 rsn_ie_len=0 caps=0x431
   skip - SSID mismatch
2: 00:11:20:f0:3e:54 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
3: 00:11:20:f0:3e:51 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
4: 26:37:77:2e:0d:41 ssid='try' wpa_ie_len=0 rsn_ie_len=0 caps=0x2
   skip - no WPA/RSN IE
5: 00:11:20:f0:3e:53 ssid='GuestInternet' wpa_ie_len=0 rsn_ie_len=0 caps=0x421
   skip - no WPA/RSN IE
Try to find non-WPA AP
0: 68:7f:74:96:57:f4 ssid='wipro' wpa_ie_len=0 rsn_ie_len=20 caps=0x411
   skip - SSID mismatch
1: 00:11:20:f0:3e:52 ssid='' wpa_ie_len=24 rsn_ie_len=0 caps=0x431
   skip - SSID mismatch
2: 00:11:20:f0:3e:54 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
3: 00:11:20:f0:3e:51 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
4: 26:37:77:2e:0d:41 ssid='try' wpa_ie_len=0 rsn_ie_len=0 caps=0x2
   skip - SSID mismatch
5: 00:11:20:f0:3e:53 ssid='GuestInternet' wpa_ie_len=0 rsn_ie_len=0 caps=0x421
   selected non-WPA AP 00:11:20:f0:3e:53 ssid='GuestInternet'
Automatic auth_alg selection: 0x1
WPA: clearing AP WPA IE
WPA: clearing AP RSN IE
WPA: clearing own WPA/RSN IE
Cancelling scan request
Trying to authenticate with 00:11:20:f0:3e:53 (SSID='GuestInternet' freq=2462 MHz)
No keys have been configured - skip key clearing
State: AUTHENTICATING -> AUTHENTICATING
EAPOL: External notification - EAP success=0
EAPOL: Supplicant port status: Unauthorized
EAPOL: External notification - EAP fail=0
EAPOL: Supplicant port status: Unauthorized
EAPOL: External notification - portControl=ForceAuthorized
EAPOL: Supplicant port status: Unauthorized
nl80211: Authenticate (ifindex=7)
  * bssid=00:11:20:f0:3e:53
  * freq=2462
  * SSID - hexdump_ascii(len=13):
     47 75 65 73 74 49 6e 74 65 72 6e 65 74            GuestInternet   
  * IEs - hexdump(len=0): [NULL]
  * Auth Type 0
nl80211: Authentication request send successfully
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
nl80211: Event message available
nl80211: MLME event 37; timeout with 00:11:20:f0:3e:53
SME: Authentication timed out
Setting scan request: 5 sec 0 usec
Starting AP scan for wildcard SSID
nl80211: Scan SSID - hexdump_ascii(len=0): [NULL]
Scan requested (ret=0) - scan timeout 30 seconds
nl80211: Event message available
nl80211: Scan trigger
nl80211: Event message available
nl80211: New scan results available
Received scan results (6 BSSes)
BSS: Start scan result update 3
BSS: Add new id 6 BSSID 00:11:20:f0:3e:50 SSID ''
New scan results available
Selecting BSS from priority group 0
Try to find WPA-enabled AP
0: 68:7f:74:96:57:f4 ssid='wipro' wpa_ie_len=0 rsn_ie_len=20 caps=0x411
   skip - SSID mismatch
1: 00:11:20:f0:3e:54 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
2: 00:11:20:f0:3e:51 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
3: 00:11:20:f0:3e:50 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
4: 00:11:20:f0:3e:53 ssid='GuestInternet' wpa_ie_len=0 rsn_ie_len=0 caps=0x421
   skip - no WPA/RSN IE
5: 26:37:77:2e:0d:41 ssid='try' wpa_ie_len=0 rsn_ie_len=0 caps=0x2
   skip - no WPA/RSN IE
Try to find non-WPA AP
0: 68:7f:74:96:57:f4 ssid='wipro' wpa_ie_len=0 rsn_ie_len=20 caps=0x411
   skip - SSID mismatch
1: 00:11:20:f0:3e:54 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
2: 00:11:20:f0:3e:51 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
3: 00:11:20:f0:3e:50 ssid='' wpa_ie_len=0 rsn_ie_len=22 caps=0x431
   skip - SSID mismatch
4: 00:11:20:f0:3e:53 ssid='GuestInternet' wpa_ie_len=0 rsn_ie_len=0 caps=0x421
   selected non-WPA AP 00:11:20:f0:3e:53 ssid='GuestInternet'
Automatic auth_alg selection: 0x1
WPA: clearing AP WPA IE
WPA: clearing AP RSN IE
WPA: clearing own WPA/RSN IE
Cancelling scan request
Trying to authenticate with 00:11:20:f0:3e:53 (SSID='GuestInternet' freq=2462 MHz)
No keys have been configured - skip key clearing
State: AUTHENTICATING -> AUTHENTICATING
EAPOL: External notification - EAP success=0
EAPOL: Supplicant port status: Unauthorized
EAPOL: External notification - EAP fail=0
EAPOL: Supplicant port status: Unauthorized
EAPOL: External notification - portControl=ForceAuthorized
EAPOL: Supplicant port status: Unauthorized
nl80211: Authenticate (ifindex=7)
  * bssid=00:11:20:f0:3e:53
  * freq=2462
  * SSID - hexdump_ascii(len=13):
     47 75 65 73 74 49 6e 74 65 72 6e 65 74            GuestInternet   
  * IEs - hexdump(len=0): [NULL]
  * Auth Type 0
nl80211: Authentication request send successfully
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
nl80211: Event message available
nl80211: MLME event 37; timeout with 00:11:20:f0:3e:53
SME: Authentication timed out
Setting scan request: 5 sec 0 usec
.....
ad inf
.....






Please do not print this email unless it is absolutely necessary. 

The information contained in this electronic message and any attachments to this message are intended for the exclusive use of the addressee(s) and may contain proprietary, confidential or privileged information. If you are not the intended recipient, you should not disseminate, distribute or copy this e-mail. Please notify the sender immediately and destroy all copies of this message and any attachments. 

WARNING: Computer viruses can be transmitted via email. The recipient should check this email and any attachments for the presence of viruses. The company accepts no liability for any damage caused by any virus transmitted by this email. 

www.wipro.com



More information about the Hostap mailing list