WPA-PSK locks up at 4WAY_HANDSHAKE (2/4) / setting: ndiswrapper, ubuntu, WG511 (v1)

Tue Mar 14 04:56:29 PST 2006

Hi all,

I gratefully read on the wpa_supplicant homepage that I may use this
mailing list to ask topics not only related to hostap, but also e.g.
ndiswrapper in conjunction with wpa_supplicant, so I hope this is not
annoying for you...actually I couldnt get help in any kind of forum
for more that a week intensive posting - so I take this to the
experts.
 I've just searched the non-gzip'd archive, but my problem is slightly
different.
---

I'm trying to set up a wpa connection (Ubuntu 5.10) using the latest
releases of ndiswrapper and wpa_supplicant. The driver works fine with
wpa in windoze, and ndiswrapper confirms it correctly loaded (chipset
Intersil ISL3890 (netgear WG511 V1)).
if I do "wpa_supplicant -i wlan0 -D ndiswrapper -c
/etc/wpa_supplicant.conf -ddd" the 4WAY_HANDSHAKE state never
completes. when I read the output, several lines may indicate a faulty
setup (full output appended):

ioctl[SIOCSIWPMKSA]: No such device
>> this is not serious, afaik
SIOCGIWRANGE: too old (short) data - assuming WPA is not supported
>> ? - is this due to a faulty key? windoze successfully uses a 63char
ASCII code. I used wpa_passphrase to convert it to HEX.. anyway - it
continues:

ioctl[SIOCSIWENCODEEXT]: No such device
Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE
>> 4 times....

and in the end:
WPA: Sending EAPOL-Key 2/4
>> all the time. It seems like the AP doesnt accept the key and
wouldnt let me connect. is there a way to check that in detail.

I saw that Arjan van Bentem hostap at avbentem.dds.nl (post to the
maillist on Tue Apr 19 12:19:07 MDT 2005) had a quite similar problem
http://lists.shmoo.com/pipermail/hostap/2005-April/010113.html

I hope (and still believe) I just made a dump mistake during the
configuration, but I've tried so hard and it seems that I'm not yet
skilled enough to solve it. that's why I'd greatly appreciate any
input to this topic.
actually my neighbor (I share my connection with him) is just laughing
at me: "why the hell dont you wanna use windows"... well, he dosent
know a thing.

guys, I'm looking forward for you replies! feel free to request
further information... dont let me down, for my neighbors sake ;-)

seb

pasting complete terminal output:
---
sudo wpa_supplicant -i wlan0 -D ndiswrapper -c /etc/wpa_supplicant.conf -ddd

Initializing interface 'wlan0' conf '/etc/wpa_supplicant.conf' driver
'ndiswrapper'
Configuration file '/etc/wpa_supplicant.conf' -> '/etc/wpa_supplicant.conf'
Reading configuration file '/etc/wpa_supplicant.conf'
ctrl_interface='/var/run/wpa_supplicant'
ctrl_interface_group=0
eapol_version=1
ap_scan=1
fast_reauth=1
Line: 17 - start of a new network block
ssid - hexdump_ascii(len=7):
     57 47 2d 4e 65 74 7a                              WG-Netz
scan_ssid=1 (0x1)
proto: 0x1
key_mgmt: 0x2
PSK - hexdump(len=32): [REMOVED]
Priority group 0
   id=0 ssid='WG-Netz'
Initializing interface (2) 'wlan0'
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: KEY_RX entering state NO_KEY_RECEIVE
EAPOL: SUPP_BE entering state INITIALIZE
EAP: EAP entering state DISABLED
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
ioctl[SIOCSIWPMKSA]: No such device
SIOCGIWRANGE: too old (short) data - assuming WPA is not supported
Own MAC address: 00:09:5b:45:df:68
wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
ioctl[SIOCSIWENCODEEXT]: No such device
Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE
wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
ioctl[SIOCSIWENCODEEXT]: No such device
Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE
wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
ioctl[SIOCSIWENCODEEXT]: No such device
Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE
wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
ioctl[SIOCSIWENCODEEXT]: No such device
Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE
Setting scan request: 0 sec 100000 usec
Wireless event: cmd=0x8b06 len=8
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
Wireless event: cmd=0x8b2a len=12
Wireless event: cmd=0x8b2a len=12
Wireless event: cmd=0x8b2a len=12
Wireless event: cmd=0x8b2a len=12
State: DISCONNECTED -> SCANNING
Starting AP scan (specific SSID)
Scan SSID - hexdump_ascii(len=7):
     57 47 2d 4e 65 74 7a                              WG-Netz
Scan timeout - try to get results
Received 2307 bytes of scan results (9 BSSes)
Scan results: 9
Selecting BSS from priority group 0
0: 00:04:0e:7e:49:32 ssid='WG-Netz' wpa_ie_len=26 rsn_ie_len=0 caps=0x11
   selected
Trying to associate with 00:04:0e:7e:49:32 (SSID='WG-Netz' freq=2447 MHz)
Cancelling scan request
WPA: clearing own WPA/RSN IE
Automatic auth_alg selection: 0x1
WPA: using IEEE 802.11i/D3.0
WPA: Selected cipher suites: group 8 pairwise 8 key_mgmt 2
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 f2 02 00 00
WPA: clearing AP RSN IE
WPA: using GTK TKIP
WPA: using PTK TKIP
WPA: using KEY_MGMT WPA-PSK
WPA: Set own WPA IE default - hexdump(len=24): dd 16 00 50 f2 01 01 00
00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
No keys have been configured - skip key clearing
State: SCANNING -> ASSOCIATING
Setting authentication timeout: 5 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
Wireless event: cmd=0x8c02 len=169
Custom wireless event:
'ASSOCINFO(ReqIEs=000757472d4e65747a010402040b1632080c1218243048606cdd160050f20101000050f20201000050f20201000050f202
RespIEs=010482848b9632088c129824b048606c)'
Association info event
req_ies - hexdump(len=49): 00 07 57 47 2d 4e 65 74 7a 01 04 02 04 0b
16 32 08 0c 12 18 24 30 48 60 6c dd 16 00 50 f2 01 01 00 00 50 f2 02
01 00 00 50 f2 02 01 00 00 50 f2 02
resp_ies - hexdump(len=16): 01 04 82 84 8b 96 32 08 8c 12 98 24 b0 48 60 6c
WPA: set own WPA/RSN IE - hexdump(len=24): dd 16 00 50 f2 01 01 00 00
50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
Wireless event: cmd=0x8b15 len=20
Wireless event: new AP: 00:04:0e:7e:49:32
State: ASSOCIATING -> ASSOCIATED
Associated to a new BSS: BSSID=00:04:0e:7e:49:32
No keys have been configured - skip key clearing
Associated with 00:04:0e:7e:49:32
WPA: Association event - clear replay counter
EAPOL: External notification - portEnabled=0
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
EAPOL: External notification - portEnabled=1
EAPOL: SUPP_PAE entering state CONNECTING
EAPOL: txStart
WPA: drop TX EAPOL in non-IEEE 802.1X mode (type=1 len=0)
EAPOL: SUPP_BE entering state IDLE
EAP: EAP entering state INITIALIZE
EAP: EAP entering state IDLE
Setting authentication timeout: 10 sec 0 usec
RX EAPOL from 00:04:0e:7e:49:32
RX EAPOL - hexdump(len=99): 01 03 00 5f fe 00 89 00 20 00 00 00 00 00
00 00 01 ba 20 39 67 e7 f2 ee 4c 67 b8 96 16 bc 0d ea 04 17 e3 13 ae
c6 67 28 3d f7 a2 ab 3e 98 14 20 86 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Setting authentication timeout: 10 sec 0 usec
IEEE 802.1X RX: version=1 type=3 length=95
  EAPOL-Key type=254
WPA: RX EAPOL-Key - hexdump(len=99): 01 03 00 5f fe 00 89 00 20 00 00
00 00 00 00 00 01 ba 20 39 67 e7 f2 ee 4c 67 b8 96 16 bc 0d ea 04 17
e3 13 ae c6 67 28 3d f7 a2 ab 3e 98 14 20 86 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
State: ASSOCIATED -> 4WAY_HANDSHAKE
WPA: RX message 1 of 4-Way Handshake from 00:04:0e:7e:49:32 (ver=1)
WPA: WPA IE for msg 2/4 - hexdump(len=24): dd 16 00 50 f2 01 01 00 00
50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
WPA: Renewed SNonce - hexdump(len=32): 1d 3d 6d 10 76 eb c3 b0 c9 4a
39 8c 03 23 77 53 9b ed 8d 45 cf 8d 17 fa 78 4d 8c 4b 60 67 65 30
WPA: PMK - hexdump(len=32): [REMOVED]
WPA: PTK - hexdump(len=64): [REMOVED]
WPA: Sending EAPOL-Key 2/4
WPA: TX EAPOL-Key - hexdump(len=123): 01 03 ...
<<<<< to be repeated all the time .... (the hexdump values change, though)