WPA2 connection issue on embedded ARM system

Dirk Behme dirk.behme at googlemail.com
Tue Nov 17 09:26:58 EST 2009


Holger Schurig wrote:
>> On an embedded ARM system (Gumstix Overo based on TI OMAP3) I
>> haveissues to connect to a WPA2 wifi. Kernel is 2.6.31, driver
>> is "libertas: Marvell WLAN 802.11 adapter" with Marvell's
>> 88W8686. Running wpa_supplicant I get:
> 
> ...
>> Daemonize..
> 
> Don't run wpa_supplicant in daemon mode, after Daemonize we won't 
> see anything.
> 
> 
> There's "-d" to wpa_supplicant, use that.

See output of

wpa_supplicant -Dwext -iwlan0 -c/etc/wpa_supplicant.conf -dddt

below.

This seems to loop infinite. Anything obvious that I don't see? Maybe 
this "Association request to the driver failed"?

This is with wpa_supplicant v0.6.9, libertas fw 9.70.3p36 and kernel 
2.6.31.

> The libertas driver has extensive debugging capabilities, try 
> lbsdebug, 
> http://git.infradead.org/users/schurig/libertas-tools.git
> but you can of course also dump some value by yourself 
> into /sys/module/libertas/parameters/libertas_debug.

I will enable this (anything specific what to enable?) when you don't 
see anything obvious below.

Regarding HW issues, what I hear from others on the same platform 
unencrypted wifi does work. And, I think to remember that with the 
same local wifi it worked with older kernel and rootfs some month ago 
for me as well. So I would vote for a SW (configuration) issue atm.

Many thanks for your help,

Dirk

Configuration:

# iwlist wlan0 scan
wlan0     Scan completed :
           Cell 01 - Address: 00:1F:3F:12:FA:7D
                     ESSID:"WLAN-001F3F12FA7D"
                     Mode:Managed
                     Frequency:2.462 GHz (Channel 11)
                     Quality=97/100  Signal level=-51 dBm  Noise
level=-96 dBm
                     Encryption key:on
                     Bit Rates:1 Mb/s; 2 Mb/s; 5.5 Mb/s; 11 Mb/s; 6 Mb/s
                               9 Mb/s; 12 Mb/s; 18 Mb/s; 24 Mb/s; 36 Mb/s
                               48 Mb/s; 54 Mb/s
                     IE: WPA Version 1
                         Group Cipher : TKIP
                         Pairwise Ciphers (1) : TKIP
                         Authentication Suites (1) : PSK
                     IE: IEEE 802.11i/WPA2 Version 1
                         Group Cipher : TKIP
                         Pairwise Ciphers (1) : CCMP
                         Authentication Suites (1) : PSK

# cat /etc/wpa_supplicant.conf
ctrl_interface=/var/run/wpa_supplicant
ctrl_interface_group=0
eapol_version=1
ap_scan=1
fast_reauth=1

network={
       ssid="WLAN-001F3F12FA7D"
       proto=WPA2
       key_mgmt=WPA-PSK
       pairwise=CCMP TKIP
       group=CCMP TKIP
       scan_ssid=0
       psk="7......0"
       priority=10
}

# wpa_supplicant -Dwext -iwlan0 -c/etc/wpa_supplicant.conf -dddt

1255399002.755706: Initializing interface 'wlan0' conf
'/etc/wpa_supplicant.conf' driver 'wext' ctrl_interface 'N/A' brid'
1255399002.756195: Configuration file '/etc/wpa_supplicant.conf' ->
'/etc/wpa_supplicant.conf'
1255399002.756256: Reading configuration file '/etc/wpa_supplicant.conf'
1255399002.756622: ctrl_interface='/var/run/wpa_supplicant'
1255399002.756683: ctrl_interface_group='0'
1255399002.756774: eapol_version=1
1255399002.756805: ap_scan=1
1255399002.756866: fast_reauth=1
1255399002.756896: Line: 7 - start of a new network block
1255399002.757019: ssid - hexdump_ascii(len=17):      57 4c 41 4e 2d 
30 30 31 46 33 46 31 32 46 41 37 WLAN-001F3F12FA7     44             D
1255399002.757202: proto: 0x2
1255399002.757263: key_mgmt: 0x2
1255399002.757293: pairwise: 0x18
1255399002.757324: group: 0x18
1255399002.757385: scan_ssid=0 (0x0)
1255399002.757415: PSK (ASCII passphrase) - hexdump_ascii(len=16): 
[REMOVED]
1255399002.757476: priority=10 (0xa)
1255399003.187591: PSK (from passphrase) - hexdump(len=32): [REMOVED]
1255399003.187927: Priority group 10
1255399003.187988:    id=0 ssid='WLAN-001F3F12FA7D'
1255399003.188018: Initializing interface (2) 'wlan0'
1255399003.188934: SIOCGIWRANGE: WE(compiled)=22 WE(source)=15 
enc_capa=0xf
1255399003.189025:   capabilities: key_mgmt 0xf enc 0xf flags 0x0
1255399003.335968: WEXT: Operstate: linkmode=1, operstate=5
1255399003.336364: Own MAC address: 00:19:88:20:fa:20
1255399003.336456: wpa_driver_wext_set_wpa
1255399003.336547: wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 
seq_len=0 key_len=0
1255399003.336669: wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 
seq_len=0 key_len=0
1255399003.336730: wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 
seq_len=0 key_len=0
1255399003.336792: wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 
seq_len=0 key_len=0
1255399003.336853: wpa_driver_wext_set_countermeasures
1255399003.336914: wpa_driver_wext_set_drop_unencrypted
1255399003.336944: RSN: flushing PMKID list in the driver
1255399003.337097: Setting scan request: 0 sec 100000 usec
1255399003.355957: EAPOL: SUPP_PAE entering state DISCONNECTED
1255399003.356079: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
1255399003.356109: EAPOL: SUPP_BE entering state INITIALIZE
1255399003.356140: EAP: EAP entering state DISABLED
1255399003.358734: ctrl_interface_group=0
1255399003.359069: Added interface wlan0
1255399003.359283: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399003.359344: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399003.359405: Wireless event: cmd=0x8b06 len=8
1255399003.437500: State: DISCONNECTED -> SCANNING
1255399003.437561: Starting AP scan (broadcast SSID)
1255399003.437591: Trying to get current scan results first without 
requesting a new scan to speed up initial association
1255399003.437744: Received 0 bytes of scan results (0 BSSes)
1255399003.437835: Cached scan results are empty - not posting
1255399003.437866: Selecting BSS from priority group 10
1255399003.437896: Try to find WPA-enabled AP
1255399003.437927: Try to find non-WPA AP
1255399003.437957: No suitable AP found.
1255399003.438018: Setting scan request: 0 sec 0 usec
1255399003.438079: Starting AP scan (broadcast SSID)
1255399003.438140: Scan requested (ret=0) - scan timeout 5 seconds
1255399004.357391: EAPOL: disable timer tick
1255399005.390991: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399005.391143: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399005.391204: Wireless event: cmd=0x8b19 len=8
1255399005.391296: Received 0 bytes of scan results (0 BSSes)
1255399005.391357: CTRL-EVENT-SCAN-RESULTS
1255399005.391387: Selecting BSS from priority group 10
1255399005.391418: Try to find WPA-enabled AP
1255399005.391448: Try to find non-WPA AP
1255399005.391479: No suitable AP found.
1255399005.391540: Setting scan request: 5 sec 0 usec
1255399010.393951: Starting AP scan (broadcast SSID)
1255399010.394134: Scan requested (ret=0) - scan timeout 30 seconds
1255399012.352600: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399012.352752: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399012.352813: Wireless event: cmd=0x8b19 len=8
1255399012.352966: Received 245 bytes of scan results (1 BSSes)
1255399012.353027: CTRL-EVENT-SCAN-RESULTS
1255399012.353057: Selecting BSS from priority group 10
1255399012.353118: Try to find WPA-enabled AP
1255399012.353149: 0: 00:1f:3f:12:fa:7d ssid='WLAN-001F3F12FA7D' 
wpa_ie_len=24 rsn_ie_len=20 caps=0x11
1255399012.353210:    selected based on RSN IE
1255399012.353271:    selected WPA AP 00:1f:3f:12:fa:7d 
ssid='WLAN-001F3F12FA7D'
1255399012.353393: Trying to associate with 00:1f:3f:12:fa:7d 
(SSID='WLAN-001F3F12FA7D' freq=2462 MHz)
1255399012.353424: Cancelling scan request
1255399012.353485: WPA: clearing own WPA/RSN IE
1255399012.354095: Automatic auth_alg selection: 0x1
1255399012.354217: RSN: using IEEE 802.11i/D9.0
1255399012.354248: WPA: Selected cipher suites: group 8 pairwise 16 
key_mgmt 2 proto 2
1255399012.354370: WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 
f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50
1255399012.354461: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 
00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
1255399012.354553: WPA: using GTK TKIP
1255399012.354614: WPA: using PTK CCMP
1255399012.354644: WPA: using KEY_MGMT WPA-PSK
1255399012.354675: WPA: Set own WPA IE default - hexdump(len=22): 30 
14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f a0
1255399012.354766: No keys have been configured - skip key clearing
1255399012.354797: wpa_driver_wext_set_drop_unencrypted
1255399012.354858: State: SCANNING -> ASSOCIATING
1255399012.354888: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
1255399012.354919: WEXT: Operstate: linkmode=-1, operstate=5
1255399012.355041: wpa_driver_wext_associate
1255399012.355163: wpa_driver_wext_set_psk
1255399012.355743: Association request to the driver failed
1255399012.355804: Setting authentication timeout: 5 sec 0 usec
1255399012.355834: EAPOL: External notification - EAP success=0
1255399012.355895: EAPOL: External notification - EAP fail=0
1255399012.355926: EAPOL: External notification - portControl=Auto
1255399012.355987: RSN: Ignored PMKID candidate without preauth flag
1255399012.356079: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399012.356109: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399012.356140: Wireless event: cmd=0x8b06 len=8
1255399012.356201: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399012.356231: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399012.356262: Wireless event: cmd=0x8b04 len=12
1255399017.361175: Authentication with 00:1f:3f:12:fa:7d timed out.
1255399017.361297: Added BSSID 00:1f:3f:12:fa:7d into blacklist
1255399017.361358: No keys have been configured - skip key clearing
1255399017.361389: State: ASSOCIATING -> DISCONNECTED
1255399017.361419: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
1255399017.361450: WEXT: Operstate: linkmode=-1, operstate=5
1255399017.361541: EAPOL: External notification - portEnabled=0
1255399017.361602: EAPOL: External notification - portValid=0
1255399017.361633: EAPOL: External notification - EAP success=0
1255399017.361694: Setting scan request: 0 sec 0 usec
1255399017.361755: State: DISCONNECTED -> SCANNING
1255399017.361785: Starting AP scan (broadcast SSID)
1255399017.361877: Scan requested (ret=0) - scan timeout 30 seconds
1255399019.308227: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399019.308380: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399019.308410: Wireless event: cmd=0x8b19 len=8
1255399019.308593: Received 245 bytes of scan results (1 BSSes)
1255399019.308654: CTRL-EVENT-SCAN-RESULTS
1255399019.308685: Selecting BSS from priority group 10
1255399019.308715: Try to find WPA-enabled AP
1255399019.308746: 0: 00:1f:3f:12:fa:7d ssid='WLAN-001F3F12FA7D' 
wpa_ie_len=24 rsn_ie_len=20 caps=0x11
1255399019.308807:    selected based on RSN IE
1255399019.308837:    selected WPA AP 00:1f:3f:12:fa:7d 
ssid='WLAN-001F3F12FA7D'
1255399019.308898: Trying to associate with 00:1f:3f:12:fa:7d 
(SSID='WLAN-001F3F12FA7D' freq=2462 MHz)
1255399019.308959: Cancelling scan request
1255399019.308990: WPA: clearing own WPA/RSN IE
1255399019.309539: Automatic auth_alg selection: 0x1
1255399019.309661: RSN: using IEEE 802.11i/D9.0
1255399019.309722: WPA: Selected cipher suites: group 8 pairwise 16 
key_mgmt 2 proto 2
1255399019.309753: WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 
f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50
1255399019.309844: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 
00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
1255399019.309936: WPA: using GTK TKIP
1255399019.309967: WPA: using PTK CCMP
1255399019.310028: WPA: using KEY_MGMT WPA-PSK
1255399019.310058: WPA: Set own WPA IE default - hexdump(len=22): 30 
14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f a0
1255399019.310150: No keys have been configured - skip key clearing
1255399019.310180: wpa_driver_wext_set_drop_unencrypted
1255399019.310241: State: SCANNING -> ASSOCIATING
1255399019.310272: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
1255399019.310302: WEXT: Operstate: linkmode=-1, operstate=5
1255399019.310394: wpa_driver_wext_associate
1255399019.310485: wpa_driver_wext_set_psk
1255399019.311035: Association request to the driver failed
1255399019.311096: Setting authentication timeout: 5 sec 0 usec
1255399019.311157: EAPOL: External notification - EAP success=0
1255399019.311218: EAPOL: External notification - EAP fail=0
1255399019.311248: EAPOL: External notification - portControl=Auto
1255399019.311309: RSN: Ignored PMKID candidate without preauth flag
1255399019.311340: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399019.311401: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399019.311431: Wireless event: cmd=0x8b06 len=8
1255399019.311462: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399019.311523: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399019.311553: Wireless event: cmd=0x8b04 len=12
1255399024.315399: Authentication with 00:1f:3f:12:fa:7d timed out.
1255399024.315521: BSSID 00:1f:3f:12:fa:7d blacklist count incremented 
to 2
1255399024.315582: No keys have been configured - skip key clearing
1255399024.315612: State: ASSOCIATING -> DISCONNECTED
1255399024.315643: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
1255399024.315673: WEXT: Operstate: linkmode=-1, operstate=5
1255399024.315765: EAPOL: External notification - portEnabled=0
1255399024.315826: EAPOL: External notification - portValid=0
1255399024.315856: EAPOL: External notification - EAP success=0
1255399024.315917: Setting scan request: 0 sec 0 usec
1255399024.315979: State: DISCONNECTED -> SCANNING
1255399024.316009: Starting AP scan (broadcast SSID)
1255399024.316070: Scan requested (ret=0) - scan timeout 30 seconds
1255399026.269378: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399026.269531: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399026.269592: Wireless event: cmd=0x8b19 len=8
1255399026.269744: Received 245 bytes of scan results (1 BSSes)
1255399026.269805: CTRL-EVENT-SCAN-RESULTS
1255399026.269836: Selecting BSS from priority group 10
1255399026.269866: Try to find WPA-enabled AP
1255399026.269897: 0: 00:1f:3f:12:fa:7d ssid='WLAN-001F3F12FA7D' 
wpa_ie_len=24 rsn_ie_len=20 caps=0x11
1255399026.269958:    skip - blacklisted
1255399026.269989: Try to find non-WPA AP
1255399026.270019: 0: 00:1f:3f:12:fa:7d ssid='WLAN-001F3F12FA7D' 
wpa_ie_len=24 rsn_ie_len=20 caps=0x11
1255399026.270050:    skip - blacklisted
1255399026.270080: No APs found - clear blacklist and try again
1255399026.270111: Removed BSSID 00:1f:3f:12:fa:7d from blacklist (clear)
1255399026.270141: Selecting BSS from priority group 10
1255399026.270172: Try to find WPA-enabled AP
1255399026.270202: 0: 00:1f:3f:12:fa:7d ssid='WLAN-001F3F12FA7D' 
wpa_ie_len=24 rsn_ie_len=20 caps=0x11
1255399026.270263:    selected based on RSN IE
1255399026.270294:    selected WPA AP 00:1f:3f:12:fa:7d 
ssid='WLAN-001F3F12FA7D'
1255399026.270355: Trying to associate with 00:1f:3f:12:fa:7d 
(SSID='WLAN-001F3F12FA7D' freq=2462 MHz)
1255399026.270416: Cancelling scan request
1255399026.270446: WPA: clearing own WPA/RSN IE
1255399026.271026: Automatic auth_alg selection: 0x1
1255399026.271148: RSN: using IEEE 802.11i/D9.0
1255399026.271179: WPA: Selected cipher suites: group 8 pairwise 16 
key_mgmt 2 proto 2
1255399026.271209: WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50
f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50
1255399026.271301: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00
00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
1255399026.271423: WPA: using GTK TKIP

1255399026.271453: WPA: using PTK CCMP

1255399026.271484: WPA: using KEY_MGMT WPA-PSK

1255399026.271514: WPA: Set own WPA IE default - hexdump(len=22): 30
14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f a0
1255399026.271606: No keys have been configured - skip key clearing

1255399026.271636: wpa_driver_wext_set_drop_unencrypted

1255399026.271697: State: SCANNING -> ASSOCIATING

1255399026.271728: wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
1255399026.271759: WEXT: Operstate: linkmode=-1, operstate=5

1255399026.271850: wpa_driver_wext_associate

1255399026.271942: wpa_driver_wext_set_psk

1255399026.272521: Association request to the driver failed

1255399026.272583: Setting authentication timeout: 5 sec 0 usec

1255399026.272613: EAPOL: External notification - EAP success=0

1255399026.272674: EAPOL: External notification - EAP fail=0

1255399026.272705: EAPOL: External notification - portControl=Auto

1255399026.272766: RSN: Ignored PMKID candidate without preauth flag

1255399026.272796: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])

1255399026.272857: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added

1255399026.272888: Wireless event: cmd=0x8b06 len=8

1255399026.272918: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])

1255399026.272949: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added

1255399026.273010: Wireless event: cmd=0x8b04 len=12

1255399031.276367: Authentication with 00:1f:3f:12:fa:7d timed out.

1255399031.276489: Added BSSID 00:1f:3f:12:fa:7d into blacklist

1255399031.276550: No keys have been configured - skip key clearing

1255399031.276580: State: ASSOCIATING -> DISCONNECTED

1255399031.276611: wpa_driver_wext_set_operstate: operstate 0->0
(DORMANT)
1255399031.276672: WEXT: Operstate: linkmode=-1, operstate=5

1255399031.276733: EAPOL: External notification - portEnabled=0

1255399031.276794: EAPOL: External notification - portValid=0

1255399031.276824: EAPOL: External notification - EAP success=0

1255399031.276885: Setting scan request: 0 sec 0 usec

1255399031.276947: State: DISCONNECTED -> SCANNING

1255399031.277008: Starting AP scan (broadcast SSID)

1255399031.277069: Scan requested (ret=0) - scan timeout 30 seconds

1255399033.226928: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])

1255399033.227081: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added

1255399033.227111: Wireless event: cmd=0x8b19 len=8

1255399033.227233: Received 0 bytes of scan results (0 BSSes)

1255399033.227294: CTRL-EVENT-SCAN-RESULTS

1255399033.227325: Selecting BSS from priority group 10

1255399033.227355: Try to find WPA-enabled AP

1255399033.227386: Try to find non-WPA AP

1255399033.227416: No APs found - clear blacklist and try again

1255399033.227447: Removed BSSID 00:1f:3f:12:fa:7d from blacklist
(clear)
1255399033.227478: Selecting BSS from priority group 10

1255399033.227508: Try to find WPA-enabled AP

1255399033.227539: Try to find non-WPA AP

1255399033.227569: No suitable AP found.

1255399033.227600: Setting scan request: 5 sec 0 usec

1255399038.229949: Starting AP scan (broadcast SSID)

1255399038.230102: Scan requested (ret=0) - scan timeout 30 seconds

1255399040.180603: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])

1255399040.180755: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added

1255399040.180786: Wireless event: cmd=0x8b19 len=8

1255399040.180908: Received 0 bytes of scan results (0 BSSes)

1255399040.180969: CTRL-EVENT-SCAN-RESULTS

1255399040.180999: Selecting BSS from priority group 10

1255399040.181030: Try to find WPA-enabled AP

1255399040.181060: Try to find non-WPA AP

1255399040.181091: No suitable AP found.

1255399040.181121: Setting scan request: 5 sec 0 usec

1255399045.182617: Starting AP scan (broadcast SSID)

1255399045.182800: Scan requested (ret=0) - scan timeout 30 seconds

1255399047.113372: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])

1255399047.113525: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added

1255399047.113555: Wireless event: cmd=0x8b19 len=8

1255399047.113739: Received 245 bytes of scan results (1 BSSes)

1255399047.113800: CTRL-EVENT-SCAN-RESULTS

1255399047.113830: Selecting BSS from priority group 10

1255399047.113861: Try to find WPA-enabled AP

1255399047.113891: 0: 00:1f:3f:12:fa:7d ssid='WLAN-001F3F12FA7D' 
wpa_ie_len=24 rsn_ie_len=20 caps=0x11
1255399047.113952:    selected based on RSN IE
1255399047.113983:    selected WPA AP 00:1f:3f:12:fa:7d 
ssid='WLAN-001F3F12FA7D'
1255399047.114044: Trying to associate with 00:1f:3f:12:fa:7d 
(SSID='WLAN-001F3F12FA7D' freq=2462 MHz)
1255399047.114105: Cancelling scan request
1255399047.114135: WPA: clearing own WPA/RSN IE
1255399047.114227: Automatic auth_alg selection: 0x1
1255399047.114288: RSN: using IEEE 802.11i/D9.0
1255399047.114349: WPA: Selected cipher suites: group 8 pairwise 16 
key_mgmt 2 proto 2
1255399047.114379: WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 
f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50
1255399047.114471: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 
00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
1255399047.114562: WPA: using GTK TKIP
1255399047.114593: WPA: using PTK CCMP
1255399047.114654: WPA: using KEY_MGMT WPA-PSK
1255399047.114685: WPA: Set own WPA IE default - hexdump(len=22): 30 
14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f a0
1255399047.114776: No keys have been configured - skip key clearing
1255399047.114807: wpa_driver_wext_set_drop_unencrypted
1255399047.114837: State: SCANNING -> ASSOCIATING
1255399047.114898: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
1255399047.114929: WEXT: Operstate: linkmode=-1, operstate=5
1255399047.114990: wpa_driver_wext_associate
1255399047.115112: wpa_driver_wext_set_psk
1255399047.115234: Association request to the driver failed
1255399047.115295: Setting authentication timeout: 5 sec 0 usec
1255399047.115325: EAPOL: External notification - EAP success=0
1255399047.115386: EAPOL: External notification - EAP fail=0
1255399047.115417: EAPOL: External notification - portControl=Auto
1255399047.115447: RSN: Ignored PMKID candidate without preauth flag
1255399047.116027: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399047.116088: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399047.116149: Wireless event: cmd=0x8b06 len=8
1255399047.116180: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
1255399047.116210: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
1255399047.116241: Wireless event: cmd=0x8b04 len=12
1255399052.120727: Authentication with 00:1f:3f:12:fa:7d timed out.
1255399052.120880: Added BSSID 00:1f:3f:12:fa:7d into blacklist
1255399052.120910: No keys have been configured - skip key clearing
1255399052.120941: State: ASSOCIATING -> DISCONNECTED


More information about the HostAP mailing list