wpa_supplicant not handshaking with wrtg54gs

Brian J. Murrell brian at interlinx.bc.ca
Thu Apr 21 12:53:14 EDT 2005


On Sat, 2005-04-16 at 20:54 -0700, Jouni Malinen wrote: 
> 
> Which firmware version are you using now (i.e., which version does not
> seem to work)?

v3.37.6

> What NDIS driver and which version of ndiswrapper are you
> using in the client?

ndiswrapper version 1.1 loaded (preempt=no,smp=no)
ndiswrapper: driver bcmwl5 (Broadcom,06/13/2003, 3.20.23.0) loaded
ACPI: PCI interrupt 0000:02:03.0[A] -> GSI 5 (level, low) -> IRQ 5
ndiswrapper: using irq 5
wlan0: ndiswrapper ethernet device 00:90:4b:b0:22:08 using driver
bcmwl5, configuration file 14E4:4301.5.conf
wlan0: encryption modes supported: WEP, WPA with TKIP

>  Would it be possible for you to test this AP with
> another driver than ndiswrapper+NDIS?

Sure.  Here is the hostap driver for my linksys card:

# /home/brian/hostap/wpa_supplicant/wpa_supplicant -t -d -D hostap -d -w -c /etc/wpa_supplicant.conf -i wlan1
Apr 17 21:37:56.495100: Initializing interface 'wlan1' conf '/etc/wpa_supplicant.conf' driver 'hostap'
Apr 17 21:37:56.497417: Configuration file '/etc/wpa_supplicant.conf' -> '/etc/wpa_supplicant.conf'
Apr 17 21:37:56.502665: Reading configuration file '/etc/wpa_supplicant.conf'
Apr 17 21:37:56.509043: eapol_version=1
Apr 17 21:37:56.510718: ap_scan=1
Apr 17 21:37:56.515644: fast_reauth=1
Apr 17 21:37:56.519816: Line: 464 - start of a new network block
Apr 17 21:37:56.544593: ssid - hexdump_ascii(len=5):
     69 6c 69 6e 78                                    ilinx           
Apr 17 21:37:56.550427: PSK - hexdump(len=32): [REMOVED]
Apr 17 21:37:56.554384: Line: 473 - start of a new network block
Apr 17 21:37:56.559027: ssid - hexdump_ascii(len=7):
     6c 69 6e 6b 73 79 73                              linksys         
Apr 17 21:37:56.594996: key_mgmt: 0x4
Apr 17 21:37:56.598981: PSK - hexdump(len=32): [REMOVED]
Apr 17 21:37:56.603291: Priority group 0
Apr 17 21:37:56.607259:    id=0 ssid='ilinx'
Apr 17 21:37:56.611198:    id=1 ssid='linksys'
Apr 17 21:37:56.615436: Initializing interface (2) 'wlan1'
Apr 17 21:37:56.645351: EAPOL: SUPP_PAE entering state DISCONNECTED
Apr 17 21:37:56.647221: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
Apr 17 21:37:56.651550: EAPOL: SUPP_BE entering state INITIALIZE
Apr 17 21:37:56.654924: EAP: EAP entering state DISABLED
Apr 17 21:37:56.659236: EAPOL: External notification - portEnabled=0
Apr 17 21:37:56.663466: EAPOL: External notification - portValid=0
ioctl[SIOCSIWPMKSA]: Operation not supported
Apr 17 21:37:56.696669: Own MAC address: 00:06:25:aa:65:2a
Apr 17 21:37:56.698460: wpa_driver_hostap_set_wpa: enabled=1
Apr 17 21:37:56.753749: wpa_driver_hostap_set_key: alg=none key_idx=0 set_tx=0 seq_len=0 key_len=0
Apr 17 21:37:56.755777: wpa_driver_hostap_set_key: alg=none key_idx=1 set_tx=0 seq_len=0 key_len=0
Apr 17 21:37:56.761505: wpa_driver_hostap_set_key: alg=none key_idx=2 set_tx=0 seq_len=0 key_len=0
Apr 17 21:37:56.765793: wpa_driver_hostap_set_key: alg=none key_idx=3 set_tx=0 seq_len=0 key_len=0
Apr 17 21:37:56.770302: wpa_driver_hostap_set_countermeasures: enabled=0
Apr 17 21:37:56.774263: wpa_driver_hostap_set_drop_unencrypted: enabled=1
Apr 17 21:37:56.774722: Setting scan request: 0 sec 100000 usec
Apr 17 21:37:56.776404: Wireless event: cmd=0x8b06 len=8
Apr 17 21:37:56.776975: RTM_NEWLINK, IFLA_IFNAME: Interface 'wifi0' added
Apr 17 21:37:56.777505: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan1' added
Apr 17 21:37:56.778044: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan1' added
Apr 17 21:37:56.876836: State: DISCONNECTED -> SCANNING
Apr 17 21:37:56.877027: Starting AP scan (broadcast SSID)
Apr 17 21:37:57.396306: Wireless event: cmd=0x8b19 len=12
Apr 17 21:37:57.396708: Received 259 bytes of scan results (1 BSSes)
Apr 17 21:37:57.396854: Scan results: 1
Apr 17 21:37:57.396976: Selecting BSS from priority group 0
Apr 17 21:37:57.397095: 0: 00:12:17:41:37:c8 ssid='ilinx' wpa_ie_len=24 rsn_ie_len=0 caps=0x11
Apr 17 21:37:57.397225:    selected
Apr 17 21:37:57.397351: Setting scan request: 10 sec 0 usec
Apr 17 21:38:07.398419: Starting AP scan (broadcast SSID)
Apr 17 21:38:07.826747: Wireless event: cmd=0x8b19 len=12
Apr 17 21:38:07.827089: Received 259 bytes of scan results (1 BSSes)
Apr 17 21:38:07.827217: Scan results: 1
Apr 17 21:38:07.827355: Selecting BSS from priority group 0
Apr 17 21:38:07.827476: 0: 00:12:17:41:37:c8 ssid='ilinx' wpa_ie_len=24 rsn_ie_len=0 caps=0x11
Apr 17 21:38:07.827608:    selected
Apr 17 21:38:07.827735: Setting scan request: 10 sec 0 usec
Apr 17 21:38:17.827948: Starting AP scan (broadcast SSID)
Apr 17 21:38:18.299240: Wireless event: cmd=0x8b19 len=12
Apr 17 21:38:18.299573: Received 259 bytes of scan results (1 BSSes)
Apr 17 21:38:18.299700: Scan results: 1
Apr 17 21:38:18.299826: Selecting BSS from priority group 0
Apr 17 21:38:18.299964: 0: 00:12:17:41:37:c8 ssid='ilinx' wpa_ie_len=24 rsn_ie_len=0 caps=0x11
Apr 17 21:38:18.300095:    selected
Apr 17 21:38:18.300223: Setting scan request: 10 sec 0 usec
Apr 17 21:38:28.300534: Starting AP scan (broadcast SSID)
Apr 17 21:38:28.724615: Wireless event: cmd=0x8b19 len=12
Apr 17 21:38:28.724955: Received 259 bytes of scan results (1 BSSes)
Apr 17 21:38:28.725082: Scan results: 1
Apr 17 21:38:28.725205: Selecting BSS from priority group 0
Apr 17 21:38:28.725325: 0: 00:12:17:41:37:c8 ssid='ilinx' wpa_ie_len=24 rsn_ie_len=0 caps=0x11
Apr 17 21:38:28.725471:    selected
Apr 17 21:38:28.725598: Setting scan request: 10 sec 0 usec
Apr 17 21:38:38.726110: Starting AP scan (broadcast SSID)
Apr 17 21:38:39.197619: Wireless event: cmd=0x8b19 len=12
Apr 17 21:38:39.197984: Received 259 bytes of scan results (1 BSSes)
Apr 17 21:38:39.198112: Scan results: 1
Apr 17 21:38:39.198239: Selecting BSS from priority group 0
Apr 17 21:38:39.198360: 0: 00:12:17:41:37:c8 ssid='ilinx' wpa_ie_len=24 rsn_ie_len=0 caps=0x11
Apr 17 21:38:39.198494:    selected
Apr 17 21:38:39.198618: Setting scan request: 10 sec 0 usec
Apr 17 21:38:49.199662: Starting AP scan (broadcast SSID)
Apr 17 21:38:49.718261: Wireless event: cmd=0x8b19 len=12
Apr 17 21:38:49.718635: Received 259 bytes of scan results (1 BSSes)
Apr 17 21:38:49.718762: Scan results: 1
Apr 17 21:38:49.718886: Selecting BSS from priority group 0
Apr 17 21:38:49.719007: 0: 00:12:17:41:37:c8 ssid='ilinx' wpa_ie_len=24 rsn_ie_len=0 caps=0x11
Apr 17 21:38:49.719139:    selected
Apr 17 21:38:49.719265: Setting scan request: 10 sec 0 usec
Apr 17 21:38:59.721129: Starting AP scan (broadcast SSID)
Apr 17 21:39:00.059968: Wireless event: cmd=0x8b19 len=12
Apr 17 21:39:00.060327: Received 259 bytes of scan results (1 BSSes)
Apr 17 21:39:00.060456: Scan results: 1
Apr 17 21:39:00.060583: Selecting BSS from priority group 0
Apr 17 21:39:00.060706: 0: 00:12:17:41:37:c8 ssid='ilinx' wpa_ie_len=24 rsn_ie_len=0 caps=0x11
Apr 17 21:39:00.060837:    selected
Apr 17 21:39:00.060963: Setting scan request: 10 sec 0 usec
Apr 17 21:39:01.672852: Signal 2 received - terminating
Apr 17 21:39:01.674599: State: SCANNING -> DISCONNECTED
Apr 17 21:39:01.674998: No keys have been configured - skip key clearing
Apr 17 21:39:01.675135: EAPOL: External notification - portEnabled=0
Apr 17 21:39:01.679888: EAPOL: External notification - portValid=0
Apr 17 21:39:01.680045: wpa_driver_hostap_set_wpa: enabled=0
Apr 17 21:39:01.727404: wpa_driver_hostap_set_drop_unencrypted: enabled=0
Apr 17 21:39:01.729251: wpa_driver_hostap_set_countermeasures: enabled=0

I'm not sure if that "ioctl[SIOCSIWPMKSA]: Operation not supported" is
part of the wpa_supplicant output, it's stderr or what but it was
interspersed in the output so I figured to include it.

Here is the iwlist scan using it:

wlan1     Scan completed :
          Cell 01 - Address: 00:12:17:41:37:C8
                    ESSID:"ilinx"
                    Mode:Master
                    Frequency:2.437 GHz (Channel 6)
                    Quality:0/70  Signal level:-36 dBm  Noise level:-86 dBm
                    Encryption key:on
                    Bit Rate:1 Mb/s
                    Bit Rate:2 Mb/s
                    Bit Rate:5.5 Mb/s
                    Bit Rate:11 Mb/s
                    Bit Rate:18 Mb/s
                    Bit Rate:24 Mb/s
                    Bit Rate:36 Mb/s
                    Bit Rate:54 Mb/s
                    Extra:bcn_int=100
                    Extra:resp_rate=10
                    Extra:wpa_ie=******

Any more ideas?

b.

-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-signature
Size: 189 bytes
Desc: This is a digitally signed message part
Url : http://lists.shmoo.com/pipermail/hostap/attachments/20050421/d68fa0bd/attachment.pgp 


More information about the HostAP mailing list