[pkg-wpa-devel] Bug#590566: Bug#590566: wpasupplicant: wpa authentication suddenly no longer works on eeepc901
folkert
folkert at vanheusden.com
Fri Jul 30 11:26:59 UTC 2010
Hi,
> > entering incorrect passphrases returns immediately, entering the correct one lets it sit there doing nothing (all from within networkmanager). none of the 2 dots become green
> > this problem occurs with multiple brands/types access points wpa and wpa2
> This information might give a networkmanager maintainer intial hints,
> unfortunately it's of little help with debugging wpasupplicant if some
> strange GUI beeps or makes funny faces, while essential information about
> the involved wlan hardware (and its kernel modules!) or actual error
> messages are omitted. I'd assume that networkmanager offers an option to
> get slightly more verbose debugging output than 2 unnamed dots not becoming
> green, if not there's always wpa_cli and dmesg, which will likely be more
> verbose about the failure condition.
> Therefore I'd like to ask for the output of:
> - lspci -knn
> - lsusb
> [ depending if you're using a PCI- or USB based wlan card ]
> - dmesg
> - wpa_cli status
> Furthermore it would be helpful to know if the affected wlan card can
> operate at all, e.g. by invoking a scan request (iw dev wlan0 scan).
The card does work. Connecting to unsecured or WEP works fine.
lspci
-----
00:00.0 Host bridge [0600]: Intel Corporation Mobile 945GME Express Memory Controller Hub [8086:27ac] (rev 03)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
Kernel driver in use: agpgart-intel
00:02.0 VGA compatible controller [0300]: Intel Corporation Mobile 945GME Express Integrated Graphics Controller [8086:27ae] (rev 03)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
00:02.1 Display controller [0380]: Intel Corporation Mobile 945GM/GMS/GME, 943/940GML Express Integrated Graphics Controller [8086:27a6] (rev 03)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
00:1b.0 Audio device [0403]: Intel Corporation N10/ICH 7 Family High Definition Audio Controller [8086:27d8] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:831a]
Kernel driver in use: HDA Intel
00:1c.0 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 1 [8086:27d0] (rev 02)
Kernel driver in use: pcieport
00:1c.1 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 2 [8086:27d2] (rev 02)
Kernel driver in use: pcieport
00:1c.2 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 3 [8086:27d4] (rev 02)
Kernel driver in use: pcieport
00:1c.3 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 4 [8086:27d6] (rev 02)
Kernel driver in use: pcieport
00:1d.0 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #1 [8086:27c8] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
Kernel driver in use: uhci_hcd
00:1d.1 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #2 [8086:27c9] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
Kernel driver in use: uhci_hcd
00:1d.2 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #3 [8086:27ca] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
Kernel driver in use: uhci_hcd
00:1d.3 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #4 [8086:27cb] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
Kernel driver in use: uhci_hcd
00:1d.7 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB2 EHCI Controller [8086:27cc] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
Kernel driver in use: ehci_hcd
00:1e.0 PCI bridge [0604]: Intel Corporation 82801 Mobile PCI Bridge [8086:2448] (rev e2)
00:1f.0 ISA bridge [0601]: Intel Corporation 82801GBM (ICH7-M) LPC Interface Bridge [8086:27b9] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
00:1f.2 IDE interface [0101]: Intel Corporation 82801GBM/GHM (ICH7 Family) SATA IDE Controller [8086:27c4] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
Kernel driver in use: ata_piix
00:1f.3 SMBus [0c05]: Intel Corporation N10/ICH 7 Family SMBus Controller [8086:27da] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:830f]
01:00.0 Network controller [0280]: RaLink RT2860 [1814:0781]
Subsystem: RaLink Device [1814:2790]
Kernel driver in use: rt2860
04:00.0 Ethernet controller [0200]: Atheros Communications AR8121/AR8113/AR8114 Gigabit or Fast Ethernet [1969:1026] (rev b0)
Subsystem: ASUSTeK Computer Inc. Device [1043:8324]
Kernel driver in use: ATL1E
dmesg
-----
[ 4.268066] rt2860sta: module is from the staging directory, the quality is unknown, you have been warned.
[ 4.304730] rt2860 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
[ 4.305410]
[ 4.305414]
[ 4.305416] === pAd = f81e1000, size = 580812 ===
[ 4.305419]
[ 4.305734] <-- RTMPAllocAdapterBlock, Status=0
[ 4.306923] rt2860 0000:01:00.0: setting latency timer to 64
[ 15.809926] rt2860 0000:01:00.0: firmware: requesting rt2860.bin
[ 15.836460] RX DESC f6441000 size = 2048
[ 15.837165] <-- RTMPAllocTxRxRingMemory, Status=0
[ 15.845778] I/F(wlan0) Key1Str is Invalid key length! KeyLen = 0!
[ 15.845892] I/F(wlan0) Key2Str is Invalid key length! KeyLen = 0!
[ 15.845998] I/F(wlan0) Key3Str is Invalid key length! KeyLen = 0!
[ 15.846104] I/F(wlan0) Key4Str is Invalid key length! KeyLen = 0!
[ 15.846530] 1. Phy Mode = 9
[ 15.846603] 2. Phy Mode = 9
[ 15.868471] RTMPSetPhyMode: channel is out of range, use first channel=1
[ 15.875925] 3. Phy Mode = 9
[ 15.900450] MCS Set = ff ff 00 00 01
[ 15.902254] <==== RTMPInitialize, Status=0
[ 15.902402] 0x1300 = 00064300
scan for access points
----------------------
Cell 01 - Address: C0:3F:0E:29:EF:AE
Protocol:802.11b/g/n
ESSID:"customer"
Mode:Managed
Channel:1
Quality:70/100 Signal level:-62 dBm Noise level:-81 dBm
Encryption key:on
Bit Rates:54 Mb/s
IE: WPA Version 1
Group Cipher : TKIP
Pairwise Ciphers (2) : CCMP TKIP
Authentication Suites (1) : PSK
IE: IEEE 802.11i/WPA2 Version 1
Group Cipher : TKIP
Pairwise Ciphers (2) : CCMP TKIP
Authentication Suites (1) : PSK
wpa supplicant config
---------------------
network={
ssid="customer"
scan_ssid=1
psk="secret"
key_mgmt=WPA-PSK
}
wpa_supplicant -i wlan0 -c test.conf
------------------------------------
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
Trying to associate with c0:3f:0e:29:ef:ae (SSID='customer' freq=2412 MHz)
Associated with c0:3f:0e:29:ef:ae
Authentication with c0:3f:0e:29:ef:ae timed out.
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
Trying to associate with c0:3f:0e:29:ef:ae (SSID='customer' freq=2412 MHz)
Associated with c0:3f:0e:29:ef:ae
Authentication with c0:3f:0e:29:ef:ae timed out.
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
> > Versions of packages wpasupplicant depends on:
> > ii adduser 3.112 add and remove users and groups
> > ii libc6 2.10.2-6 Embedded GNU C Library: Shared lib
> > ii libdbus-1-3 1.2.24-1 simple interprocess messaging syst
> > ii libnl1 1.1-5 library for dealing with netlink s
> > ii libpcsclite1 1.5.5-3 Middleware to access a smart card
> > ii libreadline6 6.1-3 GNU readline and history libraries
> > ii libssl0.9.8 0.9.8o-1 SSL shared libraries
> > ii lsb-base 3.2-23.1 Linux Standard Base 3.2 init scrip
>
> I notice that you're not using pure testing, but rather quite a package mix
> between stable and testing, which, at least when it comes to the default
> udev version (158-1) in squeeze, is not compatible to lenny's 2.6.26
> kernel[1] and might be a reason for quite some problems, including
> wireless.
It was initially setup using a stable cd and then upgraded to testing.
I wrote the bugreport while in 2.6.26 but the problem also happens in 2.6.32.
wpa_supplicant -i wlan0 -c test.conf -dd
----------------------------------------
ioctl[SIOCGIWSCAN]: Resource temporarily unavailable
Initializing interface 'wlan0' conf 'test.conf' driver 'default' ctrl_interface 'N/A' bridge 'N/A'
Configuration file 'test.conf' -> '/home/folkert/test.conf'
Reading configuration file '/home/folkert/test.conf'
Line: 1 - start of a new network block
ssid - hexdump_ascii(len=11):
customer
scan_ssid=1 (0x1)
proto: 0x1
group: 0x8
key_mgmt: 0x2
PSK (ASCII passphrase) - hexdump_ascii(len=15): [REMOVED]
PSK (from passphrase) - hexdump(len=32): [REMOVED]
Priority group 0
id=0 ssid='customer'
Initializing interface (2) 'wlan0'
Interface wlan0 set UP - waiting a second for the driver to complete initialization
SIOCGIWRANGE: WE(compiled)=22 WE(source)=14 enc_capa=0xf
capabilities: key_mgmt 0xf enc 0xf flags 0x0
WEXT: Operstate: linkmode=1, operstate=5
Own MAC address: 00:22:43:26:6b:41
wpa_driver_wext_set_wpa
wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
wpa_driver_wext_set_countermeasures
wpa_driver_wext_set_drop_unencrypted
RSN: flushing PMKID list in the driver
Setting scan request: 0 sec 100000 usec
WPS: UUID based on MAC address - hexdump(len=16): bc da 5b 3f 91 3c 52 02 83 5a 1d 74 72 76 b7 d9
WPS: Build Beacon and Probe Response IEs
WPS: * Version
WPS: * Wi-Fi Protected Setup State (0)
WPS: * Version
WPS: * Wi-Fi Protected Setup State (0)
WPS: * Response Type (2)
WPS: * UUID-E
WPS: * Manufacturer
WPS: * Model Name
WPS: * Model Number
WPS: * Serial Number
WPS: * Primary Device Type
WPS: * Device Name
WPS: * Config Methods (0)
WPS: * RF Bands (3)
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
Added interface wlan0
RTM_NEWLINK: operstate=0 ifi_flags=0x1002 ()
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
Wireless event: cmd=0x8b06 len=8
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
State: DISCONNECTED -> SCANNING
Starting AP scan (specific SSID)
Scan SSID - hexdump_ascii(len=11):
customer
Trying to get current scan results first without requesting a new scan to speed up initial association
Failed to get scan results
Failed to get scan results - try scanning again
Setting scan request: 0 sec 0 usec
Starting AP scan (broadcast SSID)
Scan requested (ret=0) - scan timeout 5 seconds
EAPOL: disable timer tick
Scan timeout - try to get results
Received 428 bytes of scan results (3 BSSes)
New scan results available
Selecting BSS from priority group 0
Try to find WPA-enabled AP
0: c0:3f:0e:29:ef:ae ssid='customer' wpa_ie_len=28 rsn_ie_len=24 caps=0x11
selected based on WPA IE
selected WPA AP c0:3f:0e:29:ef:ae ssid='customer'
Trying to associate with c0:3f:0e:29:ef:ae (SSID='customer' freq=2412 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 24 key_mgmt 2 proto 1
WPA: set AP WPA IE - hexdump(len=30): dd 1c 00 50 f2 01 01 00 00 50 f2 02 02 00 00 50 f2 04 00 50 f2 02 01 00 00 50 f2 02 0c 00
WPA: set AP RSN IE - hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02 01 00 00 0f ac 02 0c 00
WPA: using GTK TKIP
WPA: using PTK CCMP
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 04 01 00 00 50 f2 02
No keys have been configured - skip key clearing
wpa_driver_wext_set_drop_unencrypted
State: SCANNING -> ASSOCIATING
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
wpa_driver_wext_associate
wpa_driver_wext_set_psk
Setting authentication timeout: 10 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=Auto
RSN: Ignored PMKID candidate without preauth flag
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
Wireless event: cmd=0x8b06 len=8
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
Wireless event: cmd=0x8b04 len=12
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
Wireless event: cmd=0x8c07 len=53
AssocReq IE wireless event - hexdump(len=45): 00 0b 42 50 53 6f 6c 75 74 69 6f 6e 73 01 08 82 84 0b 16 24 30 48 6c 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 04 01 00 00 50 f2 02
RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
Wireless event: cmd=0x8b15 len=20
Wireless event: new AP: c0:3f:0e:29:ef:ae
Association info event
req_ies - hexdump(len=45): 00 0b 42 50 53 6f 6c 75 74 69 6f 6e 73 01 08 82 84 0b 16 24 30 48 6c 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 04 01 00 00 50 f2 02
Truncated IE in assoc_info - hexdump(len=22): 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 04 01 00 00 50 f2 02
WPA: clearing own WPA/RSN IE
State: ASSOCIATING -> ASSOCIATED
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
Associated to a new BSS: BSSID=c0:3f:0e:29:ef:ae
No keys have been configured - skip key clearing
Associated with c0:3f:0e:29:ef:ae
WPA: Association event - clear replay counter
WPA: Clear old PTK
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: enable timer tick
EAPOL: SUPP_BE entering state IDLE
Setting authentication timeout: 10 sec 0 usec
Cancelling scan request
EAPOL: startWhen --> 0
EAPOL: disable timer tick
EAPOL: SUPP_PAE entering state CONNECTING
EAPOL: enable timer tick
EAPOL: txStart
WPA: drop TX EAPOL in non-IEEE 802.1X mode (type=1 len=0)
Authentication with c0:3f:0e:29:ef:ae timed out.
Added BSSID c0:3f:0e:29:ef:ae into blacklist
wpa_driver_wext_disassociate
No keys have been configured - skip key clearing
State: ASSOCIATED -> DISCONNECTED
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=5
EAPOL: External notification - portEnabled=0
EAPOL: SUPP_PAE entering state DISCONNECTED
EAPOL: SUPP_BE entering state INITIALIZE
EAPOL: External notification - portValid=0
EAPOL: External notification - EAP success=0
Setting scan request: 0 sec 0 usec
State: DISCONNECTED -> SCANNING
etc
> Furthermore especially mac80211 based drivers have seen quite some
> bugfixes since kernel 2.6.26, so testing the current default kernel in
> squeeze (>=2.6.32-15) would definately be appreciated. While partial
Only 2.6.32-5 is available in testing. I installed that one but that didn't help.
Folkert van Heusden
+------------------------------------------------------------------+
|UNIX admin? Then give MultiTail (http://vanheusden.com/multitail/)|
|a try, it brings monitoring logfiles to a different level! See |
|http://vanheusden.com/multitail/features.html for a feature list. |
+------------------------------------------------------------------+
Phone: +31-6-41278122, PGP-key: 1F28D8AE
More information about the Pkg-wpa-devel
mailing list