[Pkg-utopia-maintainers] Bug#749191: Bug#749191: network-manager does not auto connect to wireless connection after system start anymore

Sun May 25 00:06:49 UTC 2014

Am 24.5.2014 18:51, schrieb Michael Biebl:
> Am 25.05.2014 01:46, schrieb Michael Meier:
>> Package: network-manager
>> Version: 0.9.8.10-2
>> Severity: normal
>> 
>> When starting the system network-manager does not automatically 
>> connect to wireless connections marked as "connect automatically".
>> One has to connect to them by hand. Once connected it tries to 
>> automatically reconnect when it looses connection.
>> In previous verions that used to work.
>> 
> 
> Please send me a debug log. Follow the instructions at [1].
> 
> Michael
> 
> [1] https://wiki.gnome.org/Projects/NetworkManager/Debugging

below the output of syslog.
When it connects at 18:50 it's because I manually told it so.
I'm not really sure how to get any output from wpa_supplicant at 
systemstart...
Maybe it's not needed (as far as I understand the log it seems like it 
even doesn't try to connect.

May 24 18:48:58 RMMbook avahi-daemon[2930]: Network interface 
enumeration completed.
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> NetworkManager 
(version 0.9.8.10) is starting...
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> Read config file 
/etc/NetworkManager/NetworkManager.conf
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> WEXT support is 
enabled
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> VPN: loaded 
org.freedesktop.NetworkManager.vpnc
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> VPN: loaded 
org.freedesktop.NetworkManager.openvpn
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> VPN: loaded 
org.freedesktop.NetworkManager.pptp
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
init!
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
update_system_hostname
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPluginIfupdown: 
management mode: unmanaged
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
devices added (path: 
/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0/net/wlan0, iface: 
wlan0)
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
device added (path: 
/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0/net/wlan0, iface: 
wlan0): no ifupdown configuration found.
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
devices added (path: 
/sys/devices/pci0000:00/0000:00:1c.3/0000:02:00.0/net/eth0, iface: eth0)
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
device added (path: 
/sys/devices/pci0000:00/0000:00:1c.3/0000:02:00.0/net/eth0, iface: 
eth0): no ifupdown configuration found.
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
devices added (path: /sys/devices/virtual/net/lo, iface: lo)
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown 
configuration found.
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: end 
_init.
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> Loaded plugin 
ifupdown: (C) 2008 Canonical Ltd.  To report bugs please use the 
NetworkManager mailing list.
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> Loaded plugin 
keyfile: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the 
NetworkManager mailing list.
May 24 18:48:58 RMMbook NetworkManager[3026]:    Ifupdown: get unmanaged 
devices count: 0
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
(10240544) ... get_connections.
May 24 18:48:58 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
(10240544) ... get_connections (managed=false): return empty list.
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing Yoga 
Vishnu Studio ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'Yoga Vishnu Studio'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
59293779 ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection '59293779'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
48540314 ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection '48540314'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
FAMILIA ACOSTA VELANDIA ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'FAMILIA ACOSTA VELANDIA'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing Wired 
connection 1 ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'Wired connection 1'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
18394619 ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection '18394619'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
macarena7131 ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'macarena7131'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing ZONA 
LIBRE ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'ZONA LIBRE'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
76233659 ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection '76233659'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing Claro 
...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'Claro'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
Movistar ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'Movistar'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
MICHAEL ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'MICHAEL'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
Motorola ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'Motorola'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing New 
802-11-wireless connection ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'my_access_point'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 11206 
...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection '11206'
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile: parsing 
AndroidAP ...
May 24 18:48:58 RMMbook NetworkManager[3026]:    keyfile:     read 
connection 'AndroidAP'
May 24 18:48:58 RMMbook NetworkManager[3026]:    Ifupdown: get unmanaged 
devices count: 0
May 24 18:48:58 RMMbook NetworkManager[3026]: <warn> Skipping Sleep 
Monitor setup, system not booted with systemd
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> monitoring kernel 
firmware directory '/lib/firmware'.
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> monitoring ifupdown 
state file '/run/network/ifstate'.
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> rfkill3: found WiFi 
radio killswitch (at 
/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0/ieee80211/phy0/rfkill3) (driver iwlwifi)
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> rfkill1: found WiFi 
radio killswitch (at /sys/devices/platform/samsung/rfkill/rfkill1) 
(platform driver (unknown))
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> WiFi hardware radio 
set enabled
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> WiFi enabled by 
radio killswitch; enabled by state file
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> WWAN enabled by 
radio killswitch; enabled by state file
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> WiMAX enabled by 
radio killswitch; enabled by state file
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> Networking is 
enabled by state file
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> (wlan0): using 
nl80211 for WiFi device control
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> (wlan0): driver 
supports Access Point (AP) mode
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> (wlan0): new 802.11 
WiFi device (driver: 'iwlwifi' ifindex: 3)
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> (wlan0): exported 
as /org/freedesktop/NetworkManager/Devices/0
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> (wlan0): device 
state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
May 24 18:48:58 RMMbook NetworkManager[3026]: <info> (wlan0): bringing 
up device.
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (wlan0): preparing 
device.
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (wlan0): 
deactivating device (reason 'managed') [2]
May 24 18:48:59 RMMbook NetworkManager[3026]: <warn> failed to allocate 
link cache: (-26) Protocol mismatch
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (eth0): carrier is 
OFF
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (eth0): new 
Ethernet device (driver: 'r8169' ifindex: 2)
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (eth0): exported as 
/org/freedesktop/NetworkManager/Devices/1
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (eth0): device 
state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (eth0): bringing up 
device.
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (eth0): preparing 
device.
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (eth0): 
deactivating device (reason 'managed') [2]
May 24 18:48:59 RMMbook NetworkManager[3026]: <warn> 
/sys/devices/virtual/net/lo: couldn't determine device driver; 
ignoring...
May 24 18:48:59 RMMbook NetworkManager[3026]: <warn> 
/sys/devices/virtual/net/lo: couldn't determine device driver; 
ignoring...
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> wpa_supplicant 
started
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (wlan0) supports 5 
scan SSIDs
May 24 18:48:59 RMMbook NetworkManager[3026]: <warn> Trying to remove a 
non-existant call id.
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (wlan0): supplicant 
interface state: starting -> ready
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (wlan0): device 
state change: unavailable -> disconnected (reason 
'supplicant-available') [20 30 42]
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (wlan0): supplicant 
interface state: ready -> inactive
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (wlan0) supports 5 
scan SSIDs
May 24 18:48:59 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
devices added (path: /sys/devices/virtual/net/virbr0, iface: virbr0)
May 24 18:48:59 RMMbook NetworkManager[3026]:    SCPlugin-Ifupdown: 
device added (path: /sys/devices/virtual/net/virbr0, iface: virbr0): no 
ifupdown configuration found.
May 24 18:48:59 RMMbook NetworkManager[3026]: <warn> failed to allocate 
link cache: (-26) Protocol mismatch
May 24 18:48:59 RMMbook NetworkManager[3026]: <info> (virbr0): ignoring 
bridge not created by NetworkManager
May 24 18:50:34 RMMbook NetworkManager[3026]: <info> ModemManager 
disappeared from bus
May 24 18:50:34 RMMbook NetworkManager[3026]: <info> ModemManager 
available in the bus
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
starting connection '59293779'
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> (wlan0): device 
state change: disconnected -> prepare (reason 'none') [30 40 0]
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> NetworkManager 
state is now CONNECTING
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 1 of 5 (Device Prepare) scheduled...
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 1 of 5 (Device Prepare) started...
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 2 of 5 (Device Configure) scheduled...
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 1 of 5 (Device Prepare) complete.
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 2 of 5 (Device Configure) starting...
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> (wlan0): device 
state change: prepare -> config (reason 'none') [40 50 0]
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation 
(wlan0/wireless): access point '59293779' has security, but secrets are 
required.
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> (wlan0): device 
state change: config -> need-auth (reason 'none') [50 60 0]
May 24 18:50:48 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 2 of 5 (Device Configure) complete.
May 24 18:50:48 RMMbook NetworkManager[3026]: get_secret_flags: 
assertion 'is_secret_prop (setting, secret_name, error)' failed
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 1 of 5 (Device Prepare) scheduled...
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 1 of 5 (Device Prepare) started...
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> (wlan0): device 
state change: need-auth -> prepare (reason 'none') [60 40 0]
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 2 of 5 (Device Configure) scheduled...
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 1 of 5 (Device Prepare) complete.
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Activation (wlan0) 
Stage 2 of 5 (Device Configure) starting...
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> (wlan0): device 
state change: prepare -> config (reason 'none') [40 50 0]
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Activation 
(wlan0/wireless): connection '59293779' has security, and secrets exist. 
  No new secrets needed.
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Config: added 
'ssid' value '59293779'
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Config: added 
'scan_ssid' value '1'
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Config: added 
'key_mgmt' value 'NONE'
May 24 18:50:49 RMMbook NetworkManager[3026]: <info> Config: added 
'auth_alg' value 'SHARED'