[blfs-support] Network Manager Woes

Dan McGhee beesnees at grm.net
Sun Dec 15 14:29:54 PST 2013


I installed and configured Network Manager--and double checked-as the 
BLFS book indicates.  The first sign of trouble what when I rebooted and 
the boot "hung" with 2 error messages from NetworkManager repeating.  
They were the wlano statements below about the device becoming 
disasociated.  I had to reboot again and remove the networkmanager boot 
scripts from the chroot environment in Ubuntu.

I researched the man pages, and all the documentation I could find about 
configuring Network Manager, but anything I tried didn't work.  I have 
been running my tests as 'root' to obviate the need to build the scripts 
noted in the wiki on the NetworkManager BLFS page.

To see if I could figure things out, I've been running <NetworkManager 
--no-daemon> from the command line.  I've not yet been able to make 
sense of the output.  The net result is the final messages logged below 
just before I hit 'CTRL-C' and in the process NetworkManager takes my 
wireless card down.  I need to restart the network.

This is my NetworkManager.conf file:

> [main]
> plugins=keyfile
> dhcp=dhcpcd
>
> [logging]
> level=DEBUG

And here, I'm sorry to post so much, is the output from running 
NetworkManager (I've removed the statements about eth0 because I'm not 
wired):

> NetworkManager[28530]: <info> NetworkManager (version 0.9.8.8) is 
> starting...
> NetworkManager[28530]: <info> Read config file 
> /etc/NetworkManager/NetworkManager.conf
> NetworkManager[28530]: <info> WEXT support is enabled
> NetworkManager[28530]: <info> Loaded plugin keyfile: (c) 2007 - 2010 
> Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
> NetworkManager[28530]: <debug> [1387144646.128700] 
> [nm-modem-manager.c:376] modem_manager_disappeared(): trying to start 
> the modem manager...
> NetworkManager[28530]: <debug> [1387144646.129211] 
> [nm-modem-manager.c:280] poke_modem_cb(): Requesting to (re)launch 
> modem-manager...
> NetworkManager[28530]: <info> monitoring kernel firmware directory 
> '/lib/firmware'.
> NetworkManager[28530]: <debug> [1387144646.130732] 
> [nm-firewall-manager.c:248] nm_firewall_manager_init(): firewall is 
> not running
> NetworkManager[28530]: <info> rfkill0: found WiFi radio killswitch (at 
> /sys/devices/pci0000:00/0000:00:05.0/0000:02:00.0/ieee80211/phy0/rfkill0) 
> (driver rt2800pci)
> NetworkManager[28530]: <debug> [1387144646.133717] 
> [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill switch 
> rfkill0 state now 1/0
> NetworkManager[28530]: <info> WiFi hardware radio set enabled
> NetworkManager[28530]: <info> WiFi enabled by radio killswitch; 
> enabled by state file
> NetworkManager[28530]: <info> WWAN enabled by radio killswitch; 
> enabled by state file
> NetworkManager[28530]: <info> WiMAX enabled by radio killswitch; 
> enabled by state file
> NetworkManager[28530]: <info> Networking is enabled by state file
> NetworkManager[28530]: <warn> failed to allocate link cache: (-10) 
> Operation not supported
> NetworkManager[28530]: <debug> [1387144646.138735] 
> [nm-device-ethernet.c:1607] supports_ethtool_carrier_detect(): ethtool 
> is supported
> NetworkManager[28530]: <debug> [1387144646.138992] 
> [nm-device-wired.c:313] constructor(): (eth0): kernel ifindex 3
[deleted eth0 statements.  no wired connection]
>
> NetworkManager[28530]: <debug> [1387144646.143967] 
> [nm-settings-connection.c:1524] 
> nm_settings_connection_read_and_fill_timestamp(): failed to read 
> connection timestamp for '892bbfce-c2e9-4a71-96f8-8268840997a3': (4) 
> Key file does not have group 'timestamps'
> NetworkManager[28530]: <debug> [1387144646.144660] [nm-manager.c:1381] 
> system_create_virtual_devices(): creating virtual devices...
> NetworkManager[28530]: <debug> [1387144646.145235] 
> [nm-device-wifi.c:309] constructor(): (wlan0): kernel ifindex 4
> NetworkManager[28530]: <info> (wlan0): using nl80211 for WiFi device 
> control
> NetworkManager[28530]: <info> (wlan0): driver supports Access Point 
> (AP) mode
> NetworkManager[28530]: <debug> [1387144646.145877] 
> [nm-device-wifi.c:2930] update_initial_hw_address(): (wlan0): read 
> initial MAC address BC:85:56:53:32:25
> NetworkManager[28530]: <debug> [1387144646.146077] [nm-manager.c:1726] 
> manager_rfkill_update_one_type(): WiFi hw-enabled 1 sw-enabled 1
> NetworkManager[28530]: <debug> [1387144646.146125] 
> [nm-device-wifi.c:3576] set_enabled(): (wlan0): device now enabled
> NetworkManager[28530]: <debug> [1387144646.146167] 
> [nm-device-wifi.c:3582] set_enabled(): (enable): wlan0 blocked by 
> UNMANAGED state
> NetworkManager[28530]: <info> (wlan0): new 802.11 WiFi device (driver: 
> 'rt2800pci' ifindex: 4)
> NetworkManager[28530]: <info> (wlan0): exported as 
> /org/freedesktop/NetworkManager/Devices/1
> NetworkManager[28530]: <debug> [1387144646.146329] [nm-device.c:5314] 
> nm_device_set_managed(): (wlan0): now managed
> NetworkManager[28530]: <info> (wlan0): device state change: unmanaged 
> -> unavailable (reason 'managed') [10 20 2]
> NetworkManager[28530]: <info> (wlan0): preparing device.
> NetworkManager[28530]: <info> (wlan0): deactivating device (reason 
> 'managed') [2]
> NetworkManager[28530]: <debug> [1387144646.146663] 
> [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting 
> '/proc/sys/net/ipv6/conf/wlan0/accept_ra' to '0'
> NetworkManager[28530]: <debug> [1387144646.146717] 
> [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting 
> '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0'
> NetworkManager[28530]: <debug> [1387144646.146774] 
> [nm-device-wifi.c:854] _set_hw_addr(): (wlan0): no MAC address change 
> needed
> NetworkManager[28530]: <debug> [1387144646.146899] [nm-system.c:1404] 
> nm_system_iface_flush_routes(): (wlan0): flushing routes ifindex 4 
> family INET (2)
> NetworkManager[28530]: <debug> [1387144646.147041] 
> [nm-netlink-utils.c:356] dump_route():   route idx 1 family INET (2) 
> addr 127.0.0.0/32
> NetworkManager[28530]: <debug> [1387144646.147089] 
> [nm-netlink-utils.c:356] dump_route():   route idx 1 family INET (2) 
> addr 127.0.0.0/8
> NetworkManager[28530]: <debug> [1387144646.147131] 
> [nm-netlink-utils.c:356] dump_route():   route idx 1 family INET (2) 
> addr 127.0.0.1/32
> NetworkManager[28530]: <debug> [1387144646.147173] 
> [nm-netlink-utils.c:356] dump_route():   route idx 1 family INET (2) 
> addr 127.255.255.255/32
> NetworkManager[28530]: <debug> [1387144646.147213] 
> [nm-netlink-utils.c:356] dump_route():   route idx 1 family INET (2) 
> addr 192.168.1.4/32
> NetworkManager[28530]: <debug> [1387144646.147349] [nm-system.c:194] 
> sync_addresses(): (wlan0): syncing addresses (family 2)
> NetworkManager[28530]: <debug> [1387144646.147588] 
> [nm-supplicant-manager.c:90] nm_supplicant_manager_iface_get(): 
> (wlan0): creating new supplicant interface
> NetworkManager[28530]: <debug> [1387144646.147914] 
> [nm-supplicant-interface.c:1022] interface_add(): (wlan0): adding 
> interface to supplicant
> NetworkManager[28530]: <debug> [1387144646.166440] 
> [nm-device-wifi.c:1381] is_available(): (wlan0): not available because 
> supplicant interface not ready
> NetworkManager[28530]: <debug> [1387144646.166633] [nm-device.c:5146] 
> nm_device_state_changed(): (wlan0): device not yet available for 
> transition to DISCONNECTED
> NetworkManager[28530]: <debug> [1387144646.166771] [nm-manager.c:1381] 
> system_create_virtual_devices(): creating virtual devices...
> NetworkManager[28530]: <warn> /sys/devices/virtual/net/lo: couldn't 
> determine device driver; ignoring...
> NetworkManager[28530]: <warn> /sys/devices/virtual/net/sit0: couldn't 
> determine device driver; ignoring...
> NetworkManager[28530]: <warn> /sys/devices/virtual/net/lo: couldn't 
> determine device driver; ignoring...
> NetworkManager[28530]: <warn> /sys/devices/virtual/net/sit0: couldn't 
> determine device driver; ignoring...
> NetworkManager[28530]: <debug> [1387144646.171988] [nm-manager.c:1381] 
> system_create_virtual_devices(): creating virtual devices...
> NetworkManager[28530]: <debug> [1387144646.172257] [main.c:611] 
> main(): setting up local loopback
> NetworkManager[28530]: <debug> [1387144646.172687] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x11003
> NetworkManager[28530]: <debug> [1387144646.173095] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x11043
> NetworkManager[28530]: <warn> Couldn't get managed objects: 
> GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name 
> org.bluez was not provided by any .service files
> NetworkManager[28530]: <debug> [1387144646.179484] 
> [nm-supplicant-manager.c:182] get_capabilities_cb(): AP mode is not 
> supported
> NetworkManager[28530]: <debug> [1387144646.181129] 
> [nm-supplicant-manager.c:194] get_capabilities_cb(): EAP-FAST is not 
> supported
> NetworkManager[28530]: <debug> [1387144646.181428] 
> [nm-supplicant-interface.c:849] interface_add_done(): (wlan0): 
> interface added to supplicant
> NetworkManager[28530]: <info> (wlan0) supports 4 scan SSIDs
> NetworkManager[28530]: <debug> [1387144646.183046] 
> [nm-supplicant-interface.c:747] iface_check_netreply_cb(): Supplicant 
> supports network credentials requests
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> starting -> ready
> NetworkManager[28530]: <info> (wlan0): device state change: 
> unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
> NetworkManager[28530]: <warn> Trying to remove a non-existant call id.
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> ready -> disconnected
> NetworkManager[28530]: <info> (wlan0) supports 4 scan SSIDs
> NetworkManager[28530]: <debug> [1387144646.204897] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 1 flags 0x10049
> NetworkManager[28530]: <debug> [1387144646.204948] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 2 flags 0x80
> NetworkManager[28530]: <debug> [1387144646.204965] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 3 flags 0x1003
> NetworkManager[28530]: <debug> [1387144646.204981] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x11043
> NetworkManager[28530]: <debug> [1387144649.81125] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x1003
> NetworkManager[28530]: <debug> [1387144649.81279] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x11043
> NetworkManager[28530]: <debug> [1387144649.82098] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x1043
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> disconnected -> inactive
> NetworkManager[28530]: <warn> Connection disconnected (reason -2)
> NetworkManager[28530]: <debug> [1387144649.83947] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x1003
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> inactive -> disconnected
> NetworkManager[28530]: <debug> [1387144650.232810] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x1003
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> disconnected -> inactive
> NetworkManager[28530]: <debug> [1387144650.255568] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x11003
> NetworkManager[28530]: <debug> [1387144650.255642] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x11003
> NetworkManager[28530]: <debug> [1387144650.255676] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x11003
> NetworkManager[28530]: <debug> [1387144650.281239] 
> [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: 
> iface idx 4 flags 0x1003
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> inactive -> associated
> NetworkManager[28530]: <warn> Connection disconnected (reason -3)
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> associated -> disconnected
> NetworkManager[28530]: <warn> Connection disconnected (reason -3)
> NetworkManager[28530]: <info> (wlan0): supplicant interface state: 
> disconnected -> scanning
> ^CNetworkManager[28530]: <info> caught signal 2, shutting down normally.
> NetworkManager[28530]: <debug> [1387144650.946859] [nm-device.c:5314] 
> nm_device_set_managed(): (eth0): now unmanaged
> NetworkManager[28530]: <info> (eth0): device state change: unavailable 
> -> unmanaged (reason 'removed') [20 10 36]
> NetworkManager[28530]: <info> (eth0): cleaning up...
> NetworkManager[28530]: <info> (eth0): taking down device.
> NetworkManager[28530]: <debug> [1387144650.950961] 
> [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting 
> '/proc/sys/net/ipv6/conf/eth0/accept_ra' to '1'
> NetworkManager[28530]: <debug> [1387144650.951150] 
> [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting 
> '/proc/sys/net/ipv6/conf/eth0/use_tempaddr' to '0'
> NetworkManager[28530]: <debug> [1387144650.951303] [nm-device.c:5314] 
> nm_device_set_managed(): (wlan0): now unmanaged
> NetworkManager[28530]: <info> (wlan0): device state change: 
> disconnected -> unmanaged (reason 'removed') [30 10 36]
> NetworkManager[28530]: <info> (wlan0): cleaning up...
> NetworkManager[28530]: <info> (wlan0): taking down device.
> NetworkManager[28530]: <debug> [1387144650.969026] 
> [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting 
> '/proc/sys/net/ipv6/conf/wlan0/accept_ra' to '1'
> NetworkManager[28530]: <debug> [1387144650.969255] 
> [NetworkManagerUtils.c:637] nm_utils_do_sysctl(): sysctl: setting 
> '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0'
> NetworkManager[28530]: <info> exiting (success)
I circumvented any ownership and persmissions problems by installing as 
root.  Once again, I'm sorry to post so much logging output, but I 
didn't know what was relevant.

Thanks,
Dan




More information about the blfs-support mailing list