Latest NetworkManager test update dying in F8

[Peter Robinson]

Hi All,

I downloaded the latest NetworkManager as part of my updates (which
include testing) last night with the glee of it supporting 3G cards.
Now when I power up this morning NM is broken.

A "service NetworkManager status" reports NetworkManager dead but pid
file exists, the applet doesn't appear.

>From the /var/log/messages I get the output below from a couple of
tries. There's some complaints about selinux but its in permissive
mode so wouldn't actually be blocking.

Also when I try and start nm-applet manually it fails with some errors
about utms (3G card not connected currently) but I suspect its because
NM itself can't startup. Output from that even further below.

Cheers,
Peter

Feb 14 08:21:27 localhost NetworkManager: <info>  starting...
Feb 14 08:21:27 localhost NetworkManager: <info>  Found radio
killswitch /org/freedesktop/Hal/devices/ipw_wlan_switch
Feb 14 08:21:27 localhost NetworkManager: <info>  eth0: Device is
fully-supported using driver 'b44'.
Feb 14 08:21:27 localhost NetworkManager: <info>  Now managing wired
Ethernet (802.3) device 'eth0'.
Feb 14 08:21:27 localhost NetworkManager: <info>  Bringing down device eth0
Feb 14 08:21:27 localhost kernel: b44: eth0: powering down PHY
Feb 14 08:21:27 localhost avahi-daemon[2223]: Interface eth0.IPv4 no
longer relevant for mDNS.
Feb 14 08:21:27 localhost avahi-daemon[2223]: Leaving mDNS multicast
group on interface eth0.IPv4 with address 172.16.4.11.
Feb 14 08:21:27 localhost dhclient: receive_packet failed on eth0:
Network is down
Feb 14 08:21:27 localhost avahi-daemon[2223]: Withdrawing address
record for fe80::21a:4bff:fe5c:ce on eth0.
Feb 14 08:21:27 localhost avahi-daemon[2223]: Withdrawing address
record for 172.16.4.11 on eth0.
Feb 14 08:21:29 localhost NetworkManager: <info>  Bringing up device eth0
Feb 14 08:21:30 localhost kernel: ADDRCONF(NETDEV_UP): eth0: link is not ready
Feb 14 08:21:30 localhost avahi-daemon[2223]: Joining mDNS multicast
group on interface eth0.IPv4 with address 172.16.4.11.
Feb 14 08:21:30 localhost avahi-daemon[2223]: New relevant interface
eth0.IPv4 for mDNS.
Feb 14 08:21:30 localhost avahi-daemon[2223]: Registering new address
record for 172.16.4.11 on eth0.IPv4.
Feb 14 08:21:30 localhost NetworkManager: <info>  Deactivating device eth0.
Feb 14 08:21:30 localhost avahi-daemon[2223]: Withdrawing address
record for 172.16.4.11 on eth0.
Feb 14 08:21:30 localhost avahi-daemon[2223]: Leaving mDNS multicast
group on interface eth0.IPv4 with address 172.16.4.11.
Feb 14 08:21:30 localhost avahi-daemon[2223]: Interface eth0.IPv4 no
longer relevant for mDNS.
Feb 14 08:21:30 localhost NetworkManager: <info>  (eth0): exported as
/org/freedesktop/Hal/devices/net_00_1a_4b_5c_00_ce
Feb 14 08:21:30 localhost NetworkManager: <info>  wlan0: Device is
fully-supported using driver 'iwl3945'.
Feb 14 08:21:30 localhost NetworkManager: <info>  wlan0: driver
supports SSID scans (scan_capa 0x01).
Feb 14 08:21:30 localhost NetworkManager: <info>  Now managing
wireless (802.11) device 'wlan0'.
Feb 14 08:21:30 localhost NetworkManager: <info>  Bringing down device wlan0
Feb 14 08:21:30 localhost kernel: ACPI: PCI interrupt for device
0000:10:00.0 disabled
Feb 14 08:21:30 localhost avahi-daemon[2223]: Withdrawing address
record for fe80::21b:77ff:fe76:b2a6 on wlan0.
Feb 14 08:21:32 localhost NetworkManager: <info>  Bringing up device wlan0
Feb 14 08:21:32 localhost kernel: ACPI: PCI Interrupt 0000:10:00.0[A]
-> GSI 17 (level, low) -> IRQ 17
Feb 14 08:21:32 localhost kernel: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Feb 14 08:21:32 localhost NetworkManager: <info>  Deactivating device wlan0.
Feb 14 08:21:32 localhost NetworkManager: <info>  (wlan0): exported as
/org/freedesktop/Hal/devices/net_00_1b_77_76_b2_a6
Feb 14 08:21:32 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:21:32 localhost kernel: ADDRCONF(NETDEV_CHANGE): wlan0: link
becomes ready
Feb 14 08:21:32 localhost NetworkManager: <info>  (eth0) supplicant
interface is now in state 2 (from 1).
Feb 14 08:21:32 localhost NetworkManager: <info>  (wlan0) supplicant
interface is now in state 2 (from 1).
Feb 14 08:21:32 localhost kernel: printk: 203 messages suppressed.
Feb 14 08:21:32 localhost kernel: nm-system-setti[4648]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007ffff4282b40 error 4
Feb 14 08:21:32 localhost NetworkManager: file dbus-gproxy.c: line 659
(unassociate_proxies): assertion failed: (priv->associated)
Feb 14 08:21:33 localhost kernel: b44: eth0: Link is up at 100 Mbps,
half duplex.
Feb 14 08:21:33 localhost kernel: b44: eth0: Flow control is off for
TX and off for RX.
Feb 14 08:21:33 localhost kernel: ADDRCONF(NETDEV_CHANGE): eth0: link
becomes ready
Feb 14 08:21:33 localhost avahi-daemon[2223]: Registering new address
record for fe80::21b:77ff:fe76:b2a6 on wlan0.*.
Feb 14 08:21:34 localhost setroubleshoot: #012    SELinux is
preventing nm-system-setti(/usr/sbin/nm-system-settings)
(system_dbusd_t) "getattr" to <Unknown> (inotifyfs_t).#012
For complete SELinux messages. run sealert -l
c4a5c22d-eafd-47c0-afb3-e322f146a55a
Feb 14 08:21:34 localhost avahi-daemon[2223]: Registering new address
record for fe80::21a:4bff:fe5c:ce on eth0.*.
Feb 14 08:22:50 localhost NetworkManager: <info>  starting...
Feb 14 08:22:50 localhost NetworkManager: <info>  Found radio
killswitch /org/freedesktop/Hal/devices/ipw_wlan_switch
Feb 14 08:22:50 localhost NetworkManager: <info>  eth0: Device is
fully-supported using driver 'b44'.
Feb 14 08:22:50 localhost NetworkManager: <info>  Now managing wired
Ethernet (802.3) device 'eth0'.
Feb 14 08:22:50 localhost NetworkManager: <info>  Bringing down device eth0
Feb 14 08:22:50 localhost kernel: b44: eth0: powering down PHY
Feb 14 08:22:50 localhost avahi-daemon[2223]: Withdrawing address
record for fe80::21a:4bff:fe5c:ce on eth0.
Feb 14 08:22:50 localhost dhclient: receive_packet failed on eth0:
Network is down
Feb 14 08:22:52 localhost NetworkManager: <info>  Bringing up device eth0
Feb 14 08:22:52 localhost kernel: ADDRCONF(NETDEV_UP): eth0: link is not ready
Feb 14 08:22:52 localhost NetworkManager: <info>  Deactivating device eth0.
Feb 14 08:22:52 localhost NetworkManager: <info>  (eth0): exported as
/org/freedesktop/Hal/devices/net_00_1a_4b_5c_00_ce
Feb 14 08:22:52 localhost NetworkManager: <info>  wlan0: Device is
fully-supported using driver 'iwl3945'.
Feb 14 08:22:52 localhost NetworkManager: <info>  wlan0: driver
supports SSID scans (scan_capa 0x01).
Feb 14 08:22:52 localhost NetworkManager: <info>  Now managing
wireless (802.11) device 'wlan0'.
Feb 14 08:22:52 localhost NetworkManager: <info>  Bringing down device wlan0
Feb 14 08:22:52 localhost avahi-daemon[2223]: Withdrawing address
record for fe80::21b:77ff:fe76:b2a6 on wlan0.
Feb 14 08:22:52 localhost kernel: ACPI: PCI interrupt for device
0000:10:00.0 disabled
Feb 14 08:22:54 localhost NetworkManager: <info>  Bringing up device wlan0
Feb 14 08:22:54 localhost kernel: ACPI: PCI Interrupt 0000:10:00.0[A]
-> GSI 17 (level, low) -> IRQ 17
Feb 14 08:22:54 localhost kernel: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Feb 14 08:22:54 localhost NetworkManager: <info>  Deactivating device wlan0.
Feb 14 08:22:54 localhost NetworkManager: <info>  (wlan0): exported as
/org/freedesktop/Hal/devices/net_00_1b_77_76_b2_a6
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost NetworkManager: <info>  (eth0) supplicant
interface is now in state 2 (from 1).
Feb 14 08:22:54 localhost NetworkManager: <info>  (wlan0) supplicant
interface is now in state 2 (from 1).
Feb 14 08:22:54 localhost kernel: ADDRCONF(NETDEV_CHANGE): wlan0: link
becomes ready
Feb 14 08:22:54 localhost kernel: nm-system-setti[4714]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fffc3585e40 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4716]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fff9e4fadc0 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4718]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fff10312bd0 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4720]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fff76be84b0 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4722]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fffa4e82740 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4724]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fff96f2a7f0 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4726]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fffce882140 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4728]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fff2d40ecd0 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4730]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fff2f34cc10 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:54 localhost kernel: nm-system-setti[4732]: segfault at
0000000000000008 rip 00002aaaab80b36a rsp 00007fff9cad93a0 error 4
Feb 14 08:22:54 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:55 localhost NetworkManager:last message repeated 53 times
Feb 14 08:22:55 localhost kernel: b44: eth0: Link is up at 100 Mbps,
half duplex.
Feb 14 08:22:55 localhost kernel: b44: eth0: Flow control is off for
TX and off for RX.
Feb 14 08:22:55 localhost kernel: ADDRCONF(NETDEV_CHANGE): eth0: link
becomes ready
Feb 14 08:22:55 localhost NetworkManager: <info>  SWITCH: no current
connection, found better connection 'Auto Ethernet (eth0)'.
Feb 14 08:22:55 localhost NetworkManager: <info>  Activating device eth0
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 1 of 5 (Device Prepare) scheduled...
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 1 of 5 (Device Prepare) started...
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 2 of 5 (Device Configure) scheduled...
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 1 of 5 (Device Prepare) complete.
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 2 of 5 (Device Configure) starting...
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 2 of 5 (Device Configure) successful.
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 3 of 5 (IP Configure Start) scheduled.
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 2 of 5 (Device Configure) complete.
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 3 of 5 (IP Configure Start) started...
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Beginning DHCP transaction.
Feb 14 08:22:55 localhost NetworkManager: <info>  dhclient started with pid 4842
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 3 of 5 (IP Configure Start) complete.
Feb 14 08:22:55 localhost dhclient: Internet Systems Consortium DHCP
Client V3.0.6-Fedora
Feb 14 08:22:55 localhost dhclient: Copyright 2004-2007 Internet
Systems Consortium.
Feb 14 08:22:55 localhost dhclient: All rights reserved.
Feb 14 08:22:55 localhost dhclient: For info, please visit
http://www.isc.org/sw/dhcp/
Feb 14 08:22:55 localhost dhclient:
Feb 14 08:22:55 localhost dhclient: wmaster0: unknown hardware address type 801
Feb 14 08:22:55 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:55 localhost NetworkManager:last message repeated 3 times
Feb 14 08:22:55 localhost dhclient: wmaster0: unknown hardware address type 801
Feb 14 08:22:55 localhost NetworkManager: <info>  DHCP: device eth0
state changed (null) -> preinit
Feb 14 08:22:55 localhost dhclient: Listening on LPF/eth0/00:1a:4b:5c:00:ce
Feb 14 08:22:55 localhost dhclient: Sending on   LPF/eth0/00:1a:4b:5c:00:ce
Feb 14 08:22:55 localhost dhclient: Sending on   Socket/fallback
Feb 14 08:22:55 localhost dhclient: DHCPDISCOVER on eth0 to
255.255.255.255 port 67 interval 5
Feb 14 08:22:55 localhost dhclient: DHCPOFFER from 172.16.1.9
Feb 14 08:22:55 localhost dhclient: DHCPREQUEST on eth0 to
255.255.255.255 port 67
Feb 14 08:22:55 localhost dhclient: DHCPACK from 172.16.1.9
Feb 14 08:22:55 localhost NetworkManager: <info>  Trying to start the
system settings daemon...
Feb 14 08:22:55 localhost dhclient: bound to 172.16.4.11 -- renewal in
13079 seconds.
Feb 14 08:22:55 localhost NetworkManager: <info>  DHCP: device eth0
state changed preinit -> bound
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 4 of 5 (IP Configure Get) scheduled...
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 4 of 5 (IP Configure Get) started...
Feb 14 08:22:55 localhost NetworkManager: <info>    address 172.16.4.11
Feb 14 08:22:55 localhost NetworkManager: <info>    netmask 255.255.248.0
Feb 14 08:22:55 localhost NetworkManager: <info>    broadcast 172.16.255.255
Feb 14 08:22:55 localhost NetworkManager: <info>    gateway 172.16.0.1
Feb 14 08:22:55 localhost NetworkManager: <info>    nameserver '172.16.1.9'
Feb 14 08:22:55 localhost NetworkManager: <info>    nameserver '213.130.62.249'
Feb 14 08:22:55 localhost NetworkManager: <info>    nameserver '213.198.86.135'
Feb 14 08:22:55 localhost NetworkManager: <info>    domain name
'int.online.ntt.eu'
Feb 14 08:22:55 localhost NetworkManager: <info>    domain name 'eu.verio.net'
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 5 of 5 (IP Configure Commit) scheduled...
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 4 of 5 (IP Configure Get) complete.
Feb 14 08:22:55 localhost NetworkManager: <info>  Activation (eth0)
Stage 5 of 5 (IP Configure Commit) started...
Feb 14 08:22:55 localhost avahi-daemon[2223]: Joining mDNS multicast
group on interface eth0.IPv4 with address 172.16.4.11.
Feb 14 08:22:55 localhost avahi-daemon[2223]: New relevant interface
eth0.IPv4 for mDNS.
Feb 14 08:22:55 localhost avahi-daemon[2223]: Registering new address
record for 172.16.4.11 on eth0.IPv4.
Feb 14 08:22:55 localhost avahi-daemon[2223]: Registering new address
record for fe80::21b:77ff:fe76:b2a6 on wlan0.*.
Feb 14 08:22:56 localhost NetworkManager: <info>  Activation (eth0)
successful, device activated.
Feb 14 08:22:56 localhost NetworkManager: <info>  Activation (eth0)
Stage 5 of 5 (IP Configure Commit) complete.
Feb 14 08:22:56 localhost NetworkManager: file dbus-gproxy.c: line 659
(unassociate_proxies): assertion failed: (priv->associated)
Feb 14 08:22:56 localhost gnome-keyring-daemon[2693]: couldn't read 4
bytes from client:
Feb 14 08:22:56 localhost gnome-keyring-daemon[2693]: couldn't read 4
bytes from client:
Feb 14 08:22:58 localhost avahi-daemon[2223]: Registering new address
record for fe80::21a:4bff:fe5c:ce on eth0.*.
Feb 14 08:22:58 localhost dnsmasq[2347]: reading /etc/resolv.conf
Feb 14 08:22:58 localhost dnsmasq[2347]: using nameserver 213.198.86.135#53
Feb 14 08:22:58 localhost dnsmasq[2347]: using nameserver 213.130.62.249#53
Feb 14 08:22:58 localhost dnsmasq[2347]: using nameserver 172.16.1.9#53
Feb 14 08:22:58 localhost setroubleshoot: #012    SELinux is
preventing nm-system-setti(/usr/sbin/nm-system-settings)
(system_dbusd_t) "getattr" to <Unknown> (inotifyfs_t).#012
For complete SELinux messages. run sealert -l
c4a5c22d-eafd-47c0-afb3-e322f146a55a
Feb 14 08:22:58 localhost setroubleshoot: #012    SELinux is
preventing the dhclient(/sbin/dhclient) from using potentially
mislabeled files (<Unknown>).#012     For complete SELinux
messages. run sealert -l df941369-6ce6-49df-ad44-18fcf4b0f607
Feb 14 08:22:58 localhost setroubleshoot: #012    SELinux is
preventing the dhclient(/sbin/dhclient) from using potentially
mislabeled files (/etc/services).#012     For complete SELinux
messages. run sealert -l 6f0ac0d2-bf99-48ad-a23f-d3fc4437b4db

[perobinson at euuklonw7300b1n ~]$ nm-applet

** (nm-applet:3587): WARNING **: Unknown setting 'umts'

** (nm-applet:3587): WARNING **: Required setting 'umts' not found.

** (nm-applet:3587): WARNING **: Invalid connection read from GConf at
/system/networking/connections/4.

** (nm-applet:3587): WARNING **: nm_object_get_property: Error getting
'WirelessEnabled' for /org/freedesktop/NetworkManager: The name
org.freedesktop.NetworkManager was not provided by any .service files


** (nm-applet:3587): WARNING **: nm_object_get_property: Error getting
'WirelessHardwareEnabled' for /org/freedesktop/NetworkManager: The
name org.freedesktop.NetworkManager was not provided by any .service
files


** (nm-applet:3587): WARNING **: nm_object_get_property: Error getting
'State' for /org/freedesktop/NetworkManager: The name
org.freedesktop.NetworkManager was not provided by any .service files


** (nm-applet:3587): WARNING **: Error in getting VPN connections: The
name org.freedesktop.NetworkManager was not provided by any .service
files