[Pkg-utopia-maintainers] Bug#762740: No network devices available
Michal Hocko
mstsxfx at gmail.com
Wed Sep 24 20:31:41 UTC 2014
Package: network-manager
Version: 0.9.4.0-10
Severity: serious
Hi,
it seems that network-manager stopped being able to handle my lan and
wlan devices properly after last series of updates (which don't seem to
be directly related to the nm packages). Although I can get connected to
both wired and wireless (to the system wide saved networks) nm-applet
(network-manager-gnome package) claims that there are "No network
devices available" so it doesn't give me access to neither of the
saved networks nor to the saved VPN configurations.
I originally wanted to report this agains network-manager-gnome package
but I think this comes from network-manager and the applet simply relays
to information.
/etc/NetworkManager/NetworkManager.conf is default one:
[main]
plugins=ifupdown,keyfile
[ifupdown]
managed=false
and /etc/network/interfaces:
# This file describes the network interfaces available on your system
# and how to activate them. For more information, see interfaces(5).
# The loopback network interface
auto lo
iface lo inet loopback
# The primary network interface
allow-hotplug eth0
#NetworkManager#iface lan0 inet dhcp
Here is what my log says after I start nm:
Sep 24 22:13:38 tiehlicka dbus[3380]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> NetworkManager (version 0.9.4.0) is starting...
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> Read config file /etc/NetworkManager/NetworkManager.conf
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: init!
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: update_system_hostname
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPluginIfupdown: management mode: unmanaged
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: devices added (path: /sys/devices/pci0000:00/0000:00:19.0/net/lan0, iface: lan0)
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: device added (path: /sys/devices/pci0000:00/0000:00:19.0/net/lan0, iface: lan0): no ifupdown configuration found.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: devices added (path: /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/net/wlan0, iface: wlan0)
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: device added (path: /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/net/wlan0, iface: wlan0): no ifupdown configuration found.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/lo, iface: lo)
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/sit0, iface: sit0)
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/sit0, iface: sit0): no ifupdown configuration found.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: end _init.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> Loaded plugin ifupdown: (C) 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc. To report bugs please use the NetworkManager mailing list.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: Ifupdown: get unmanaged devices count: 0
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: (7664400) ... get_connections.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: SCPlugin-Ifupdown: (7664400) ... get_connections (managed=false): return empty list.
[ ... keyfile: parsting XYZ removed ... ]
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: Ifupdown: get unmanaged devices count: 0
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> trying to start the modem manager...
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> monitoring kernel firmware directory '/lib/firmware'.
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> monitoring ifupdown state file '/run/network/ifstate'.
Sep 24 22:13:42 tiehlicka dbus[3380]: [system] Activating service name='org.bluez' (using servicehelper)
Sep 24 22:13:42 tiehlicka dbus[3380]: [system] Activated service 'org.bluez' failed: Launch helper exited with unknown return code 1
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> WiFi enabled by radio killswitch; enabled by state file
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> WWAN enabled by radio killswitch; enabled by state file
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> WiMAX enabled by radio killswitch; enabled by state file
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> Networking is enabled by state file
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <warn> failed to allocate link cache: (-26) Protocol mismatch
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> (lan0): carrier is OFF
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> (lan0): new Ethernet device (driver: 'e1000e' ifindex: 2)
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> (lan0): exported as /org/freedesktop/NetworkManager/Devices/0
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> (lan0): now managed
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> (lan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 24 22:13:42 tiehlicka NetworkManager[9129]: <info> (lan0): bringing up device.
Sep 24 22:13:42 tiehlicka kernel: [ 3251.304391] e1000e 0000:00:19.0: irq 25 for MSI/MSI-X
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (lan0): preparing device.
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (lan0): deactivating device (reason 'managed') [2]
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): using nl80211 for WiFi device control
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): new 802.11 WiFi device (driver: 'iwlwifi' ifindex: 4)
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): exported as /org/freedesktop/NetworkManager/Devices/1
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): now managed
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): bringing up device.
Sep 24 22:13:43 tiehlicka kernel: [ 3251.406177] e1000e 0000:00:19.0: irq 25 for MSI/MSI-X
Sep 24 22:13:43 tiehlicka kernel: [ 3251.406361] IPv6: ADDRCONF(NETDEV_UP): lan0: link is not ready
Sep 24 22:13:43 tiehlicka kernel: [ 3251.408421] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S
Sep 24 22:13:43 tiehlicka kernel: [ 3251.408643] iwlwifi 0000:02:00.0: Radio type=0x0-0x3-0x1
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): preparing device.
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): deactivating device (reason 'managed') [2]
Sep 24 22:13:43 tiehlicka wpa_supplicant[3687]: rfkill: Cannot open RFKILL control device
Sep 24 22:13:43 tiehlicka kernel: [ 3251.516392] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <warn> bluez error getting default adapter: Launch helper exited with unknown return code 1
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): supplicant interface state: starting -> ready
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <info> (wlan0): supplicant interface state: ready -> inactive
Sep 24 22:13:43 tiehlicka NetworkManager[9129]: <warn> Trying to remove a non-existant call id.
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Auto-activating connection 'mameluci'.
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) starting connection 'mameluci'
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0/wireless): connection 'mameluci' has security, and secrets exist. No new secrets needed.
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Config: added 'ssid' value 'mameluci'
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Config: added 'scan_ssid' value '1'
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Config: added 'key_mgmt' value 'NONE'
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Config: added 'wep_key0' value '<omitted>'
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Config: added 'wep_tx_keyidx' value '0'
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> Config: set interface ap_scan to 1
Sep 24 22:13:46 tiehlicka NetworkManager[9129]: <info> (wlan0): supplicant interface state: inactive -> scanning
Sep 24 22:13:49 tiehlicka wpa_supplicant[3687]: wlan0: SME: Trying to authenticate with c0:4a:00:f1:48:f2 (SSID='mameluci' freq=2412 MHz)
Sep 24 22:13:49 tiehlicka kernel: [ 3257.769425] wlan0: authenticate with c0:4a:00:f1:48:f2
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 22:13:49 tiehlicka kernel: [ 3257.776593] wlan0: send auth to c0:4a:00:f1:48:f2 (try 1/3)
Sep 24 22:13:49 tiehlicka wpa_supplicant[3687]: wlan0: Trying to associate with c0:4a:00:f1:48:f2 (SSID='mameluci' freq=2412 MHz)
Sep 24 22:13:49 tiehlicka kernel: [ 3257.779530] wlan0: authenticated
Sep 24 22:13:49 tiehlicka kernel: [ 3257.779743] iwlwifi 0000:02:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use
Sep 24 22:13:49 tiehlicka kernel: [ 3257.782259] wlan0: associate with c0:4a:00:f1:48:f2 (try 1/3)
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> (wlan0): supplicant interface state: authenticating -> associating
Sep 24 22:13:49 tiehlicka kernel: [ 3257.785369] wlan0: RX AssocResp from c0:4a:00:f1:48:f2 (capab=0x31 status=0 aid=1)
Sep 24 22:13:49 tiehlicka wpa_supplicant[3687]: wlan0: Associated with c0:4a:00:f1:48:f2
Sep 24 22:13:49 tiehlicka wpa_supplicant[3687]: wlan0: CTRL-EVENT-CONNECTED - Connection to c0:4a:00:f1:48:f2 completed (auth) [id=0 id_str=]
Sep 24 22:13:49 tiehlicka kernel: [ 3257.791320] wlan0: associated
Sep 24 22:13:49 tiehlicka kernel: [ 3257.791360] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> (wlan0): supplicant interface state: associating -> completed
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'mameluci'.
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> dhclient started with pid 9153
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Beginning IP6 addrconf.
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Sep 24 22:13:49 tiehlicka dhclient: Internet Systems Consortium DHCP Client 4.3.1
Sep 24 22:13:49 tiehlicka dhclient: Copyright 2004-2014 Internet Systems Consortium.
Sep 24 22:13:49 tiehlicka dhclient: All rights reserved.
Sep 24 22:13:49 tiehlicka dhclient: For info, please visit https://www.isc.org/software/dhcp/
Sep 24 22:13:49 tiehlicka dhclient:
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
Sep 24 22:13:49 tiehlicka dhclient: Listening on LPF/wlan0/24:77:03:92:9a:c4
Sep 24 22:13:49 tiehlicka dhclient: Sending on LPF/wlan0/24:77:03:92:9a:c4
Sep 24 22:13:49 tiehlicka dhclient: Sending on Socket/fallback
Sep 24 22:13:49 tiehlicka dhclient: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Sep 24 22:13:49 tiehlicka dhclient: DHCPACK from 192.168.2.3
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> (wlan0): DHCPv4 state changed preinit -> reboot
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> address 192.168.2.5
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> prefix 24 (255.255.255.0)
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> gateway 192.168.2.3
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> nameserver '192.168.2.3'
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Sep 24 22:13:49 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Sep 24 22:13:49 tiehlicka dhclient: bound to 192.168.2.5 -- renewal in 2147483648 seconds.
Sep 24 22:13:50 tiehlicka NetworkManager[9129]: <info> (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0]
Sep 24 22:13:50 tiehlicka NetworkManager[9129]: <info> Policy set 'mameluci' (wlan0) as default for IPv4 routing and DNS.
Sep 24 22:13:50 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) successful, device activated.
Sep 24 22:13:50 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
Sep 24 22:13:50 tiehlicka dbus[3380]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
Sep 24 22:13:50 tiehlicka dbus[3380]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Sep 24 22:14:00 tiehlicka ntpdate[9195]: adjust time server 195.113.144.201 offset -0.008680 sec
Sep 24 22:14:09 tiehlicka NetworkManager[9129]: <info> (wlan0): IP6 addrconf timed out or failed.
Sep 24 22:14:09 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
Sep 24 22:14:09 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) started...
Sep 24 22:14:09 tiehlicka NetworkManager[9129]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
I really do not understand what
"SCPlugin-Ifupdown: (7664400) ... get_connections (managed=false): return empty list."
means but to me it sounds like it wasn't able to find any device to
manage. It is still interesting to see that the wireless connection was
handled by NetworkManager anyway. So I might be completely wrong and
this can be the applet bug after all.
I have a suspicion that the problem started around the same time
avahi-daemon was pulled in as a dependency of one of the updated
packages.
Let me know if you need any further information.
-- System Information:
Debian Release: jessie/sid
APT prefers unstable
APT policy: (500, 'unstable'), (500, 'testing'), (500, 'stable')
Architecture: amd64 (x86_64)
Kernel: Linux 3.17.0-rc6 (SMP w/2 CPU cores; PREEMPT)
Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Versions of packages network-manager depends on:
ii adduser 3.113+nmu3
ii dbus 1.6.18-1
ii dpkg 1.17.13
ii isc-dhcp-client 4.3.1-1
ii libc6 2.19-11
ii libdbus-1-3 1.8.8-1
ii libdbus-glib-1-2 0.102-1
ii libgcrypt11 1.5.4-3
ii libglib2.0-0 2.42.0-1
ii libgnutls26 2.12.23-17
ii libgudev-1.0-0 204-10
ii libnl-3-200 3.2.24-2
ii libnl-genl-3-200 3.2.24-2
ii libnl-route-3-200 3.2.24-2
ii libnm-glib4 0.9.10.0-2.1
ii libnm-util2 0.9.10.0-2.1
ii libpolkit-gobject-1-0 0.105-3
ii libuuid1 2.20.1-5.8
ii lsb-base 4.1+Debian13
ii udev 175-7.2
ii wpasupplicant 1.0-3+b2
Versions of packages network-manager recommends:
ii crda 3.13-1
ii dnsmasq-base 2.71-1
ii iptables 1.4.21-2
pn modemmanager <none>
ii policykit-1 0.105-4
pn ppp <none>
Versions of packages network-manager suggests:
pn avahi-autoipd <none>
-- Configuration Files:
/etc/polkit-1/localauthority/10-vendor.d/org.freedesktop.NetworkManager.pkla [Errno 13] Permission denied: u'/etc/polkit-1/localauthority/10-vendor.d/org.freedesktop.NetworkManager.pkla'
-- no debconf information
--
Michal Hocko
More information about the Pkg-utopia-maintainers
mailing list