[clug] NetworkManager issue?

Eyal Lebedinsky eyal at eyal.emu.id.au
Fri Jan 22 23:01:33 MST 2010


Being a rather warm day I decided to look into some machine issues
until I can come out for fresh air later in the day.

I have a server with two interfaces. One (eth1) goes to an adsl
modem/router and the other connects to the home machines (eth0).

For starters, when the machine boots up eth0 does not get an ip.
I fix it in rc.local. eth1 is set up properly. Both have very
similar ifcfg-eth* network scripts with static parameters.

I also get the common message:

Jan 23 16:43:30 e7 nm-system-settings:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-eth0 ...
Jan 23 16:43:30 e7 nm-system-settings:    ifcfg-rh:     error: Missing or invalid IP4 prefix '0'

Is it related? I did not manage to get rid of it.

Other things fail at this point, like no nameserver set up in
/etc/resolv.conf, ntpd does not start (rc.local comes later)...

If eth0 goes offline (cable pulled or switch powered off)
the ip goes away (as ifconfig shows), and when the connection
comes back it again does not get an ip. Here is the log from
such an event:

Jan 23 15:54:47 e7 NetworkManager: <info>  (eth0): carrier now OFF (device state 3)
Jan 23 15:54:47 e7 NetworkManager: <info>  (eth0): device state change: 3 -> 2 (reason 40)
Jan 23 15:54:47 e7 NetworkManager: <info>  (eth0): deactivating device (reason: 40).
...
Jan 23 15:54:50 e7 NetworkManager: <info>  (eth0): carrier now ON (device state 2)
Jan 23 15:54:50 e7 NetworkManager: <info>  (eth0): device state change: 2 -> 3 (reason 40)

If the same thing happens of eth1 then I see many more messages.
I assume the extra steps are related to eth1 being the internet
gateway.

Jan 23 14:38:49 e7 NetworkManager: <info>  (eth1): carrier now OFF (device state 8)
Jan 23 14:38:49 e7 NetworkManager: <info>  (eth1): device state change: 8 -> 2 (reason 40)
Jan 23 14:38:49 e7 NetworkManager: <info>  (eth1): deactivating device (reason: 40).

Jan 23 14:38:51 e7 NetworkManager: <info>  (eth1): carrier now ON (device state 2)
Jan 23 14:38:51 e7 NetworkManager: <info>  (eth1): device state change: 2 -> 3 (reason 40)
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) starting connection 'System eth1'
Jan 23 14:38:51 e7 NetworkManager: <info>  (eth1): device state change: 3 -> 4 (reason 0)
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled...
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 1 of 5 (Device Prepare) started...
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 2 of 5 (Device Configure) scheduled...
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 2 of 5 (Device Configure) starting...
Jan 23 14:38:51 e7 NetworkManager: <info>  (eth1): device state change: 4 -> 5 (reason 0)
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 2 of 5 (Device Configure) successful.
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 2 of 5 (Device Configure) complete.
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 3 of 5 (IP Configure Start) started...
Jan 23 14:38:51 e7 NetworkManager: <info>  (eth1): device state change: 5 -> 7 (reason 0)
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 4 of 5 (IP Configure Get) scheduled...
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 3 of 5 (IP Configure Start) complete.
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 4 of 5 (IP Configure Get) started...
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 5 of 5 (IP Configure Commit) scheduled...
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 4 of 5 (IP Configure Get) complete.
Jan 23 14:38:51 e7 NetworkManager: <info>  Activation (eth1) Stage 5 of 5 (IP Configure Commit) started...
Jan 23 14:38:52 e7 NetworkManager: <info>  (eth1): device state change: 7 -> 8 (reason 0)
Jan 23 14:38:52 e7 NetworkManager: <info>  Policy set 'System eth1' (eth1) as default for routing and DNS.
Jan 23 14:38:52 e7 NetworkManager: <info>  Activation (eth1) successful, device activated.
Jan 23 14:38:52 e7 NetworkManager: <info>  Activation (eth1) Stage 5 of 5 (IP Configure Commit) complete.

Important (I think?) is the second last line 'Activation (eth1)
successful' which never show up for eth0.

Doing some searches often ends up with "disable nm"... but I am trying
to stay with the fedora defaults.

Any suggestions where I should look for the reason for the failures?

TIA

--
Eyal Lebedinsky	(eyal at eyal.emu.id.au)




More information about the linux mailing list