WPA-PSK only getting to EAPOL-Key 2/4

Diederick van Dijk diedvdyk
Sun Oct 17 04:32:25 PDT 2004 

Hi,

I'm trying to use WPA-PSK with an Intel ipw2100 wireless lancard to a brand 
new SpeedTouch 580i. My problem is that the authentication only gets to step 
2 of 4. I suspect that this has something to do that the lancard associates 
with the mac address of the accesspoint (00:90:96:cd:a2:ff) and that the 
answers to the authentication messages are from the internal mac address 
(00:0e:50:27:14:0c) of the hub in the accesspoint.
I've tried the ipw2100 driver and the ndiswrapper driver for the lancard, 
version 0.2.4, 0.2.5 and the latest CVS from wpa_supplicant, all give the 
same result.

Thanks,

Diederick van Dijk

-- config
ctrl_interface=/var/run/wpa_supplicant
network={
        ssid="van54dijk"
        proto=WPA
        key_mgmt=WPA-PSK
        psk="diederick"
        pairwise=TKIP
        group=TKIP
}

-- debug log
[root at darkvader wpa_supplicant]# ./wpa_supplicant -Dndiswrapper -ieth1 
-c/etc/wpa_supplicant.conf -dddd
Configuration file '/etc/wpa_supplicant.conf' -> '/etc/wpa_supplicant.conf'
Reading configuration file '/etc/wpa_supplicant.conf'
ctrl_interface='/var/run/wpa_supplicant'
Line: 2 - start of a new network block
ssid - hexdump_ascii(len=9):
     76 61 6e 35 34 64 69 6a 6b                        van54dijk
proto: 0x1
key_mgmt: 0x2
PSK (ASCII passphrase) - hexdump_ascii(len=9):
     64 69 65 64 65 72 69 63 6b                        diederick
pairwise: 0x8
group: 0x8
PSK (from passphrase) - hexdump(len=32): e8 c6 e3 6a 01 80 b0 1e 84 54 f3 c6 
27 5c 80 44 38 46 5c e5 6a 14 db 7f 99 2b 62 a1 4a 78 86 9f
Priority group 0
   id=0 ssid='van54dijk'
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
Own MAC address: 00:04:23:61:a9:72
Setting scan request: 0 sec 100000 usec
Starting AP scan (broadcast SSID)
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=0 idleWhile=0
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=0 idleWhile=0
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=0 idleWhile=0
Scan timeout - try to get results
Received 453 bytes of scan results (2 BSSes)
Scan results: 2
Selecting BSS from priority group 0
0: 00:90:96:cd:a2:ff ssid='van54dijk' wpa_ie_len=24 rsn_ie_len=0
   selected
Trying to associate with 00:90:96:cd:a2:ff (SSID='van54dijk' freq=2412 MHz)
Cancelling scan request
Automatic auth_alg selection: 0x1
WPA: using IEEE 802.11i/D3.0
WPA: using GTK TKIP
WPA: using PTK TKIP
WPA: using KEY_MGMT WPA-PSK
WPA: Own WPA 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
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=171
Custom wireless event: 
'ASSOCINFO(ReqIEs=000976616e353464696a6b010482848b96dd180050f20101000050f20201000050f20201000050f2020000 
RespIEs=010882848b962430486c32040c121860dd050010180100)'
Association info event
req_ies - hexdump(len=43): 00 09 76 61 6e 35 34 64 69 6a 6b 01 04 82 84 8b 96 
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
resp_ies - hexdump(len=23): 01 08 82 84 8b 96 24 30 48 6c 32 04 0c 12 18 60 dd 
05 00 10 18 01 00
assoc_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
Wireless event: cmd=0x8b15 len=20
Wireless event: new AP: 00:90:96:cd:a2:ff
Association event - clear replay counter
Associated to a new BSS: BSSID=00:90:96:cd:a2:ff
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
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=29 idleWhile=59
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=28 idleWhile=58
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=27 idleWhile=57
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=26 idleWhile=56
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=25 idleWhile=55
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=24 idleWhile=54
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=23 idleWhile=53
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=22 idleWhile=52
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=21 idleWhile=51
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=20 idleWhile=50
Authentication with 00:90:96:cd:a2:ff timed out.
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
Starting AP scan (broadcast SSID)
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=19 idleWhile=49
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=18 idleWhile=48
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=17 idleWhile=47
Scan timeout - try to get results
Received 636 bytes of scan results (3 BSSes)
Scan results: 3
Selecting BSS from priority group 0
0: 00:90:96:cd:a2:ff ssid='van54dijk' wpa_ie_len=24 rsn_ie_len=0
   selected
Trying to associate with 00:90:96:cd:a2:ff (SSID='van54dijk' freq=2412 MHz)
Cancelling scan request
Automatic auth_alg selection: 0x1
WPA: using IEEE 802.11i/D3.0
WPA: using GTK TKIP
WPA: using PTK TKIP
WPA: using KEY_MGMT WPA-PSK
WPA: Own WPA 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
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=171
Custom wireless event: 
'ASSOCINFO(ReqIEs=000976616e353464696a6b010482848b96dd180050f20101000050f20201000050f20201000050f2020000 
RespIEs=010882848b962430486c32040c121860dd050010180100)'
Association info event
req_ies - hexdump(len=43): 00 09 76 61 6e 35 34 64 69 6a 6b 01 04 82 84 8b 96 
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
resp_ies - hexdump(len=23): 01 08 82 84 8b 96 24 30 48 6c 32 04 0c 12 18 60 dd 
05 00 10 18 01 00
assoc_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
Wireless event: cmd=0x8b15 len=20
Wireless event: new AP: 00:90:96:cd:a2:ff
Association event - clear replay counter
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:0e:50:27:14:0c
RX EAPOL - hexdump(len=99): 01 03 00 5f fe 00 89 00 20 00 00 00 00 00 00 00 00 
4f d5 9f 46 ca b7 83 f2 f2 9b b8 92 7a 78 c9 1d fc 7d 86 6e 54 03 55 60 24 e9 
16 f5 14 2c 13 da 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
EAPOL: Ignoring WPA EAPOL-Key frame in EAPOL state machines
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 00 4f d5 9f 46 ca b7 83 f2 f2 9b b8 92 7a 78 c9 1d fc 7d 86 6e 54 03 55 
60 24 e9 16 f5 14 2c 13 da 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
WPA: RX message 1 of 4-Way Handshake from 00:0e:50:27:14:0c (ver=1)
WPA: Renewed SNonce - hexdump(len=32): a1 de f3 d5 f5 03 89 c2 93 78 1a 3a ad 
55 ca 04 60 55 33 70 40 0d 3c a0 67 db ba 76 c3 0c 37 a8
WPA: PMK - hexdump(len=32): e8 c6 e3 6a 01 80 b0 1e 84 54 f3 c6 27 5c 80 44 38 
46 5c e5 6a 14 db 7f 99 2b 62 a1 4a 78 86 9f
WPA: PTK - hexdump(len=64): d9 60 b1 04 8a fa 76 2c 94 3f 43 57 91 6b 60 12 64 
b8 e8 b9 10 ee 96 94 0f 00 da 76 75 13 32 62 68 bf a5 b6 0f 69 97 10 7e 9b f1 
f1 ee 32 30 59 fc 29 bb 2b a3 c3 87 9e 04 e7 15 86 ec bd 86 6b
WPA: EAPOL-Key MIC - hexdump(len=16): 7d ad 65 75 56 79 6d 8f 0f dc ac 11 00 
da 40 bc
WPA: Sending EAPOL-Key 2/4
WPA: TX EAPOL-Key 2/4 - hexdump(len=139): 00 0e 50 27 14 0c 00 04 23 61 a9 72 
88 8e 01 03 00 79 fe 01 09 00 20 00 00 00 00 00 00 00 00 a1 de f3 d5 f5 03 89 
c2 93 78 1a 3a ad 55 ca 04 60 55 33 70 40 0d 3c a0 67 db ba 76 c3 0c 37 a8 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 7d ad 65 75 56 79 6d 8f 0f dc ac 11 00 da 40 bc 00 1a 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
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=29 idleWhile=59
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=28 idleWhile=58
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=27 idleWhile=57
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=26 idleWhile=56
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=25 idleWhile=55
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=24 idleWhile=54
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=23 idleWhile=53
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=22 idleWhile=52
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=21 idleWhile=51
EAPOL: Port Timers tick - authWhile=0 heldWhile=0 startWhen=20 idleWhile=50
Authentication with 00:90:96:cd:a2:ff timed out.

More information about the Hostap mailing list