Newbie question on occasional NM problem

[Timothy Murphy <gayleard eircom net>]

I'm running Fedora-10/KDE on a few laptops,
and have just joined the NM mailing list,
having moaned about (and sometimes praised) NM on the Fedora mailing list
for several years.

I'm currently using a Thinkpad T43 with a PCMCIA classic Orinoco gold WiFi 
card.
I guess NM connects fine about 85% of the time when I boot up.
The other 15% of the time it doesn't connect,
and I have to re-boot.
It then connects about 75% of the time;
in the remaining cases it connects on the third try.

I used to Suspend to RAM rather than shutdown,
and then NM always came back when the machine woke up without problem.
Unfortunately, Suspend to RAM has presently stopped working for some reason
(I think this is a general Thinkpad problem.
In any case it has nothing to do with NM,
except that it re-awakes the slight problem I have always had with NM
on re-booting described above.)

I've appended what are probably excessive log-file entries below,
but I guess the question I have is:

Can a guru deduce the problem from the log-file?
And if so, is there anything one can do about it?

These are the NM entries in /var/log/messages when I re-booted this morning,
describing a first failure:
-----------------------------------------------
Apr 25 10:19:14 mary NetworkManager: <info>  starting...
Apr 25 10:19:14 mary NetworkManager: <WARN>  nm_generic_enable_loopback(): 
error -17 returned from rtnl_addr_add():#012Sucess#012
Apr 25 10:19:14 mary NetworkManager: <info>  (eth1): driver does not support 
SSID scans (scan_capa 0x00).
Apr 25 10:19:15 mary NetworkManager: <info>  (eth1): new 802.11 WiFi device 
(driver: 'orinoco_cs')
Apr 25 10:19:15 mary NetworkManager: <info>  (eth1): exported as 
/org/freedesktop/Hal/devices/net_00_02_2d_21_03_c9
Apr 25 10:19:15 mary NetworkManager: <info>  (ttyS0): ignoring due to lack of 
mobile broadband capabilties
Apr 25 10:19:15 mary NetworkManager: <info>  Trying to start the supplicant...
Apr 25 10:19:15 mary NetworkManager: <info>  Trying to start the system 
settings daemon...
Apr 25 10:19:15 mary NetworkManager: <info>  (eth1): supplicant manager state:  
down -> idle
Apr 25 10:19:15 mary nm-system-settings: Loaded plugin keyfile: (c) 2007 - 2008 
Red Hat, Inc.  To report bugs please use theNetworkManager mailing list.
Apr 25 10:19:19 mary NetworkManager: <info>  (eth1): device state change: 1 -> 
2
Apr 25 10:19:19 mary NetworkManager: <info>  (eth1): bringing up device.
Apr 25 10:19:19 mary NetworkManager: <info>  (eth1): preparing device.
Apr 25 10:19:19 mary NetworkManager: <info>  (eth1): deactivating device 
(reason: 2).
Apr 25 10:19:19 mary NetworkManager: <info>  (eth1): device state change: 2 -> 
3
Apr 25 10:19:19 mary NetworkManager: <info>  (eth1): supplicant interface 
state:  starting -> ready
Apr 25 10:21:41 mary NetworkManager: <info>  HAL disappeared
Apr 25 10:21:43 mary NetworkManager: <WARN>  nm_signal_handler(): Caught 
signal 15, shutting down normally.
Apr 25 10:21:43 mary NetworkManager: <info>  (eth1): now unmanaged
Apr 25 10:21:43 mary NetworkManager: <info>  (eth1): device state change: 3 -> 
1
Apr 25 10:21:43 mary NetworkManager: <info>  (eth1): cleaning up...
Apr 25 10:21:43 mary NetworkManager: <info>  (eth1): taking down device.
Apr 25 10:21:43 mary NetworkManager: <info>  exiting (success)
-----------------------------------------------

And here are the entries after re-booting, and getting WiFi connection:
-----------------------------------------------
Apr 25 10:22:50 mary NetworkManager: <info>  starting...
Apr 25 10:22:50 mary NetworkManager: <WARN>  nm_generic_enable_loopback(): 
error -17 returned from rtnl_addr_add():#012Sucess#012
Apr 25 10:22:50 mary NetworkManager: <info>  (eth1): driver does not support 
SSID scans (scan_capa 0x00).
Apr 25 10:22:50 mary NetworkManager: <info>  (eth1): new 802.11 WiFi device 
(driver: 'orinoco_cs')
Apr 25 10:22:50 mary NetworkManager: <info>  (eth1): exported as 
/org/freedesktop/Hal/devices/net_00_02_2d_21_03_c9
Apr 25 10:22:50 mary NetworkManager: <info>  (ttyS0): ignoring due to lack of 
mobile broadband capabilties
Apr 25 10:22:50 mary NetworkManager: <info>  Trying to start the supplicant...
Apr 25 10:22:50 mary NetworkManager: <info>  Trying to start the system 
settings daemon...
Apr 25 10:22:51 mary nm-system-settings: Loaded plugin keyfile: (c) 2007 - 2008 
Red Hat, Inc.  To report bugs please use theNetworkManager mailing list.
Apr 25 10:22:51 mary NetworkManager: <info>  (eth1): supplicant manager state:  
down -> idle
Apr 25 10:22:55 mary NetworkManager: <info>  (eth1): device state change: 1 -> 
2
Apr 25 10:22:55 mary NetworkManager: <info>  (eth1): bringing up device.
Apr 25 10:22:55 mary NetworkManager: <info>  (eth1): preparing device.
Apr 25 10:22:55 mary NetworkManager: <info>  (eth1): deactivating device 
(reason: 2).
Apr 25 10:22:55 mary NetworkManager: <info>  (eth1): device state change: 2 -> 
3
Apr 25 10:22:55 mary NetworkManager: <info>  (eth1): supplicant interface 
state:  starting -> ready
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) starting 
connection 'Auto dd-wrt'
Apr 25 10:24:29 mary NetworkManager: <info>  (eth1): device state change: 3 -> 
4
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 1 of 5 
(Device Prepare) scheduled...
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 1 of 5 
(Device Prepare) started...
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 2 of 5 
(Device Configure) scheduled...
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 1 of 5 
(Device Prepare) complete.
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 2 of 5 
(Device Configure) starting...
Apr 25 10:24:29 mary NetworkManager: <info>  (eth1): device state change: 4 -> 
5
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1/wireless): 
access point 'Auto dd-wrt' has security, but secrets are required.
Apr 25 10:24:29 mary NetworkManager: <info>  (eth1): device state change: 5 -> 
6
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 2 of 5 
(Device Configure) complete.
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 1 of 5 
(Device Prepare) scheduled...
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 1 of 5 
(Device Prepare) started...
Apr 25 10:24:29 mary NetworkManager: <info>  (eth1): device state change: 6 -> 
4
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 2 of 5 
(Device Configure) scheduled...
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 1 of 5 
(Device Prepare) complete.
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 2 of 5 
(Device Configure) starting...
Apr 25 10:24:29 mary NetworkManager: <info>  (eth1): device state change: 4 -> 
5
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1/wireless): 
connection 'Auto dd-wrt' has security, and secrets exist.  No new secrets 
needed.
Apr 25 10:24:29 mary NetworkManager: <info>  Config: added 'ssid' value 'dd-
wrt'
Apr 25 10:24:29 mary NetworkManager: <info>  Config: added 'scan_ssid' value 
'1'
Apr 25 10:24:29 mary NetworkManager: <info>  Config: added 'key_mgmt' value 
'NONE'
Apr 25 10:24:29 mary NetworkManager: <info>  Config: added 'auth_alg' value 
'OPEN'
Apr 25 10:24:29 mary NetworkManager: <info>  Config: added 'wep_key0' value 
'<omitted>'
Apr 25 10:24:29 mary NetworkManager: <info>  Config: added 'wep_tx_keyidx' 
value '0'
Apr 25 10:24:29 mary NetworkManager: <info>  Activation (eth1) Stage 2 of 5 
(Device Configure) complete.
Apr 25 10:24:29 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  scanning -> disconnected
Apr 25 10:24:29 mary NetworkManager: <info>  Config: set interface ap_scan to 1
Apr 25 10:24:31 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  disconnected -> scanning
Apr 25 10:24:31 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  scanning -> associating
Apr 25 10:24:31 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  associating -> associated
Apr 25 10:24:31 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  associated -> completed
Apr 25 10:24:31 mary NetworkManager: <info>  Activation (eth1/wireless) Stage 
2 of 5 (Device Configure) successful.  Connected to wireless network 'dd-wrt'.
Apr 25 10:24:31 mary NetworkManager: <info>  Activation (eth1) Stage 3 of 5 
(IP Configure Start) scheduled.
Apr 25 10:24:31 mary NetworkManager: <info>  Activation (eth1) Stage 3 of 5 
(IP Configure Start) started...
Apr 25 10:24:31 mary NetworkManager: <info>  (eth1): device state change: 5 -> 
7
Apr 25 10:24:31 mary NetworkManager: <info>  Activation (eth1) Beginning DHCP 
transaction.
Apr 25 10:24:31 mary NetworkManager: <info>  dhclient started with pid 2780
Apr 25 10:24:31 mary NetworkManager: <info>  Activation (eth1) Stage 3 of 5 
(IP Configure Start) complete.
Apr 25 10:24:31 mary NetworkManager: <info>  DHCP: device eth1 state changed 
(null) -> preinit
Apr 25 10:24:33 mary NetworkManager: <info>  DHCP: device eth1 state changed 
preinit -> bound
Apr 25 10:24:33 mary NetworkManager: <info>  Activation (eth1) Stage 4 of 5 
(IP Configure Get) scheduled...
Apr 25 10:24:33 mary NetworkManager: <info>  Activation (eth1) Stage 4 of 5 
(IP Configure Get) started...
Apr 25 10:24:33 mary NetworkManager: <info>    address 192.168.2.19
Apr 25 10:24:33 mary NetworkManager: <info>    prefix 24 (255.255.255.0)
Apr 25 10:24:33 mary NetworkManager: <info>    gateway 192.168.2.2
Apr 25 10:24:33 mary NetworkManager: <info>    nameserver '159.134.237.6'
Apr 25 10:24:33 mary NetworkManager: <info>    nameserver '159.134.248.17'
Apr 25 10:24:33 mary NetworkManager: <info>    domain name 'gayleard.com'
Apr 25 10:24:33 mary NetworkManager: <info>  Activation (eth1) Stage 5 of 5 
(IP Configure Commit) scheduled...
Apr 25 10:24:33 mary NetworkManager: <info>  Activation (eth1) Stage 4 of 5 
(IP Configure Get) complete.
Apr 25 10:24:33 mary NetworkManager: <info>  Activation (eth1) Stage 5 of 5 
(IP Configure Commit) started...
Apr 25 10:24:34 mary NetworkManager: <info>  (eth1): device state change: 7 -> 
8
Apr 25 10:24:34 mary NetworkManager: <info>  Policy set 'Auto dd-wrt' (eth1) 
as default for routing and DNS.
Apr 25 10:24:34 mary NetworkManager: <info>  Activation (eth1) successful, 
device activated.
Apr 25 10:24:34 mary NetworkManager: <info>  Activation (eth1) Stage 5 of 5 
(IP Configure Commit) complete.
Apr 25 11:36:00 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  completed -> associated
Apr 25 11:36:00 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  associated -> completed
Apr 25 11:36:01 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  completed -> associated
Apr 25 11:36:01 mary NetworkManager: <info>  (eth1): supplicant connection 
state:  associated -> completed
Apr 25 13:04:07 mary NetworkManager: <info>  DHCP: device eth1 state changed 
bound -> renew
Apr 25 13:04:07 mary NetworkManager: <info>    address 192.168.2.19
Apr 25 13:04:07 mary NetworkManager: <info>    prefix 24 (255.255.255.0)
Apr 25 13:04:07 mary NetworkManager: <info>    gateway 192.168.2.2
Apr 25 13:04:07 mary NetworkManager: <info>    nameserver '159.134.237.6'
Apr 25 13:04:07 mary NetworkManager: <info>    nameserver '159.134.248.17'
Apr 25 13:04:07 mary NetworkManager: <info>    domain name 'gayleard.com'
-----------------------------------------------

Apologies for the verbosity, but I am not sure what is relevant.


-- 
Timothy Murphy  
e-mail: gayleard /at/ eircom.net
tel: +353-86-2336090, +353-1-2842366
s-mail: School of Mathematics, Trinity College Dublin