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

Michael Meier crap at rmm.li
Sun May 25 01:37:25 UTC 2014


Am 24.5.2014 19:28, schrieb Michael Biebl:
>> 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...
> 
> you can simply restart wpa_supplicant.

wpa-supplicant is no service, at least not in my system, so I executed 
the dbus commands descriped in the wiki and
restarted NetworkManager... But i didn't get any log output, I also 
tried to add "-f /var/log/wpa_supplicant.log" to 
/usr/share/dbus-1/system-services/fi.w1.wpa_supplicant1.service
but nothing happened.
But what I noticed, when I restart the network-manager service, it 
autoconnect. Also if I restart the computer and then restart the 
network-manager service, it auto connects. I will attach a log of that 
at the bottom...

>> Maybe it's not needed (as far as I understand the log it seems like it
>> even doesn't try to connect.
> 
> 
> Please also includine the wpasupplicant log and the
> /etc/NetworkManager/system-connections/59293779 connection file (make
> sure to XXXX the psk)
> 
> Is this specific to this particular wireless network or a general 
> issue?

It's the same for at least 4 wireless conections, also one I added newly 
yesterday. So I guess it's a general issue.

> Does autoconnect work for a lan connection?

My laptop got one of this stupid proprietary mini-lan ports. And I don't 
have an adapter...

All right.
First /etc/NetworkManager/system-connections/59293779
The ps is not stored in it but in 
~/.kde/share/config/plasma-networkmanagment . THere isn't written 
anything interesting besides the password.
In this connection definition there's nothing written about auto connect 
(don't know if it's necessary).
But if in the settings, I disable the checkmark at auto connect. Press 
apply. Enable the checkmark again. It starts connecting to this 
connection. But after the next restart I have to connect manually again.

[connection]
id=59293779
uuid=99062574-6bb6-4105-947b-dc2f39540848
type=802-11-wireless
permissions=user:rmm:;

[802-11-wireless]
ssid=59293779
mode=infrastructure
mac-address=C4:85:08:E0:C3:DD
security=802-11-wireless-security

[802-11-wireless-security]
key-mgmt=none
auth-alg=shared
wep-key-flags=1
wep-key-type=1

[ipv4]
method=auto

[ipv6]
method=auto


and here the log after restarting the network-manager service:

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



More information about the Pkg-utopia-maintainers mailing list