Ubuntu
linux-ubuntu-modules-2.6.22 package

Knetworkmanager requires a number of attempts to start wireless

Bug #140427 reported by Toivo Pedaste
4
Affects Status Importance Assigned to Milestone
linux-ubuntu-modules-2.6.22 (Ubuntu)
Fix Released
Low
Unassigned
Ubuntu gutsy-updates

Bug Description

Binary package hint: knetworkmanager

Gutsy updated to 16 Sept 2007
Intel iwl4965 wireless driver
Using WEP

The wireless doesn't start when knetworkmanager starts with kde is started

kernel.log
==========
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 12 [2.4GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 13 [2.4GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 14 [2.4GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 183 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 184 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 185 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 187 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 188 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 189 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 192 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 196 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 7 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 8 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 11 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 12 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 16 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 34 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 38 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 42 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 46 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 100 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 104 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 108 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 112 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 116 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 120 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 124 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 128 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 132 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 136 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 140 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Channel 145 [5.2GHz] is Tx only -- skipping.
Sep 17 20:11:08 asus kernel: [ 29.060000] iwl4965: Tunable channels: 11 802.11bg, 13 802.11a channels
Sep 17 20:11:08 asus kernel: [ 29.064000] wmaster0: Selected rate control algorithm 'iwl-4965-rs'
Sep 17 20:11:08 asus kernel: [ 29.120000] iwl4965: Unhandled INTA bits 0x04000000
Sep 17 20:11:08 asus kernel: [ 29.120000] iwl4965: Disabled INTA bits 0x04000000 were pending
Sep 17 20:11:08 asus kernel: [ 29.120000] iwl4965: with FH_INT = 0x00010000
Sep 17 20:11:08 asus kernel: [ 29.124000] iwl4965: REPLY_CT_KILL_CONFIG_CMD succeeded
Sep 17 20:11:08 asus kernel: [ 29.132000] usbcore: registered new interface driver hci_usb
Sep 17 20:11:08 asus kernel: [ 29.688000] lp: driver loaded but no devices found

daemon.log
=========
Sep 17 20:12:13 asus NetworkManager: <info> Updating allowed wireless network lists.
Sep 17 20:12:13 asus NetworkManager: <info> Updating VPN Connections...
Sep 17 20:12:13 asus NetworkManager: <info> SWITCH: no current connection, found better connection 'wlan0'.
Sep 17 20:12:13 asus NetworkManager: <info> Will activate connection 'wlan0/Here'.
Sep 17 20:12:13 asus NetworkManager: <info> Device wlan0 activation scheduled...
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) started...
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0/wireless): access point 'Here' is encrypted, but NO valid key exists. New key needed.
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) New wireless user key requested for network 'Here'.
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 17 20:12:13 asus NetworkManager: <WARN> nm_dbus_get_user_key_for_network_cb(): nm_dbus_get_user_key_for_network_cb(): dbus returned an error. (org.freedesktop.NetworkManagerInfo.GetKeyError) org.freedesktop.NetworkManagerInfo.GetKeyError
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) failure scheduled...
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) failed for access point (Here)
Sep 17 20:12:13 asus NetworkManager: <info> Activation (wlan0) failed.
Sep 17 20:12:13 asus NetworkManager: <info> Deactivating device wlan0.
Sep 17 20:12:14 asus hcid[5672]: Default passkey agent (:1.15, /org/kde/kbluetooth_1234) registered
Sep 17 20:12:14 asus hcid[5672]: Default authorization agent (:1.15, /org/kde/kbluetooth_auth_1234) registered
Sep 17 20:12:23 asus ntpdate[6000]: can't find host ntp.ubuntu.com
Sep 17 20:12:23 asus ntpdate[6000]: no servers can be used, exiting
Sep 17 20:12:34 asus NetworkManager: <WARN> nm_dbus_get_network_data_cb(): nm_dbus_get_network_data_cb(): dbus returned an error. (org.freedesktop.DBus.Error.NoReply) Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.

=======================================================================================

The first attempt to get knetworkmanager to start the wireless

kernel.log
==========

Sep 17 20:13:09 asus kernel: [ 158.640000] iwl4965: REPLY_ADD_STA failed
Sep 17 20:13:09 asus kernel: [ 158.640000] wlan0: Initial auth_alg=0
Sep 17 20:13:09 asus kernel: [ 158.640000] wlan0: authenticate with AP 00:09:5b:ac:58:ea
Sep 17 20:13:09 asus kernel: [ 158.644000] wlan0: RX authentication from 00:09:5b:ac:58:ea (alg=0 transaction=2 status=0)
Sep 17 20:13:09 asus kernel: [ 158.644000] wlan0: authenticated
Sep 17 20:13:09 asus kernel: [ 158.644000] wlan0: associate with AP 00:09:5b:ac:58:ea
Sep 17 20:13:09 asus kernel: [ 158.644000] wlan0: RX AssocResp from 00:09:5b:ac:58:ea (capab=0x471 status=0 aid=1)
Sep 17 20:13:09 asus kernel: [ 158.644000] wlan0: associated
Sep 17 20:13:09 asus kernel: [ 158.652000] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Sep 17 20:13:15 asus kernel: [ 164.668000] wlan0: disassociate(reason=3)
Sep 17 20:13:17 asus kernel: [ 166.644000] wlan0: privacy configuration mismatch and mixed-cell disabled - disassociate
Sep 17 20:13:19 asus kernel: [ 168.644000] wlan0: privacy configuration mismatch and mixed-cell disabled - disassociate
Sep 17 20:13:21 asus kernel: [ 170.644000] wlan0: privacy configuration mismatch and mixed-cell disabled - disassociate
Sep 17 20:13:23 asus kernel: [ 172.644000] wlan0: privacy configuration mismatch and mixed-cell disabled - disassociate
Sep 17 20:13:23 asus kernel: [ 173.284000] wlan0: no IPv6 routers present
Sep 17 20:13:25 asus kernel: [ 174.644000] wlan0: privacy configuration mismatch and mixed-cell disabled - disassociate
Sep 17 20:13:27 asus kernel: [ 176.644000] wlan0: privacy configuration mismatch and mixed-cell disabled - disassociate

daemon.log
==========

Sep 17 20:13:06 asus NetworkManager: <debug> [1190031186.060422] nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'Here'
Sep 17 20:13:06 asus NetworkManager: <info> User Switch: /org/freedesktop/NetworkManager/Devices/wlan0 / Here
Sep 17 20:13:06 asus NetworkManager: <info> Deactivating device wlan0.
Sep 17 20:13:06 asus NetworkManager: <info> Device wlan0 activation scheduled...
Sep 17 20:13:06 asus NetworkManager: <info> Activation (wlan0) started...
Sep 17 20:13:06 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 17 20:13:06 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 17 20:13:06 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 17 20:13:06 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 17 20:13:06 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 17 20:13:06 asus NetworkManager: <info> Activation (wlan0/wireless): access point 'Here' is encrypted, and a key exists. No new key needed.
Sep 17 20:13:07 asus NetworkManager: <info> supplicant_interface_init() - connect to global ctrl socket (0/10).
Sep 17 20:13:07 asus NetworkManager: <info> supplicant_interface_init() - connect to global ctrl socket (1/10).
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'INTERFACE_ADD wlan0^I^Iwext^I/var/run/wpa_supplicant5^I'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:07 asus NetworkManager: <info> supplicant_init() - connect to device ctrl socket (3/10).
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'AP_SCAN 1'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'ADD_NETWORK'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was '0'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 ssid 48657265'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 key_mgmt NONE'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 wep_key0 <key>'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 wep_tx_keyidx 0'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: sending command 'ENABLE_NETWORK 0'
Sep 17 20:13:07 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:07 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 17 20:13:09 asus NetworkManager: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to access point 'Here'.
Sep 17 20:13:09 asus NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Sep 17 20:13:09 asus NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Sep 17 20:13:09 asus NetworkManager: <info> Old device 'wlan0' activating, won't change.
Sep 17 20:13:10 asus NetworkManager: <info> Activation (wlan0) Beginning DHCP transaction.
Sep 17 20:13:10 asus NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Sep 17 20:13:10 asus dhclient: wmaster0: unknown hardware address type 801
Sep 17 20:13:10 asus NetworkManager: <info> DHCP daemon state is now 12 (successfully started) for interface wlan0
Sep 17 20:13:10 asus avahi-autoipd(wlan0)[6047]: Got SIGTERM, quitting.
Sep 17 20:13:10 asus avahi-autoipd(wlan0)[6047]: Callout STOP, address 169.254.7.243 on interface wlan0
Sep 17 20:13:10 asus avahi-autoipd(wlan0)[6048]: client: RTNETLINK answers: Cannot assign requested address
Sep 17 20:13:10 asus avahi-autoipd(wlan0)[6048]: Script execution failed with return value 2
Sep 17 20:13:11 asus dhclient: wmaster0: unknown hardware address type 801
Sep 17 20:13:11 asus NetworkManager: <info> DHCP daemon state is now 1 (starting) for interface wlan0
Sep 17 20:13:12 asus dhclient: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Sep 17 20:13:12 asus dhclient: DHCPACK from 192.168.0.1
Sep 17 20:13:12 asus NetworkManager: <info> DHCP daemon state is now 4 (reboot) for interface wlan0
Sep 17 20:13:12 asus NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP Configure Get) scheduled...
Sep 17 20:13:12 asus NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP Configure Get) started...
Sep 17 20:13:12 asus dhclient: bound to 192.168.0.7 -- renewal in 35302 seconds.
Sep 17 20:13:12 asus NetworkManager: <info> Retrieved the following IP4 configuration from the DHCP daemon:
Sep 17 20:13:12 asus NetworkManager: <info> address 192.168.0.7
Sep 17 20:13:12 asus NetworkManager: <info> netmask 255.255.255.0
Sep 17 20:13:12 asus NetworkManager: <info> broadcast 192.168.0.255
Sep 17 20:13:12 asus NetworkManager: <info> gateway 192.168.0.1
Sep 17 20:13:12 asus NetworkManager: <info> nameserver 192.168.0.1
Sep 17 20:13:12 asus NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) scheduled...
Sep 17 20:13:12 asus NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP Configure Get) complete.
Sep 17 20:13:12 asus NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started...
Sep 17 20:13:13 asus NetworkManager: <info> Clearing nscd hosts cache.
Sep 17 20:13:13 asus NetworkManager: <WARN> nm_spawn_process(): nm_spawn_process('/usr/sbin/nscd -i hosts'): could not spawn process. (Failed to execute child process "/usr/sbin/nscd" (No such file or directory))
Sep 17 20:13:13 asus NetworkManager: <info> Activation (wlan0) Finish handler scheduled.
Sep 17 20:13:13 asus NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete.
Sep 17 20:13:13 asus NetworkManager: <info> Activation (wlan0) successful, device activated.
Sep 17 20:13:14 asus NetworkManager: <info> SWITCH: terminating current connection 'wlan0' because it's no longer valid.
Sep 17 20:13:14 asus NetworkManager: <info> Deactivating device wlan0.
Sep 17 20:13:14 asus dhclient: There is already a pid file /var/run/dhclient.wlan0.pid with pid 6312
Sep 17 20:13:14 asus dhclient: killed old client process, removed PID file
Sep 17 20:13:14 asus dhclient: wmaster0: unknown hardware address type 801
Sep 17 20:13:14 asus dhclient: wmaster0: unknown hardware address type 801
Sep 17 20:13:14 asus dhclient: DHCPRELEASE on wlan0 to 192.168.0.1 port 67
Sep 17 20:13:15 asus NetworkManager: <info> SUP: sending command 'DISABLE_NETWORK 0'
Sep 17 20:13:27 asus NetworkManager: <info> SUP: response was 'TIMEOUT[CLI]'
Sep 17 20:13:27 asus NetworkManager: <WARN> nm_utils_supplicant_request_with_check(): supplicant_cleanup: supplicant error for 'DISABLE_NETWORK 0'. Response: 'TIMEOUT[CLI]'
Sep 17 20:13:27 asus NetworkManager: <WARN> supplicant_cleanup(): supplicant_cleanup - couldn't disable network in supplicant_cleanup
Sep 17 20:13:27 asus NetworkManager: <info> SUP: sending command 'AP_SCAN 0'
Sep 17 20:13:27 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:27 asus NetworkManager: <info> SUP: sending command 'TERMINATE'
Sep 17 20:13:27 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:27 asus NetworkManager: nm_device_is_802_3_ethernet: assertion `dev != NULL' failed
Sep 17 20:13:27 asus NetworkManager: nm_device_is_802_11_wireless: assertion `dev != NULL' failed

===========================================================================================================
The second time it worked

kernel.log
==========

Sep 17 20:13:43 asus kernel: [ 192.856000] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Sep 17 20:13:46 asus kernel: [ 195.704000] iwl4965: REPLY_ADD_STA failed
Sep 17 20:13:46 asus kernel: [ 195.704000] wlan0: Initial auth_alg=0
Sep 17 20:13:46 asus kernel: [ 195.704000] wlan0: authenticate with AP 00:09:5b:ac:58:ea
Sep 17 20:13:46 asus kernel: [ 195.704000] wlan0: RX authentication from 00:09:5b:ac:58:ea (alg=0 transaction=2 status=0)
Sep 17 20:13:46 asus kernel: [ 195.704000] wlan0: authenticated
Sep 17 20:13:46 asus kernel: [ 195.704000] wlan0: associate with AP 00:09:5b:ac:58:ea
Sep 17 20:13:46 asus kernel: [ 195.708000] wlan0: RX AssocResp from 00:09:5b:ac:58:ea (capab=0x471 status=0 aid=1)
Sep 17 20:13:46 asus kernel: [ 195.708000] wlan0: associated
Sep 17 20:13:46 asus kernel: [ 195.712000] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Sep 17 20:14:01 asus kernel: [ 210.952000] wlan0: no IPv6 routers present
Sep 17 20:14:13 asus kernel: [ 223.040000] iwl4965: REPLY_ADD_STA failed
Sep 17 20:14:20 asus kernel: [ 230.404000] iwl4965: REPLY_ADD_STA failed
Sep 17 20:14:28 asus kernel: [ 237.784000] iwl4965: REPLY_ADD_STA failed
Sep 17 20:14:35 asus kernel: [ 245.164000] iwl4965: REPLY_ADD_STA failed
Sep 17 20:14:42 asus kernel: [ 252.540000] iwl4965: REPLY_ADD_STA failed
Sep 17 20:14:50 asus kernel: [ 259.916000] iwl4965: REPLY_ADD_STA failed

Daemon.log
==========
Sep 17 20:13:43 asus NetworkManager: <debug> [1190031223.241927] nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'Here'
Sep 17 20:13:43 asus NetworkManager: <info> User Switch: /org/freedesktop/NetworkManager/Devices/wlan0 / Here
Sep 17 20:13:43 asus NetworkManager: <info> Deactivating device wlan0.
Sep 17 20:13:43 asus NetworkManager: <info> Device wlan0 activation scheduled...
Sep 17 20:13:43 asus NetworkManager: <info> Activation (wlan0) started...
Sep 17 20:13:43 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 17 20:13:43 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 17 20:13:43 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 17 20:13:43 asus NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 17 20:13:43 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 17 20:13:43 asus NetworkManager: <info> Activation (wlan0/wireless): access point 'Here' is encrypted, and a key exists. No new key needed.
Sep 17 20:13:44 asus NetworkManager: <info> supplicant_interface_init() - connect to global ctrl socket (0/10).
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'INTERFACE_ADD wlan0^I^Iwext^I/var/run/wpa_supplicant8^I'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:44 asus NetworkManager: <info> supplicant_init() - connect to device ctrl socket (2/10).
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'AP_SCAN 1'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'ADD_NETWORK'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was '0'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 ssid 48657265'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 key_mgmt NONE'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 wep_key0 <key>'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 wep_tx_keyidx 0'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: sending command 'ENABLE_NETWORK 0'
Sep 17 20:13:44 asus NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:13:44 asus NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 17 20:13:46 asus NetworkManager: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to access point 'Here'.
Sep 17 20:13:46 asus NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Sep 17 20:13:46 asus NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Sep 17 20:13:47 asus NetworkManager: <info> Activation (wlan0) Beginning DHCP transaction.
Sep 17 20:13:47 asus dhclient: There is already a pid file /var/run/dhclient.wlan0.pid with pid 134519120
Sep 17 20:13:47 asus dhclient: wmaster0: unknown hardware address type 801
Sep 17 20:13:47 asus NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Sep 17 20:13:47 asus NetworkManager: <info> DHCP daemon state is now 12 (successfully started) for interface wlan0
Sep 17 20:13:48 asus NetworkManager: <info> DHCP daemon state is now 1 (starting) for interface wlan0
Sep 17 20:13:48 asus dhclient: wmaster0: unknown hardware address type 801
Sep 17 20:13:50 asus dhclient: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 4
Sep 17 20:13:50 asus dhclient: DHCPOFFER from 192.168.0.1
Sep 17 20:13:50 asus dhclient: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Sep 17 20:13:50 asus dhclient: DHCPACK from 192.168.0.1
Sep 17 20:13:50 asus dhclient: bound to 192.168.0.7 -- renewal in 36825 seconds.
Sep 17 20:13:50 asus NetworkManager: <info> DHCP daemon state is now 2 (bound) for interface wlan0
Sep 17 20:13:50 asus NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP Configure Get) scheduled...
Sep 17 20:13:50 asus NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP Configure Get) started...
Sep 17 20:13:50 asus NetworkManager: <info> Retrieved the following IP4 configuration from the DHCP daemon:
Sep 17 20:13:50 asus NetworkManager: <info> address 192.168.0.7
Sep 17 20:13:50 asus NetworkManager: <info> netmask 255.255.255.0
Sep 17 20:13:50 asus NetworkManager: <info> broadcast 192.168.0.255
Sep 17 20:13:50 asus NetworkManager: <info> gateway 192.168.0.1
Sep 17 20:13:50 asus NetworkManager: <info> nameserver 192.168.0.1
Sep 17 20:13:50 asus NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (I Configure Commit) scheduled...
Sep 17 20:13:50 asus NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (I Configure Get) complete.
Sep 17 20:13:50 asus NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (I Configure Commit) started...
Sep 17 20:13:51 asus NetworkManager: <info> Clearing nscd hosts cache.
Sep 17 20:13:51 asus NetworkManager: <WARN> nm_spawn_process(): nm_spawn_proce s('/usr/sbin/nscd -i hosts'): could not spawn process. (Failed to execute child process "/usr/sbin/nscd" (No such file or directory))
Sep 17 20:13:51 asus NetworkManager: <info> Activation (wlan0) Finish handler cheduled.
Sep 17 20:13:51 asus NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (I Configure Commit) complete.
Sep 17 20:13:51 asus NetworkManager: <info> Activation (wlan0) successful, dev ce activated.

Revision history for this message
Tim Gardner (timg-tpi) wrote :

See resolution for https://bugs.edge.launchpad.net/ubuntu/+source/linux-ubuntu-modules-2.6.22/+bug/144621

Changed in knetworkmanager:
assignee: nobody → timg-tpi
importance: Undecided → Low
milestone: none → gutsy-updates
status: New → Fix Committed
Tim Gardner (timg-tpi)
Changed in linux-ubuntu-modules-2.6.22:
assignee: timg-tpi → nobody
status: Fix Committed → Fix Released
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.