wpa and dlink di-614+

Thu Dec 8 11:54:34 PST 2005

I cannot connect a FreeBSD 6.0-RC1 machine using WPA to a D-Link DI-614+ 
router.  My Macintosh Powerbook is able to connect to this device with WPA.  
I am able to use my FreeBSD machine and WPA successfully against a Linksys 
WRT54G and D-Link DI-624, but the DI-614+ is giving me trouble.

wpa_supplicant pauses when wpa_driver_bsd_set_key is called, and then it 
disassociates.  Strangely, the DI-614+ log file says that my machine 
authenticated successfully.  It looks as if wpa_supplicant is dropping the 
connection unilaterally with "reason 8".

Per this post 
(http://www.linuxquestions.org/questions/showthread.php?t=268427), my SSID 
broadcast is enabled, and ap_scan defaults to 1.  I did not receive a reply 
to the freebsd-mobile list.

access point: d-link di-614+ revB2 firmware 3.43 (latest)
client nic: dwl-g520revB

# uname -a
FreeBSD canary 6.0-RC1 FreeBSD 6.0-RC1 #2: Tue Nov  1 23:29:30 CST 2005
jake at canary:/usr/src/sys/i386/compile/CANARY  i386

# dmesg | grep ath0 | head
ath0: <Atheros 5212> mem 0xf5000000-0xf500ffff irq 17 at device 14.0 on pci0
ath0: Ethernet address: 00:11:95:92:72:55
ath0: mac 7.9 phy 4.5 radio 5.6

# kldstat
Id Refs Address    Size     Name
1   11 0xc0400000 68be4c   kernel
2   16 0xc0a8c000 568bc    acpi.ko
3    1 0xc1ce5000 4000     wlan_tkip.ko
4    1 0xc1dd6000 15000    linux.ko
5    1 0xc20f6000 7000     wlan_ccmp.ko

# cat /usr/local/etc/wpa_supplicant.conf
network={
        ssid="yagi"
        scan_ssid=1
        proto=WPA
        key_mgmt=WPA-PSK
        psk="my-secret-key"
}

# wpa_supplicant -v
wpa_supplicant v0.3.9

# wpa_supplicant -d -c /usr/local/etc/wpa_supplicant.conf -i ath0
Initializing interface 'ath0' conf '/usr/local/etc/wpa_supplicant.conf' 
driver 'default'
Configuration file '/usr/local/etc/wpa_supplicant.conf' -> 
'/usr/local/etc/wpa_supplicant.conf'
Reading configuration file '/usr/local/etc/wpa_supplicant.conf'
Priority group 0
   id=0 ssid='yagi'
Initializing interface (2) 'ath0'
Own MAC address: 00:11:95:92:72:55
wpa_driver_bsd_set_wpa: enabled=1
wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
wpa_driver_bsd_del_key: keyidx=0
wpa_driver_bsd_del_key: keyidx=1
wpa_driver_bsd_del_key: keyidx=2
wpa_driver_bsd_del_key: keyidx=3
wpa_driver_bsd_set_countermeasures: enabled=0
wpa_driver_bsd_set_drop_unencrypted: enabled=1
Setting scan request: 0 sec 100000 usec
Starting AP scan (specific SSID)
Scan SSID - hexdump_ascii(len=4):
     79 61 67 69                                       yagi
Received 0 bytes of scan results (1 BSSes)
Scan results: 1
Selecting BSS from priority group 0
0: 00:0d:88:9b:87:3e ssid='yagi' wpa_ie_len=26 rsn_ie_len=0
   selected
Trying to associate with 00:0d:88:9b:87:3e (SSID='yagi' freq=2417 MHz)
Cancelling scan request
Automatic auth_alg selection: 0x1
WPA: using IEEE 802.11i/D3.0
WPA: Selected cipher suites: group 8 pairwise 8 key_mgmt 2
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
No keys have been configured - skip key clearing
wpa_driver_bsd_set_drop_unencrypted: enabled=1
wpa_driver_bsd_associate: ssid 'yagi' wpa ie len 24 pairwise 2 group 2 key 
mgmt 1
wpa_driver_bsd_associate: set PRIVACY 1
Setting authentication timeout: 5 sec 0 usec
Association event - clear replay counter
Associated to a new BSS: BSSID=00:0d:88:9b:87:3e
No keys have been configured - skip key clearing
Associated with 00:0d:88:9b:87:3e
Setting authentication timeout: 10 sec 0 usec
RX EAPOL from 00:0d:88:9b:87:3e
Setting authentication timeout: 10 sec 0 usec
IEEE 802.1X RX: version=1 type=3 length=95
  EAPOL-Key type=254
WPA: RX message 1 of 4-Way Handshake from 00:0d:88:9b:87:3e (ver=1)
WPA: Renewed SNonce - hexdump(len=32): 88 7f 82 24 56 73 eb f6 79 35 31 60 
fa 67 f4 ba bf f9 ec c4 f1 28 95 73 43 e4 20 b8 bd 1f 4c 95
WPA: PMK - hexdump(len=32): [REMOVED]
WPA: PTK - hexdump(len=64): [REMOVED]
WPA: EAPOL-Key MIC - hexdump(len=16): e8 b5 c4 53 e9 fb 5f 33 0d f5 76 13 dc 
ff c1 1f
WPA: Sending EAPOL-Key 2/4
RX EAPOL from 00:0d:88:9b:87:3e
IEEE 802.1X RX: version=1 type=3 length=121
  EAPOL-Key type=254
WPA: RX message 3 of 4-Way Handshake from 00:0d:88:9b:87:3e (ver=1)
WPA: IE KeyData - 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: Sending EAPOL-Key 4/4
WPA: Installing PTK to the driver.
WPA: RSC - hexdump(len=6): 00 00 00 00 00 00
wpa_driver_bsd_set_key: alg=TKIP addr=00:0d:88:9b:87:3e key_idx=0 set_tx=1 
seq_len=6 key_len=32
Authentication with 00:0d:88:9b:87:3e timed out.
Added BSSID 00:0d:88:9b:87:3e into blacklist
wpa_driver_bsd_disassociate
wpa_driver_bsd_del_key: keyidx=0
wpa_driver_bsd_del_key: keyidx=1
wpa_driver_bsd_del_key: keyidx=2
wpa_driver_bsd_del_key: keyidx=3
wpa_driver_bsd_del_key: addr=00:0d:88:9b:87:3e keyidx=0
ioctl[SIOCS80211, op 20, len 7]: Can't assign requested address
(repeat)

# 80211debug
net.wlan.0.debug: 0xc01000<assoc,auth,wpa>
ath0: [00:0d:88:9b:87:3e] recv auth frame with algorithm 0 seq 2
ath0: [00:0d:88:9b:87:3e] assoc success: long preamble, long slot time
ath0: link state changed to UP
ath0: [00:0d:88:9b:87:3e] send station disassociate (reason 8)
ath0: link state changed to DOWN