Some drivers take too long to associate (Was: network-manager 0.7 always asks for WPA passphrase)
Affects | Status | Importance | Assigned to | Milestone | |
---|---|---|---|---|---|
NetworkManager |
In Progress
|
Medium
|
|||
network-manager (Fedora) |
New
|
Undecided
|
Unassigned | ||
network-manager (Ubuntu) |
Fix Released
|
High
|
Alexander Sack | ||
Intrepid |
Fix Released
|
High
|
Alexander Sack |
Bug Description
Verify:
1. ensure that you are affected: NM connect times out after 25 seconds + wpasupplicant takes more than ~25 seconds to connect manually
2. test that new package either succeeds or takes 60 seconds before giving up.
Binary package hint: network-manager
Ububtu 8.10
network-manager 0.7~~svn2008101
Every time, after a reboot NM ask for the WPA passphase, even if it was correctly stored.
The same occours after a disconnection.
Here below the daemon log after disabling/enabling wireless. Please note the two rows in the log:
>> "connection 'Auto LORENZO' has security, and secrets exist. No new secrets needed. "
and
>>> "<info> Activation (ath0/wireless): asking for new secrets "
At that point NM applet asks for a new passphase even if the old one is showed.
I just rewrite the passphrase, click "Connect" and the connection restarts correctly.
ov 1 11:15:14 ncc-1701e NetworkManager: <WARN> nm_device_
Nov 1 11:15:14 ncc-1701e NetworkManager: <info> (ath0): bringing up device.
Nov 1 11:15:14 ncc-1701e NetworkManager: <info> (ath0): device state change: 2 -> 3
Nov 1 11:15:14 ncc-1701e NetworkManager: <info> (ath0): supplicant interface state change: 1 -> 2.
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) starting connection 'Auto LORENZO'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> (ath0): device state change: 3 -> 4
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) scheduled...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) started...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) scheduled...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) complete.
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) starting...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> (ath0): device state change: 4 -> 5
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0/wireless): access point 'Auto LORENZO' has security, but secrets are required.
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> (ath0): device state change: 5 -> 6
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) complete.
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) scheduled...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) started...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> (ath0): device state change: 6 -> 4
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) scheduled...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) complete.
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) starting...
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> (ath0): device state change: 4 -> 5
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0/wireless): connection 'Auto LORENZO' has security, and secrets exist. No new secrets needed.
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: added 'ssid' value 'LORENZO'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: added 'scan_ssid' value '1'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: added 'psk' value '<omitted>'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: added 'proto' value 'WPA RSN'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: added 'pairwise' value 'TKIP CCMP'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: added 'group' value 'WEP40 WEP104 TKIP CCMP'
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) complete.
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> Config: set interface ap_scan to 1
Nov 1 11:15:43 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 2 -> 0
Nov 1 11:15:44 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 0 -> 2
Nov 1 11:15:44 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 2 -> 3
Nov 1 11:15:54 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 3 -> 0
Nov 1 11:15:54 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 0 -> 2
Nov 1 11:15:54 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 2 -> 3
Nov 1 11:15:58 ncc-1701e NetworkManager: <info> ath0: link timed out.
Nov 1 11:16:04 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 3 -> 0
Nov 1 11:16:04 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 0 -> 3
Nov 1 11:16:08 ncc-1701e NetworkManager: <info> Activation (ath0/wireless): association took too long.
Nov 1 11:16:08 ncc-1701e NetworkManager: <info> (ath0): device state change: 5 -> 6
Nov 1 11:16:08 ncc-1701e NetworkManager: <info> Activation (ath0/wireless): asking for new secrets
Nov 1 11:16:08 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 3 -> 0
Nov 1 11:16:23 ncc-1701e NetworkManager: <info> ath0: link timed out.
Nov 1 11:16:44 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 0 -> 2
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) scheduled...
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) started...
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> (ath0): device state change: 6 -> 4
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) scheduled...
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 1 of 5 (Device Prepare) complete.
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) starting...
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> (ath0): device state change: 4 -> 5
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Activation (ath0/wireless): connection 'Auto LORENZO' has security, and secrets exist. No new secrets needed.
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: added 'ssid' value 'LORENZO'
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: added 'scan_ssid' value '1'
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: added 'psk' value '<omitted>'
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: added 'proto' value 'WPA RSN'
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: added 'pairwise' value 'TKIP CCMP'
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: added 'group' value 'WEP40 WEP104 TKIP CCMP'
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Activation (ath0) Stage 2 of 5 (Device Configure) complete.
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 2 -> 0
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> Config: set interface ap_scan to 1
Nov 1 11:17:50 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 0 -> 2
Nov 1 11:18:00 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 2 -> 3
Nov 1 11:18:00 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 3 -> 4
Nov 1 11:18:00 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 4 -> 5
Nov 1 11:18:00 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 5 -> 6
Nov 1 11:18:00 ncc-1701e NetworkManager: <info> (ath0): supplicant connection state change: 6 -> 7
Nov 1 11:18:00 ncc-1701e NetworkManager: <info> Activation (ath0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'LORENZO'.
description: | updated |
Changed in network-manager: | |
assignee: | nobody → asac |
assignee: | nobody → asac |
description: | updated |
Changed in network-manager: | |
status: | Triaged → Fix Committed |
Changed in network-manager: | |
status: | Unknown → Confirmed |
Changed in network-manager: | |
status: | Confirmed → In Progress |
Changed in network-manager (Ubuntu): | |
assignee: | Alexander Sack (asac) → Kevint (ktreadwell) |
Changed in network-manager (Ubuntu): | |
assignee: | Kevint (ktreadwell) → Alexander Sack (asac) |
Changed in network-manager: | |
importance: | Unknown → Medium |
this smells like a timing issue and slow drivers. Please test the latest intrepid packages from the network-manager team test archive (PPA): http:// launchpad. net/~network- manager/ +archive.