Ubuntu
linux package

wpa_supplicant Association request to the driver failed on orinoco

Bug #670787 reported by Rob Frohne
20
This bug affects 4 people
Affects Status Importance Assigned to Milestone
linux (Ubuntu)
Confirmed
Undecided
Unassigned

Bug Description

I tried to use my old Lucent Wavelan Silver (Orinoco) card today and I cannot get it to associate with a network. Here is the system log file:

Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3) starting connection 'Wireless connection 2'
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> (eth3): device state change: 3 -> 4 (reason 0)
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3) Stage 1 of 5 (Device Prepare) scheduled...
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3) Stage 1 of 5 (Device Prepare) started...
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3) Stage 2 of 5 (Device Configure) scheduled...
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3) Stage 1 of 5 (Device Prepare) complete.
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3) Stage 2 of 5 (Device Configure) starting...
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> (eth3): device state change: 4 -> 5 (reason 0)
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3/wireless): connection 'Wireless connection 2' requires no security. No secrets needed.
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Config: added 'ssid' value 'WIREFREEWWU'
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Config: added 'scan_ssid' value '1'
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Config: added 'key_mgmt' value 'NONE'
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Activation (eth3) Stage 2 of 5 (Device Configure) complete.
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> Config: set interface ap_scan to 1
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> (eth3): supplicant connection state: disconnected -> scanning
Nov 3 23:34:51 frohro-D610 wpa_supplicant[3844]: Trying to associate with 00:0c:e5:54:27:bb (SSID='WIREFREEWWU' freq=2462 MHz)
Nov 3 23:34:51 frohro-D610 NetworkManager[1018]: <info> (eth3): supplicant connection state: scanning -> associating
Nov 3 23:34:51 frohro-D610 kernel: [ 4636.632128] eth3: Lucent/Agere firmware doesn't support manual roaming
Nov 3 23:34:51 frohro-D610 wpa_supplicant[3844]: Association request to the driver failed
Nov 3 23:34:56 frohro-D610 wpa_supplicant[3844]: Authentication with 00:0c:e5:54:27:bb timed out.
Nov 3 23:34:56 frohro-D610 NetworkManager[1018]: <info> (eth3): supplicant connection state: associating -> disconnected
Nov 3 23:34:56 frohro-D610 NetworkManager[1018]: <info> (eth3): supplicant connection state: disconnected -> scanning

This repeats a number of times until it gives up.

Here is data from iwlist:

frohro@frohro-D610:~$ sudo iwlist eth3 scan
eth3 Scan completed :
          Cell 01 - Address: 00:11:22:33:44:57
                    Channel:1
                    Frequency:2.412 GHz (Channel 1)
                    Quality=37/70 Signal level=-73 dBm
                    Encryption key:off
                    ESSID:"FROHNE120"
                    Bit Rates:1 Mb/s; 2 Mb/s; 5.5 Mb/s; 11 Mb/s
                    Mode:Master
                    Extra:tsf=00000029cb5b8537
                    Extra: Last beacon: 240ms ago
                    IE: Unknown: 000946524F484E45313230
                    IE: Unknown: 010482848B96
                    IE: Unknown: 030101
                    IE: Unknown: DD090010180202F0000000
                    IE: Unknown: DD180050F2020101800003A4000027A400004243BC0062326600
          Cell 02 - Address: 00:0C:E5:54:27:BB
                    Channel:11
                    Frequency:2.462 GHz (Channel 11)
                    Quality=31/70 Signal level=-79 dBm
                    Encryption key:off
                    ESSID:"WIREFREEWWU"
                    Bit Rates:1 Mb/s; 2 Mb/s; 5.5 Mb/s; 11 Mb/s; 18 Mb/s
                              24 Mb/s; 36 Mb/s; 54 Mb/s
                    Bit Rates:6 Mb/s; 9 Mb/s; 12 Mb/s; 48 Mb/s
                    Mode:Master
                    Extra:tsf=000000cf47da4bdd
                    Extra: Last beacon: 172ms ago
                    IE: Unknown: 000B5749524546524545575755
                    IE: Unknown: 010882848B962430486C
                    IE: Unknown: 03010B
                    IE: Unknown: 2A0107
                    IE: Unknown: 2F0107
                    IE: Unknown: 32040C121860
                    IE: Unknown: DD090010180204F0000000
                    IE: Unknown: DD180050F2020101800003A4000027A4000042435E0062322F00

and from iwconfig:

eth3 IEEE 802.11b ESSID:"WIREFREEWWU"
          Mode:Managed Frequency:2.422 GHz Access Point: None
          Bit Rate:11 Mb/s Sensitivity:1/0
          Retry limit:8 RTS thr=2347 B Fragment thr:off
          Power Management:off
          Link Quality=0/70 Signal level=-122 dBm Noise level=-122 dBm
          Rx invalid nwid:0 Rx invalid crypt:0 Rx invalid frag:1
          Tx excessive retries:0 Invalid misc:0 Missed beacon:0

This is a regression somewhere between kernel 2.6.31-21-generic and

frohro@frohro-D610:~$ uname -r
2.6.35-23-generic

I will see if I can further narrow it down.

Thanks for the help!

Rob

ProblemType: Bug
DistroRelease: Ubuntu 10.10
Package: linux-image-2.6.35-23-generic 2.6.35-23.36
Regression: Yes
Reproducible: Yes
ProcVersionSignature: Ubuntu 2.6.35-23.36-generic 2.6.35.7
Uname: Linux 2.6.35-23-generic i686
AlsaVersion: Advanced Linux Sound Architecture Driver Version 1.0.23.
Architecture: i386
AudioDevicesInUse:
 USER PID ACCESS COMMAND
 /dev/snd/controlC0: frohro 2471 F.... pulseaudio
Card0.Amixer.info:
 Card hw:0 'ICH6'/'Intel ICH6 with STAC9750,51 at irq 16'
   Mixer name : 'SigmaTel STAC9750,51'
   Components : 'AC97a:83847650'
   Controls : 38
   Simple ctrls : 24
CheckboxSubmission: b3f7c5231c874165f4d7945857608f87
CheckboxSystem: d00f84de8a555815fa1c4660280da308
Date: Wed Nov 3 23:52:23 2010
HibernationDevice: RESUME=UUID=66e1c3c2-adb4-4036-a791-fdd183e99617
InstallationMedia: Ubuntu 9.10 "Karmic Koala" - Release i386 (20091028.5)
MachineType: Dell Inc. Latitude D610
PccardctlIdent:
 Socket 0:
   product info: "Lucent Technologies", "WaveLAN/IEEE", "Version 01.01", ""
   manfid: 0x0156, 0x0002
   function: 6 (network)
PccardctlStatus:
 Socket 0:
   5.0V 16-bit PC Card
   Subdevice 0 (function 0) bound to driver "orinoco_cs"
ProcCmdLine: BOOT_IMAGE=/boot/vmlinuz-2.6.35-23-generic root=UUID=e32a9aab-f506-4471-bb71-4b4e23ec3181 ro quiet splash
ProcEnviron:
 PATH=(custom, no user)
 LANG=en_US.utf8
 SHELL=/bin/bash
RelatedPackageVersions: linux-firmware 1.38
SourcePackage: linux
dmi.bios.date: 08/11/2005
dmi.bios.vendor: Dell Inc.
dmi.bios.version: A05
dmi.board.name: 0U8082
dmi.board.vendor: Dell Inc.
dmi.chassis.type: 8
dmi.chassis.vendor: Dell Inc.
dmi.modalias: dmi:bvnDellInc.:bvrA05:bd08/11/2005:svnDellInc.:pnLatitudeD610:pvr:rvnDellInc.:rn0U8082:rvr:cvnDellInc.:ct8:cvr:
dmi.product.name: Latitude D610
dmi.sys.vendor: Dell Inc.

Revision history for this message
Rob Frohne (frohro) wrote :
Revision history for this message
Rob Frohne (frohro) wrote :

Well, I need to explain a little more. The note above about this being a regression between kernel 2.6.31-21-generic and
2.6.35-23-generic was tested with an earlier version of Ubuntu (9.10) and this one (10.10). I tried to boot into the real time kernel from Ubuntu 10.10, which is:

frohro@frohro-D610:~$ uname -r
2.6.31-11-rt

and the issue is still there, so likely this is not a kernel issue, maybe wpa_supplicant, or something else that changed between Karmic and Maverick.

Revision history for this message
Rob Frohne (frohro) wrote :
Download full text (36.2 KiB)

Hi All,

I killed and started wpa_supplicant with more debugging and to the terminal. Here is the output from that after trying to associate eth3 with WIREFREEWWU (which has no encryption at all). First is the command sequence I used to do this and then some of the messages I copied from the terminal. Note that eth1 is an IPW2200 which works fine.

frohro@frohro-D610:~$ !ps
ps aux | grep wpa_supplicant
root 1183 0.3 0.1 4904 2360 ? S 18:42 0:01 /sbin/wpa_supplicant -u -s
frohro 3157 0.0 0.0 4016 736 pts/0 S+ 18:51 0:00 grep wpa_supplicant
frohro@frohro-D610:~$ sudo kill -9 1183 ; sudo wpa_supplicant -u -ddd

RTM_NEWLINK, IFLA_IFNAME: Interface 'eth3' added
Wireless event: cmd=0x8b19 len=8
Received 333 bytes of scan results (1 BSSes)
New scan results available
Selecting BSS from priority group 0
Try to find WPA-enabled AP
0: 00:0c:e5:54:27:bb ssid='WIREFREEWWU' wpa_ie_len=0 rsn_ie_len=0 caps=0x1
   skip - no WPA/RSN IE
Try to find non-WPA AP
0: 00:0c:e5:54:27:bb ssid='WIREFREEWWU' wpa_ie_len=0 rsn_ie_len=0 caps=0x1
   selected non-WPA AP 00:0c:e5:54:27:bb ssid='WIREFREEWWU'
Trying to associate with 00:0c:e5:54:27:bb (SSID='WIREFREEWWU' freq=2462 MHz)
Cancelling scan request
WPA: clearing own WPA/RSN IE
Automatic auth_alg selection: 0x1
WPA: clearing AP WPA IE
WPA: clearing AP RSN IE
WPA: clearing own WPA/RSN IE
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
ioctl[SIOCSIWFREQ]: Device or resource busy
ioctl[SIOCSIWAP]: Operation not supported
Association request to the driver failed
Setting authentication timeout: 5 sec 0 usec
EAPOL: External notification - EAP success=0
EAPOL: External notification - EAP fail=0
EAPOL: External notification - portControl=ForceAuthorized
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'eth3' added
Wireless event: cmd=0x8b06 len=8
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'eth3' added
Wireless event: cmd=0x8b1a len=8
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'eth3' added
Wireless event: cmd=0x8b1a len=19
Ignore event for foreign ifindex 4
Ignore event for foreign ifindex 4
Ignore event for foreign ifindex 4
Ignore event for foreign ifindex 4
Setting scan request: 0 sec 0 usec
State: INACTIVE -> SCANNING
Starting AP scan (broadcast SSID)
Scan requested (ret=0) - scan timeout 30 seconds
Ignore event for foreign ifindex 3
RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
RTM_NEWLINK, IFLA_IFNAME: Interface 'eth1' added
Wireless event: cmd=0x8b19 len=8
Received 644 bytes of scan results (3 BSSes)
New scan results available
No suitable AP found.
State: SCANNING -> INACTIVE
Authentication with 00:0c:e5:54:27:bb timed out.
Added BSSID 00:0c:e5:54:27:bb into blacklist
No keys have been configured - skip key clearing
State: ASSOCIATING -> DISCONNECTED
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
WEXT: Operstate: linkmode=-1, operstate=...

Revision history for this message
Rob Frohne (frohro) wrote :

I just checked that this bug affects my wife's machine running 10.04, so it has been around for a while.

Revision history for this message
MoLE (moleonthehill) wrote :

Thank you for taking the time to report this bug and helping to make Ubuntu better. This particular bug has already been reported and is a duplicate of bug 715438, so it is being marked as such. Please look at the other bug report to see if there is any missing information that you can provide, or to see if there is a workaround for the bug. Additionally, any further discussion regarding the bug should occur in the other report. Feel free to continue to report any other bugs you may find.

Revision history for this message
Launchpad Janitor (janitor) wrote :

Status changed to 'Confirmed' because the bug affects multiple users.

Changed in linux (Ubuntu):
status: New → Confirmed
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.
Subscribing...

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.