Arch Linux

Networkmanager verbindet sich nicht beim Systemstart

Josephus Miller

Nachdem ich das Bootproblem am Thinkpad T42 gelöst habe hänge ich wieder am Ursprungsproblem. Der Networkmanager verbindet beim Start nicht mit dem Wlan, obwohl er ohne Fehler startet:

$ systemctl status NetworkManager
● NetworkManager.service - Network Manager
   Loaded: loaded (/usr/lib/systemd/system/NetworkManager.service; enabled; vendor preset: disabled)
   Active: active (running) since Fr 2016-10-28 17:40:34 CEST; 2min 40s ago
 Main PID: 247 (NetworkManager)
    Tasks: 3 (limit: 4915)
   CGroup: /system.slice/NetworkManager.service
           └─247 /usr/bin/NetworkManager --no-daemon

Okt 28 17:40:37 thinkpad NetworkManager[247]: <info>  [1477669237.5410] (wlp2s2): driver supports SSID scans (scan_capa 0x21).
Okt 28 17:40:37 thinkpad NetworkManager[247]: <info>  [1477669237.5423] (wlp2s2): using WEXT for WiFi device control
Okt 28 17:40:37 thinkpad NetworkManager[247]: <info>  [1477669237.5950] manager: (wlp2s2): new 802.11 WiFi device (/org/freedesktop/NetworkManager/Devices/3)
Okt 28 17:40:37 thinkpad NetworkManager[247]: <info>  [1477669237.6003] device (wlp2s2): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Okt 28 17:40:38 thinkpad NetworkManager[247]: <info>  [1477669238.2397] supplicant: wpa_supplicant running
Okt 28 17:40:38 thinkpad NetworkManager[247]: <info>  [1477669238.2398] device (wlp2s2): supplicant interface state: init -> starting
Okt 28 17:40:38 thinkpad NetworkManager[247]: <info>  [1477669238.5229] sup-iface[0x99938e8,wlp2s2]: supports 1 scan SSIDs
Okt 28 17:40:38 thinkpad NetworkManager[247]: <info>  [1477669238.5319] device (wlp2s2): supplicant interface state: starting -> ready
Okt 28 17:40:38 thinkpad NetworkManager[247]: <info>  [1477669238.5322] device (wlp2s2): state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Okt 28 17:40:42 thinkpad NetworkManager[247]: <info>  [1477669242.4499] manager: startup complete

Ein Verbindung wird nach

# stystemctl stop Networkmanger
# systemctl start NetworkManager

hergestellt, warum nicht direkt beim Systemstart verstehe ich nicht.

Habe gerade gesehen dass ich das Problem letztes Jahr schon mal hatte. Der damalige workaround funktioniert allerdings diesmal nicht

Josephus Miller

Ich habe mal die Unterschiede bei wpa_supplicant.service angeschaut.

Direkt nach start, Wlan hat sich nicht verbunden:

$ systemctl status wpa_supplicant
● wpa_supplicant.service - WPA supplicant
   Loaded: loaded (/usr/lib/systemd/system/wpa_supplicant.service; disabled; vendor preset: disabled)
   Active: active (running) since Sa 2016-10-29 17:47:05 CEST; 2min 58s ago
 Main PID: 311 (wpa_supplicant)
    Tasks: 1 (limit: 4915)
   CGroup: /system.slice/wpa_supplicant.service
           └─311 /usr/bin/wpa_supplicant -u

Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to set random MAC address
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to assign random MAC address for a scan
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-SCAN-FAILED ret=-1
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Trying to associate with 08:96:d7:da:66:af (SSID='Linux' freq=2437 MHz)
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Association request to the driver failed
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Associated with 08:96:d7:da:66:af
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: WPA: Key negotiation completed with 08:96:d7:da:66:af [PTK=CCMP GTK=TKIP]
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-CONNECTED - Connection to 08:96:d7:da:66:af completed [id=0 id_str=]

Nach Restart des NetworkManagers:

$ systemctl status wpa_supplicant
● wpa_supplicant.service - WPA supplicant
   Loaded: loaded (/usr/lib/systemd/system/wpa_supplicant.service; disabled; vendor preset: disabled)
   Active: active (running) since Sa 2016-10-29 17:47:05 CEST; 2min 58s ago
 Main PID: 311 (wpa_supplicant)
    Tasks: 1 (limit: 4915)
   CGroup: /system.slice/wpa_supplicant.service
           └─311 /usr/bin/wpa_supplicant -u

Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to set random MAC address
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to assign random MAC address for a scan
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-SCAN-FAILED ret=-1
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Trying to associate with 08:96:d7:da:66:af (SSID='Linux' freq=2437 MHz)
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Association request to the driver failed
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Associated with 08:96:d7:da:66:af
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: WPA: Key negotiation completed with 08:96:d7:da:66:af [PTK=CCMP GTK=TKIP]
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-CONNECTED - Connection to 08:96:d7:da:66:af completed [id=0 id_str=]

Josephus Miller

Ich habe mal die Unterschiede bei wpa_supplicant.service angeschaut.

Direkt nach start, Wlan hat sich nicht verbunden:

$ systemctl status wpa_supplicant
● wpa_supplicant.service - WPA supplicant
   Loaded: loaded (/usr/lib/systemd/system/wpa_supplicant.service; disabled; vendor preset: disabled)
   Active: active (running) since Sa 2016-10-29 17:47:05 CEST; 2min 58s ago
 Main PID: 311 (wpa_supplicant)
    Tasks: 1 (limit: 4915)
   CGroup: /system.slice/wpa_supplicant.service
           └─311 /usr/bin/wpa_supplicant -u

Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to set random MAC address
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to assign random MAC address for a scan
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-SCAN-FAILED ret=-1
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Trying to associate with 08:96:d7:da:66:af (SSID='Linux' freq=2437 MHz)
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Association request to the driver failed
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Associated with 08:96:d7:da:66:af
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: WPA: Key negotiation completed with 08:96:d7:da:66:af [PTK=CCMP GTK=TKIP]
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-CONNECTED - Connection to 08:96:d7:da:66:af completed [id=0 id_str=]

Nach Restart des NetworkManagers:

$ systemctl status wpa_supplicant
● wpa_supplicant.service - WPA supplicant
   Loaded: loaded (/usr/lib/systemd/system/wpa_supplicant.service; disabled; vendor preset: disabled)
   Active: active (running) since Sa 2016-10-29 17:47:05 CEST; 2min 58s ago
 Main PID: 311 (wpa_supplicant)
    Tasks: 1 (limit: 4915)
   CGroup: /system.slice/wpa_supplicant.service
           └─311 /usr/bin/wpa_supplicant -u

Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to set random MAC address
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: Failed to assign random MAC address for a scan
Okt 29 17:49:57 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-SCAN-FAILED ret=-1
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Trying to associate with 08:96:d7:da:66:af (SSID='Linux' freq=2437 MHz)
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Association request to the driver failed
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: Associated with 08:96:d7:da:66:af
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: WPA: Key negotiation completed with 08:96:d7:da:66:af [PTK=CCMP GTK=TKIP]
Okt 29 17:49:58 thinkpad wpa_supplicant[311]: wlp2s2: CTRL-EVENT-CONNECTED - Connection to 08:96:d7:da:66:af completed [id=0 id_str=]

Josephus Miller

Nachdem ich bis networkmanager-1.0.7-1 zurückgegangen bin funktioniert es wieder.

Bis networkmanager-1.2.2-2-i686.pkg.tar.xz geht es mit dem beschriebenen restart des NetworkManagers, mit networkmanager-1.4.2-1-i686.pkg.tar.xz kann ich gar nicht starten.

Würde es aber gerne trotzdem richtig lösen. Die Wlan-Karte ist

Network controller: Intel Corporation PRO/Wireless 2200BG [Calexico2] Network Connection (rev 05)

SUSEDJAlex

was sagt eigentlich:

systemctl status dhcpcd.service

Installiere dir mal das Paket hwinfo nach und poste dann die Ausgaben:

pacman -S hwinfo
hwinfo --network
lspci --nnk | grep -i net -A2

LG SUSEDJAlex

Werner

Icecube63 schriebNachdem ich bis networkmanager-1.0.7-1 zurückgegangen bin funktioniert es wieder.

Bei mir gab es identische Probleme mit diesem 8 Jahre alten Chip:

Network controller: Intel Corporation WiFi Link 5100

Das Problem der fehlenden MAC-Scan-Fähigkeit, die ab Version 1.4 vorausgesetzt wird, ließ sich lösen, das von dir beschriebenen Problem jedoch nicht. Für mich war das der Anlass, auf connman und connman-gtk zu wechseln.

Gruß, Werner

Josephus Miller

Das Problem der fehlenden MAC-Scan-Fähigkeit, die ab Version 1.4 vorausgesetzt wird, ließ sich lösen, das von dir beschriebenen Problem jedoch nicht. Für mich war das der Anlass, auf connman und connman-gtk zu wechseln.

Der Wechsel war auch meine Überlegung, habe connman aber auf die Schnelle nicht eingerichtet bekommen. Habe jetzt mal den networkmanager zum Kernel auf ignore gesetzt, Auf Dauer ist denke ich eher ein neueres Laptop angedacht

Werner

Das Einrichten von connman fand ich bestechend einfach, sowohl über Konsole als auch über connman-gtk (AUR).
Eine kleine Tücke ist allerdings der Networkmanager. Den NetworkManager.service ausschalten reicht nicht – jedenfalls bei mir mit Xfce4 nicht – man muss ihn maskieren. Anschließend schreibt man die Konfigurationsdatei [1] /etc/connman/main.conf

[General]
PreferredTechnologies=ethernet,wifi
NetworkInterfaceBlacklist=eth,wlan

Der Blacklist-Eintrag weist connman an, der Schnittstelle keinen Namen (wie wlan0) zuzuweisen, sondern abzuwarten, bis der systemd-udevd.service das erledigt hat. Offenbar ist connman zu schnell für udev 🙂
Danach kann man connman.service und connman-vpn.service aktivieren und starten, die Verbindung(en) über connmanctl oder connman-gtk einrichten und sich freuen. [2]

Gruß, Werner

Edit: Sprungmarke aus URL entfernt

Josephus Miller

Werner schriebDas Einrichten von connman fand ich bestechend einfach, sowohl über Konsole als auch über connman-gtk (AUR).
Eine kleine Tücke ist allerdings der Networkmanager. Den NetworkManager.service ausschalten reicht nicht – jedenfalls bei mir mit Xfce4 nicht – man muss ihn maskieren. Anschließend schreibt man die Konfigurationsdatei [1] /etc/connman/main.conf
[General]
PreferredTechnologies=ethernet,wifi
NetworkInterfaceBlacklist=eth,wlan
Der Blacklist-Eintrag weist connman an, der Schnittstelle keinen Namen (wie wlan0) zuzuweisen, sondern abzuwarten, bis der systemd-udevd.service das erledigt hat. Offenbar ist connman zu schnell für udev 🙂
Danach kann man connman.service und connman-vpn.service aktivieren und starten, die Verbindung(en) über connmanctl oder connman-gtk einrichten und sich freuen. [2]

Ich werde es mal an meinem Laptop testen, das alte Thinkpad lasse ich so, wie gesagt macht ein neueres Sinn weil auch mit dem aktuellen Kernel wie im ersten Beitrag verlinkt Probleme auftreten und auch der Bildschirm ruhig etwas größer sein dürfte.