iwi, hidden SSID and wpa_supplicant problem

Goran Lowkrantz goran.lowkrantz at ismobile.com
Mon Oct 9 15:12:56 UTC 2006


I have the same problem with an IBM R50 laptop and the iwi driver. From 
dmesg

iwi0: <Intel(R) PRO/Wireless 2915ABG> mem 0xc0214000-0xc0214fff irq 9 at 
device 2.0 on pci2

I have never been able to connect to a hidden SSID without giving the 
BSSID. If I give the BSSID I can get connection but it takes a long time 
and is not reliable as the driver looses connection and failes to 
re-connect after a while.

When connected to an AP that broadcasts the SSID I still lose connection 
after a couple of hours and have to stop and restart the connection.  Here 
is the sequiece from the console:

iwi0: link state changed to DOWN
iwi0: scan stuck
iwi0: link state changed to UP
iwi0: link state changed to DOWN
iwi0: link state changed to UP
iwi0: firmware error
iwi0: link state changed to DOWN
iwi0: scan stuck
iwi0: link state changed to UP
iwi0: link state changed to DOWN
iwi0: link state changed to UP
iwi0: firmware error
iwi0: link state changed to DOWN
iwi0: scan stuck
iwi0: could not allocate firmware DMA memory
# /etc/rc.d/netif stop iwi0
Stopping network:Stopping wpa_supplicant.
Waiting for PIDS: 324.
 iwi0.
# /etc/rc.d/netif start iwi0
Starting wpa_supplicant.
DHCPDISCOVER on iwi0 to 255.255.255.255 port 67 interval 7
iwi0: link state changed to UP
DHCPDISCOVER on iwi0 to 255.255.255.255 port 67 interval 7
DHCPDISCOVER on iwi0 to 255.255.255.255 port 67 interval 19
DHCPOFFER from 10.255.253.253
DHCPREQUEST on iwi0 to 255.255.255.255 port 67
DHCPACK from 10.255.253.253
bound to 10.255.253.200 -- renewal in 300 seconds.
iwi0: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> mtu 1500
        inet6 fe80::216:6fff:fe8b:a21%iwi0 prefixlen 64 scopeid 0x2
        inet 10.255.253.200 netmask 0xffffff00 broadcast 10.255.253.255
        ether 00:16:6f:8b:0a:21
        media: IEEE 802.11 Wireless Ethernet autoselect (DS/2Mbps)
        status: associated
        ssid SSID channel 11 bssid xx:xx:xx:xx:xx:xx
        authmode WPA privacy ON deftxkey UNDEF TKIP 2:128-bit txpowmax 100
        bmiss 10 protmode CTS roaming MANUAL bintval 100

The first couple of times it recovers on it self but after receiving iwi0: 
could not allocate firmware DMA memory I always have to restart the 
connection manually.

The kernel is built with option INVARIANTS and option INVARIANT_SUPPORT.

> uname -a
FreeBSD viglaf 6.2-PRERELEASE FreeBSD 6.2-PRERELEASE #62: Thu Oct  5 
10:35:57 CEST 2006     root at viglaf:/usr/obj/usr/src/sys/VIGLAF  i386


> pkg_info -Ix iwi
iwi-firmware-kmod-3.0_1 Intel PRO/Wireless 2200 Firmware Kernel Module

dmesg attached.


/glz

--On Monday, October 09, 2006 18:35:40 +0400 "Andrew N. Below" 
<defan at zenon.net> wrote:

> Hi.
>
> I have an Asus V6V (V6800) laptop with Intel wireless adapter:
> iwi0: <Intel(R) PRO/Wireless 2200BG
>
> and FreeBSD installed:
>
> defanbook# uname -v
> FreeBSD 6.2-PRERELEASE #3: Mon Oct  9 17:40:59 UTC 2006
>
> I want to connect to access point (cisco 350) with
> hidden (not broadcasted) SSID using WPA/TKIP authentication
> but still got no success.
>
> Here is my wpa_supplicant.conf:
>
> =======================
> ctrl_interface=/var/run/wpa_supplicant
> ctrl_interface_group=0
> eapol_version=1
> ap_scan=1
> fast_reauth=1
>
> network={
>         ssid="MY-SSID"
>         scan_ssid=1
>         key_mgmt=WPA-PSK
>         proto=WPA
>         pairwise=TKIP
>         group=TKIP
>         psk="PASSPHRASE"
>         phase2="auth=MSCHAPV2"
> }
> =======================
>
> Here is wpa_supplicant output:
>
> defanbook# wpa_supplicant -ddKt -i iwi0 -c /etc/wpa_supplicant.conf
> Oct 09 18:24:41.247941: Initializing interface 'iwi0' conf
> '/etc/wpa_supplicant.conf' driver 'default' ctrl_interface 'N/A'
> Oct 09 18:24:41.248083: Configuration file '/etc/wpa_supplicant.conf' ->
> '/etc/wpa_supplicant.conf'
> Oct 09 18:24:41.248094: Reading configuration file
> '/etc/wpa_supplicant.conf'
> Oct 09 18:24:41.248129: ctrl_interface='/var/run/wpa_supplicant'
> Oct 09 18:24:41.248473: ctrl_interface_group=0
> Oct 09 18:24:41.248490: eapol_version=1
> Oct 09 18:24:41.248497: ap_scan=1
> Oct 09 18:24:41.248503: fast_reauth=1
> Oct 09 18:24:41.248510: Line: 7 - start of a new network block
> Oct 09 18:24:41.248520: ssid - hexdump_ascii(len=11):
> [..]
> Oct 09 18:24:41.248535: scan_ssid=1 (0x1)
> Oct 09 18:24:41.248552: key_mgmt: 0x2
> Oct 09 18:24:41.248559: proto: 0x1
> Oct 09 18:24:41.248567: pairwise: 0x8
> Oct 09 18:24:41.248573: group: 0x8
> Oct 09 18:24:41.248586: PSK (ASCII passphrase) - hexdump_ascii(len=9):
> [..]
> Oct 09 18:24:41.248601: phase2 - hexdump_ascii(len=13):
>      61 75 74 68 3d 4d 53 43 48 41 50 56 32            auth=MSCHAPV2
> Oct 09 18:24:41.269142: PSK (from passphrase) - hexdump(len=32): c4 47 52
> 5b 8c 7d 47 21 1a bc 2f 75 dd 1d 69 c6 aa c8 33 02 23 70 e1 0a e3 6d be
> 5b 1f 1f 92 d9
> Oct 09 18:24:41.269174: Priority group 0
> Oct 09 18:24:41.269181:    id=0 ssid='MY-SSID'
> Oct 09 18:24:41.269190: Initializing interface (2) 'iwi0'
> Oct 09 18:24:41.271574: EAPOL: SUPP_PAE entering state DISCONNECTED
> Oct 09 18:24:41.271584: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
> Oct 09 18:24:41.271590: EAPOL: SUPP_BE entering state INITIALIZE
> Oct 09 18:24:41.271597: EAP: EAP entering state DISABLED
> Oct 09 18:24:41.271636: EAPOL: External notification - portEnabled=0
> Oct 09 18:24:41.271657: EAPOL: External notification - portValid=0
> Oct 09 18:24:41.271918: Own MAC address: 00:12:f0:3d:cd:58
> Oct 09 18:24:41.271929: wpa_driver_bsd_set_wpa: enabled=1
> Oct 09 18:24:41.271936: wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1
> Oct 09 18:24:41.271946: wpa_driver_bsd_del_key: keyidx=0
> Oct 09 18:24:41.271954: wpa_driver_bsd_del_key: keyidx=1
> Oct 09 18:24:41.271962: wpa_driver_bsd_del_key: keyidx=2
> Oct 09 18:24:41.271969: wpa_driver_bsd_del_key: keyidx=3
> Oct 09 18:24:41.271977: wpa_driver_bsd_set_countermeasures: enabled=0
> Oct 09 18:24:41.271984: wpa_driver_bsd_set_drop_unencrypted: enabled=1
> Oct 09 18:24:41.271994: Setting scan request: 0 sec 100000 usec
> Oct 09 18:24:41.272118: Added interface iwi0
> Oct 09 18:24:41.372226: State: DISCONNECTED -> SCANNING
> Oct 09 18:24:41.372235: Starting AP scan (specific SSID)
> Oct 09 18:24:41.372242: Scan SSID - hexdump_ascii(len=11):
> [MY-SSID]
> Oct 09 18:24:43.021948: Received 0 bytes of scan results (4 BSSes)
> Oct 09 18:24:43.021982: Scan results: 4
> Oct 09 18:24:43.021992: Selecting BSS from priority group 0
> Oct 09 18:24:43.021998: 0: 00:07:0e:b8:d8:ee ssid='' wpa_ie_len=26
> rsn_ie_len=0 caps=0x31
> Oct 09 18:24:43.022008:    skip - SSID mismatch
> Oct 09 18:24:43.022014: 1: 02:3f:2d:21:0e:c2 ssid='ANY' wpa_ie_len=0
> rsn_ie_len=0 caps=0x2
> Oct 09 18:24:43.022023:    skip - no WPA/RSN IE
> Oct 09 18:24:43.022029: 2: 00:60:b3:d4:0d:76 ssid='ADSL_Wireless'
> wpa_ie_len=0 rsn_ie_len=0 caps=0x61
> Oct 09 18:24:43.022038:    skip - no WPA/RSN IE
> Oct 09 18:24:43.022044: 3: 00:14:6c:55:24:4a ssid='' wpa_ie_len=0
> rsn_ie_len=0 caps=0x11
> Oct 09 18:24:43.022052:    skip - no WPA/RSN IE
> Oct 09 18:24:43.022058: No suitable AP found.
> Oct 09 18:24:43.022066: Setting scan request: 5 sec 0 usec
> Oct 09 18:24:48.023226: Starting AP scan (broadcast SSID)
> Oct 09 18:24:49.501060: Received 0 bytes of scan results (2 BSSes)
> Oct 09 18:24:49.501070: Scan results: 2
> Oct 09 18:24:49.501077: Selecting BSS from priority group 0
> Oct 09 18:24:49.501083: 0: 00:07:0e:b8:d8:ee ssid='' wpa_ie_len=26
> rsn_ie_len=0 caps=0x31
> Oct 09 18:24:49.501092:    skip - SSID mismatch
> Oct 09 18:24:49.501098: 1: 00:14:6c:55:24:4a ssid='' wpa_ie_len=0
> rsn_ie_len=0 caps=0x11
> Oct 09 18:24:49.501106:    skip - no WPA/RSN IE
> Oct 09 18:24:49.501112: No suitable AP found.
> Oct 09 18:24:49.501118: Setting scan request: 5 sec 0 usec
> ^COct 09 18:24:52.082178: CTRL-EVENT-TERMINATING - signal 2 received
> Oct 09 18:24:52.082190: Removing interface iwi0
> Oct 09 18:24:52.082197: State: SCANNING -> DISCONNECTED
> Oct 09 18:24:52.082204: No keys have been configured - skip key clearing
> Oct 09 18:24:52.082210: EAPOL: External notification - portEnabled=0
> Oct 09 18:24:52.082282: EAPOL: External notification - portValid=0
> Oct 09 18:24:52.082315: wpa_driver_bsd_set_wpa: enabled=0
> Oct 09 18:24:52.082321: wpa_driver_bsd_set_wpa_internal: wpa=0 privacy=0
> Oct 09 18:24:52.082333: wpa_driver_bsd_set_drop_unencrypted: enabled=0
> Oct 09 18:24:52.082341: wpa_driver_bsd_set_countermeasures: enabled=0
> Oct 09 18:24:52.082348: No keys have been configured - skip key clearing
> Oct 09 18:24:52.082463: wpa_driver_bsd_set_wpa_internal: wpa=0 privacy=0
> Oct 09 18:24:52.082851: Cancelling scan request
>
> As we can see, it just repeats specific and broadcast SSID scan
> in cycle, but always says "No suitable AP found" and "SSID mismatch".
> While this process is running I can see more and more
> "Number of frames with a bad CRC receive" with the iwicontrol utility.
>
> On another FreeBSD box with 6.1-release and same version of
> wpa_supplicant, but with another USB wireless device (ural) all works
> fine.
>
> Wireless connection in winxp on this laptop works fine too.
>
> Any ideas?
>
> --
> Andrew N. Below
> Zenon N.S.P.
>
> _______________________________________________
> freebsd-stable at freebsd.org mailing list
> http://lists.freebsd.org/mailman/listinfo/freebsd-stable
> To unsubscribe, send any mail to "freebsd-stable-unsubscribe at freebsd.org"



-- 
................................................... the future isMobile

  Goran Lowkrantz <goran.lowkrantz at ismobile.com>
  System Architect, isMobile, Aurorum 2, S-977 75 Lule¥, Sweden
  Phone: +46(0)920-75559
  Mobile: +46(0)70-587 87 82 Fax: +46(0)70-615 87 82

http://www.ismobile.com ...............................................
-------------- next part --------------
A non-text attachment was scrubbed...
Name: dmesg.boot
Type: application/octet-stream
Size: 7638 bytes
Desc: not available
Url : http://lists.freebsd.org/pipermail/freebsd-stable/attachments/20061009/7a35c7d6/dmesg.obj


More information about the freebsd-stable mailing list