LinuxQuestions.org

LinuxQuestions.org (/questions/)
-   Linux - Wireless Networking (http://www.linuxquestions.org/questions/linux-wireless-networking-41/)
-   -   Networkmanager slow to start Wifi (http://www.linuxquestions.org/questions/linux-wireless-networking-41/networkmanager-slow-to-start-wifi-549587/)

pugsley 04-27-2007 06:32 PM

Networkmanager slow to start Wifi
 
Hi,

I am running SUSE10.2 on a Dell laptop with a Belkin wireless card. Networking works fine .... once it gets going (bit like me in the morning). If is use ifup the card starts OK during boot. If I use the Networkmanager tool the card takes a long time to start up and get an IP adress. Networkmanager also trys stating the built in wired eth0 connection even though there is no cable connected (does not appear to support sensing cable connection). Looking at networkmanager log there is a message about request_and_convert_scan_results(): card took too much time scanning. Get a better one." It appears that networkmanager may not be waiting long enough for this card to pickup a signal?? Any suggestions??

Pugsley

log output follows:


Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.034292] nm_system_device_get_system_config(): found config '/etc/sysconfig/network/ifcfg-wlan-id-00:30:bd:d2:6a:61' for interface 'eth1'
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186370] nm_system_device_get_system_config(): BOOTPROTO=dhcp
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186677] nm_system_device_get_system_config(): Adding 'WLAN' to the list of trusted networks
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186747] nm_system_device_get_system_config(): ------ Config (eth1)
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186782] nm_system_device_get_system_config(): dhcp=1
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186854] nm_system_device_get_system_config(): addr=0.0.0.0
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186886] nm_system_device_get_system_config(): gw=0.0.0.0
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186915] nm_system_device_get_system_config(): mask=0.0.0.0
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.186950] nm_system_device_get_system_config(): ---------------------
Apr 27 19:07:53 laptop NetworkManager: <info> eth1: Device is fully-supported using driver 'atmel_cs'.
Apr 27 19:07:53 laptop NetworkManager: <info> nm_device_init(): waiting for device's worker thread to start
Apr 27 19:07:53 laptop NetworkManager: <info> nm_device_init(): device's worker thread started, continuing.
Apr 27 19:07:53 laptop NetworkManager: <info> Now managing wireless (802.11) device 'eth1'.
Apr 27 19:07:53 laptop NetworkManager: <info> Deactivating device eth1.
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.466229] nm_system_device_get_system_config(): found config '/etc/sysconfig/network/ifcfg-eth-id-00:0b:db:16:6a:1b' for interface 'eth0'
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.466543] nm_system_device_get_system_config(): BOOTPROTO=dhcp
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.466664] nm_system_device_get_system_config(): ------ Config (eth0)
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.466762] nm_system_device_get_system_config(): dhcp=1
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.466856] nm_system_device_get_system_config(): addr=0.0.0.0
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.466948] nm_system_device_get_system_config(): gw=0.0.0.0
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.467039] nm_system_device_get_system_config(): mask=0.0.0.0
Apr 27 19:07:53 laptop NetworkManager: <debug> [1177664873.467127] nm_system_device_get_system_config(): ---------------------
Apr 27 19:07:53 laptop NetworkManager: <info> eth0: Device is fully-supported using driver '3c59x'.
Apr 27 19:07:53 laptop NetworkManager: <info> nm_device_init(): waiting for device's worker thread to start
Apr 27 19:07:53 laptop NetworkManager: <info> nm_device_init(): device's worker thread started, continuing.
Apr 27 19:07:53 laptop NetworkManager: <info> Now managing wired Ethernet (802.3) device 'eth0'.
Apr 27 19:07:53 laptop NetworkManager: <info> Deactivating device eth0.
Apr 27 19:07:53 laptop NetworkManager: <info> Will activate wired connection 'eth0' because it now has a link.
Apr 27 19:07:53 laptop NetworkManager: <info> SWITCH: no current connection, found better connection 'eth0'.
Apr 27 19:07:53 laptop NetworkManager: <info> Will activate connection 'eth0'.
Apr 27 19:07:53 laptop NetworkManager: <info> Device eth0 activation scheduled...
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) started...
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started...
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting...
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful.
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete.
Apr 27 19:07:53 laptop NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
Apr 27 19:07:54 laptop NetworkManager: <info> Activation (eth0) Beginning DHCP transaction.
Apr 27 19:07:55 laptop NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
Apr 27 19:07:55 laptop NetworkManager: <info> DHCP daemon state is now 12 (successfully started) for interface eth0
Apr 27 19:07:55 laptop NetworkManager: <info> Old device 'eth0' activating, won't change.
Apr 27 19:07:57 laptop NetworkManager: <info> DHCP daemon state is now 1 (starting) for interface eth0
Apr 27 19:08:03 laptop NetworkManager: <info> Old device 'eth0' activating, won't change.
Apr 27 19:08:33 laptop NetworkManager: <info> Old device 'eth0' activating, won't change.
Apr 27 19:08:40 laptop NetworkManager: <info> Deactivating device eth1.
Apr 27 19:08:40 laptop NetworkManager: <info> Updating allowed wireless network lists.
Apr 27 19:08:40 laptop NetworkManager: <info> Old device 'eth0' activating, won't change.
Apr 27 19:08:40 laptop NetworkManager: <info> Device 'eth0' DHCP transaction took too long (>45s), stopping it.
Apr 27 19:08:41 laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP Configure Timeout) scheduled...
Apr 27 19:08:41 laptop NetworkManager: <info> DHCP daemon state is now 14 (normal exit) for interface eth0
Apr 27 19:08:41 laptop NetworkManager: <info> DHCP daemon state is now 11 (unknown) for interface eth0
Apr 27 19:08:41 laptop NetworkManager: <info> DHCP daemon state is now 14 (normal exit) for interface eth0
Apr 27 19:08:41 laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP Configure Timeout) started...
Apr 27 19:08:41 laptop NetworkManager: <info> No DHCP reply received. Automatically obtaining IP via Zeroconf.
Apr 27 19:08:41 laptop NetworkManager: <info> autoip: Sending probe #0 for IP address 169.254.74.81.
Apr 27 19:08:41 laptop NetworkManager: <info> autoip: Waiting for reply...
Apr 27 19:08:41 laptop NetworkManager: <info> Old device 'eth0' activating, won't change.
Apr 27 19:08:43 laptop NetworkManager: <info> autoip: Sending probe #1 for IP address 169.254.74.81.
Apr 27 19:08:43 laptop NetworkManager: <info> autoip: Waiting for reply...
Apr 27 19:08:45 laptop NetworkManager: <info> autoip: Sending probe #2 for IP address 169.254.74.81.
Apr 27 19:08:45 laptop NetworkManager: <info> autoip: Waiting for reply...
Apr 27 19:08:47 laptop NetworkManager: <info> autoip: Sending announce #0 for IP address 169.254.74.81.
Apr 27 19:08:47 laptop NetworkManager: <info> autoip: Waiting for reply...
Apr 27 19:08:50 laptop NetworkManager: <info> autoip: Sending announce #1 for IP address 169.254.74.81.
Apr 27 19:08:50 laptop NetworkManager: <info> autoip: Waiting for reply...
Apr 27 19:08:52 laptop NetworkManager: <info> Old device 'eth0' activating, won't change.
Apr 27 19:08:53 laptop NetworkManager: <info> autoip: Sending announce #2 for IP address 169.254.74.81.
Apr 27 19:08:53 laptop NetworkManager: <info> autoip: Waiting for reply...
Apr 27 19:08:56 laptop NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled...
Apr 27 19:08:56 laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP Configure Timeout) complete.
Apr 27 19:08:56 laptop NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) started...
Apr 27 19:08:57 laptop NetworkManager: <info> Clearing nscd hosts cache.
Apr 27 19:08:57 laptop NetworkManager: <info> Activation (eth0) successful, device activated.
Apr 27 19:08:57 laptop NetworkManager: <info> Activation (eth0) Finish handler scheduled.
Apr 27 19:08:57 laptop NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete.
Apr 27 19:09:03 laptop NetworkManager: <debug> [1177664943.028429] nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'WLAN'
Apr 27 19:09:03 laptop NetworkManager: <info> User Switch: /org/freedesktop/NetworkManager/Devices/eth1 / WLAN
Apr 27 19:09:03 laptop NetworkManager: <info> Deactivating device eth1.
Apr 27 19:09:03 laptop NetworkManager: <info> Device eth1 activation scheduled...
Apr 27 19:09:03 laptop NetworkManager: <info> Deactivating device eth0.
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1) started...
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled...
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) started...
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1) Stage 2 of 5 (Device Configure) scheduled...
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1) Stage 2 of 5 (Device Configure) starting...
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1/wireless): access point 'WLAN' is unencrypted, no key needed.
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: sending command 'INTERFACE_ADD eth1 wext /var/run/wpa_supplicant '
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: response was 'OK'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: sending command 'AP_SCAN 1'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: response was 'OK'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: sending command 'ADD_NETWORK'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: response was '0'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 ssid 574c414e'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: response was 'OK'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 scan_ssid 1'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: response was 'OK'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: sending command 'SET_NETWORK 0 key_mgmt NONE'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: response was 'OK'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: sending command 'ENABLE_NETWORK 0'
Apr 27 19:09:03 laptop NetworkManager: <info> SUP: response was 'OK'
Apr 27 19:09:03 laptop NetworkManager: <info> Activation (eth1) Stage 2 of 5 (Device Configure) complete.
Apr 27 19:09:04 laptop NetworkManager: <info> Old device 'eth1' activating, won't change.
Apr 27 19:09:20 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:27 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:32 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:37 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:41 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:45 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:50 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:50 laptop NetworkManager: <info> Activation (eth1/wireless) Stage 2 of 5 (Device Configure) successful. Connected to access point 'WLAN'.
Apr 27 19:09:50 laptop NetworkManager: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Apr 27 19:09:54 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:09:58 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:02 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:07 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:11 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:15 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:20 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:24 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:28 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:33 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:37 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:41 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:46 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:50 laptop NetworkManager: <WARN> request_and_convert_scan_results(): card took too much time scanning. Get a better one.
Apr 27 19:10:50 laptop NetworkManager: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) started...
Apr 27 19:10:51 laptop NetworkManager: <info> Activation (eth1) Beginning DHCP transaction.
Apr 27 19:10:52 laptop NetworkManager: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) complete.
Apr 27 19:10:52 laptop NetworkManager: <info> DHCP daemon state is now 12 (successfully started) for interface eth1
Apr 27 19:10:52 laptop NetworkManager: <info> DHCP daemon state is now 1 (starting) for interface eth1
Apr 27 19:10:57 laptop NetworkManager: <info> DHCP daemon state is now 2 (bound) for interface eth1
Apr 27 19:10:57 laptop NetworkManager: <info> Activation (eth1) Stage 4 of 5 (IP Configure Get) scheduled...
Apr 27 19:10:57 laptop NetworkManager: <info> Activation (eth1) Stage 4 of 5 (IP Configure Get) started...
Apr 27 19:10:57 laptop NetworkManager: <info> Retrieved the following IP4 configuration from the DHCP daemon:
Apr 27 19:10:57 laptop NetworkManager: <info> address 192.168.2.58
Apr 27 19:10:57 laptop NetworkManager: <info> netmask 255.255.255.0
Apr 27 19:10:57 laptop NetworkManager: <info> broadcast 255.255.255.255
Apr 27 19:10:57 laptop NetworkManager: <info> gateway 192.168.2.1
Apr 27 19:10:57 laptop NetworkManager: <info> nameserver 192.168.2.1
Apr 27 19:10:57 laptop NetworkManager: <info> domain name 'Belkin'
Apr 27 19:10:57 laptop NetworkManager: <info> Activation (eth1) Stage 5 of 5 (IP Configure Commit) scheduled...
Apr 27 19:10:57 laptop NetworkManager: <info> Activation (eth1) Stage 4 of 5 (IP Configure Get) complete.
Apr 27 19:10:57 laptop NetworkManager: <info> Activation (eth1) Stage 5 of 5 (IP Configure Commit) started...
Apr 27 19:10:58 laptop NetworkManager: <info> Clearing nscd hosts cache.
Apr 27 19:10:58 laptop NetworkManager: <info> Activation (eth1) successful, device activated.
Apr 27 19:10:58 laptop NetworkManager: <info> Activation (eth1) Finish handler scheduled.
Apr 27 19:10:58 laptop NetworkManager: <info> Activation (eth1) Stage 5 of 5 (IP Configure Commit) complete.


All times are GMT -5. The time now is 04:14 PM.