hallo community,
ich habe vor kurzem für die Firma einen DELL Laptop, der mit Ubuntu 18.04 vorinstalliert war, ein bisschen konfiguriert (OpenVPN, VNC, LDAP client).
Wenn ich eine offene X Session habe (mit verschiedenen Benutzern getestet), und den Rechner stehen lasse, dann ist nach ca. 1 Stunde Inaktivität die X session (der X server) weg, und eine Textkonsole wird angezeigt (nur ein paar Steuerzeichen). Wenn ich Strg+C drücke, dann startet GDM und ich kann mich erneut einloggen, aber meine Session ist weg. Nachdem ich in gdm3 Wayland deaktiviert habe (/etc/gdm3/custom.conf), stürzt GDM nicht mehr ab, aber der eingeloggte user wird weiterhin nach ca. 0,5-2 Stunden ausgeloggt (man kann sich direkt wieder einloggen, aber die session ist weg).
Als Erstes habe ich hibernate/suspend/.. abgestellt, indem ich die systemd services deaktiviert habe [1]:
$ sudo systemctl mask sleep.target suspend.target hibernate.target hybrid-sleep.target
[1] https://askubuntu.com/questions/473037/how-to-permanently-disable-sleep-suspend
Ich habe einen Tag lang den Rechner überwacht, und festgestellt, dass jedes Mal eine Meldung "Stopping User Manager for UID XXX" in /var/log/syslog auftaucht:
[...] Jun 2 07:24:21 RECHNERNAME sssd[be[default]]: Backend is online Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): DFP-0: disconnected Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): DFP-0: Internal TMDS Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): DFP-0: 165.0 MHz maximum pixel clock Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): DFP-0: disconnected Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): DFP-0: Internal TMDS Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): DFP-0: 165.0 MHz maximum pixel clock Jun 2 07:24:21 RECHNERNAME /usr/lib/gdm3/gdm-x-session[3023]: (--) NVIDIA(GPU-0): Jun 2 07:24:22 RECHNERNAME systemd[1]: Stopping User Manager for UID 1000033... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Virtual filesystem service - Apple File Conduit monitor... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Virtual filesystem service - GNOME Online Accounts monitor... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping sandboxed app permission store... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping D-Bus User Message Bus... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Evolution address book service... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Accessibility services bus... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Evolution calendar service... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Virtual filesystem service - digital camera monitor... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Virtual filesystem service... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped target Default. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Evolution source registry... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Virtual filesystem service - Media Transfer Protocol monitor... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Virtual filesystem metadata service... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopping Virtual filesystem service - disk device monitor... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Virtual filesystem service - Apple File Conduit monitor. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped sandboxed app permission store. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Virtual filesystem service - GNOME Online Accounts monitor. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Virtual filesystem service - Media Transfer Protocol monitor. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Virtual filesystem metadata service. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Virtual filesystem service - digital camera monitor. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped D-Bus User Message Bus. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Evolution source registry. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Virtual filesystem service - disk device monitor. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Evolution calendar service. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Evolution address book service. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Virtual filesystem service. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Accessibility services bus. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped target Basic System. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped target Sockets. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Closed GnuPG cryptographic agent (ssh-agent emulation). Jun 2 07:24:22 RECHNERNAME systemd[2069]: Closed REST API socket for snapd user session agent. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Closed GnuPG network certificate management daemon. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Closed GnuPG cryptographic agent and passphrase cache (restricted). Jun 2 07:24:22 RECHNERNAME systemd[2069]: Closed GnuPG cryptographic agent and passphrase cache. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers). Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped target Paths. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped Pending report trigger for Ubuntu Report. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Stopped target Timers. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Closed D-Bus User Message Bus Socket. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Reached target Shutdown. Jun 2 07:24:22 RECHNERNAME systemd[2069]: Starting Exit the Session... Jun 2 07:24:22 RECHNERNAME systemd[2069]: Received SIGRTMIN+24 from PID 3096 (kill). Jun 2 07:24:22 RECHNERNAME systemd[1]: Stopped User Manager for UID 1000033. Jun 2 07:24:22 RECHNERNAME systemd[1]: Removed slice User Slice of fnatter.
bei 3x automatischen Logout in der Logperiode tritt "Stopping User Manager for UID 1000033" 3x auf, oft mit "DFP-0: disconnected" vorher. Allerdings zeigt die (sys)log-Analyse, dass "DFP-0: disconnected" sehr oft vorkommt, und nicht mit dem Fehler in Verbindung zu hängen scheint.
(da ich sssd (als LDAP client) mit "cache_credentials=True" konfiguriert habe, ist "Backend is offline" m.E. OK.)
Statt dessen habe ich beobachtet, dass diese Meldung (fast?) immer mit dem logout zusammen hängt:
Jun 2 09:29:39 RECHNERNAME NetworkManager[1117]: <info> [1591082979.2053] device (wlp4s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'managed') Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.847012] r8169 0000:03:00.0 enp3s0: Link is Down Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.848546] pcieport 0000:00:1d.6: AER: Multiple Corrected error received: 0000:00:1d.6 Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.848563] pcieport 0000:00:1d.6: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.848565] pcieport 0000:00:1d.6: device [8086:a336] error status/mask=00000081/00002000 Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.848566] pcieport 0000:00:1d.6: [ 0] RxErr Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.848567] pcieport 0000:00:1d.6: [ 7] BadDLLP Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.882339] pcieport 0000:00:1d.6: AER: Multiple Corrected error received: 0000:00:1d.6 Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.882361] pcieport 0000:00:1d.6: PCIe Bus Error: severity=Corrected, type=Physical Layer, (Receiver ID) Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.882363] pcieport 0000:00:1d.6: device [8086:a336] error status/mask=00000001/00002000 Jun 2 09:29:39 RECHNERNAME kernel: [ 8925.882366] pcieport 0000:00:1d.6: [ 0] RxErr Jun 2 09:29:39 RECHNERNAME kernel: [ 8926.097542] ath10k_pci 0000:04:00.0: unsupported HTC service id: 1536 Jun 2 09:29:39 RECHNERNAME NetworkManager[1117]: <info> [1591082979.4923] manager: NetworkManager state is now DISCONNECTED Jun 2 09:29:39 RECHNERNAME wpa_supplicant[1120]: dbus: fill_dict_with_properties dbus_interface=fi.w1.wpa_supplicant1.Interface dbus_property=Stations getter failed Jun 2 09:29:39 RECHNERNAME wpa_supplicant[1120]: dbus: wpa_dbus_get_object_properties: failed to get object properties: (none) none Jun 2 09:29:39 RECHNERNAME wpa_supplicant[1120]: dbus: Failed to construct signal Jun 2 09:29:39 RECHNERNAME wpa_supplicant[1120]: dbus: fill_dict_with_properties dbus_interface=fi.w1.wpa_supplicant1.Interface dbus_property=Stations getter failed Jun 2 09:29:39 RECHNERNAME NetworkManager[1117]: <info> [1591082979.5534] device (wlp4s0): supplicant interface state: starting -> ready Jun 2 09:29:39 RECHNERNAME NetworkManager[1117]: <info> [1591082979.5535] device (wlp4s0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed') Jun 2 09:29:39 RECHNERNAME systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jun 2 09:29:39 RECHNERNAME systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: (EE) Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: Fatal server error: Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: (EE) systemd-logind disappeared (stopped/restarted?) Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: (EE) Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: (EE) Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: Please consult the The X.Org Foundation support Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: #011 at http://wiki.x.org Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: for help. Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Jun 2 09:29:39 RECHNERNAME /usr/lib/gdm3/gdm-x-session[6144]: (EE) Jun 2 09:29:39 RECHNERNAME ModemManager[1087]: <warn> [sleep-monitor] inhibit failed: GDBus.Error:org.freedesktop.DBus.Error.NoReply: Message recipient disconnected from message bus without replying Jun 2 09:29:39 RECHNERNAME systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jun 2 09:29:39 RECHNERNAME gsd-power[6309]: Unable to inhibit suspend: GDBus.Error:org.freedesktop.DBus.Error.NoReply: Message recipient disconnected from message bus without replying Jun 2 09:29:39 RECHNERNAME gsd-media-keys[6304]: Unable to inhibit suspend: GDBus.Error:org.freedesktop.DBus.Error.NoReply: Message recipient disconnected from message bus without replying Jun 2 09:29:39 RECHNERNAME upowerd[1629]: Could not acquire inhibitor lock: GDBus.Error:org.freedesktop.DBus.Error.NoReply: Message recipient disconnected from message bus without replying Jun 2 09:29:39 RECHNERNAME systemd[1]: systemd-logind.service: Scheduled restart job, restart counter is at 5. Jun 2 09:29:39 RECHNERNAME systemd[1]: Stopped Login Service.
–> das sieht mir danach aus, dass (durch einen Hardwarefehler "PCIe Bus Error") die Netzwerkverbindung abbricht, und deshalb der system-logind abschmiert, ist das realistisch?
sssd habe ich wie folgt konfiguriert:
echo "creating sssd.conf..." echo "[domain/default]" > /etc/sssd/sssd.conf echo "id_provider = ldap" >> /etc/sssd/sssd.conf echo "auth_provider = ldap" >> /etc/sssd/sssd.conf echo "chpass_provider = ldap" >> /etc/sssd/sssd.conf echo "ldap_uri = ldap://INTERNAL_LDAP_IP/" >> /etc/sssd/sssd.conf echo "ldap_search_base = dc=DOMAIN,dc=com" >> /etc/sssd/sssd.conf echo "ldap_id_use_start_tls = True" >> /etc/sssd/sssd.conf echo "ldap_tls_cacertdir = /etc/openldap/cacerts" >> /etc/sssd/sssd.conf echo "ldap_tls_cacert = /etc/openldap/cacerts/CERTIFICATE.crt.pem" >> /etc/sssd/sssd.conf echo "cache_credentials = True" >> /etc/sssd/sssd.conf echo "ldap_tls_reqcert = allow" >> /etc/sssd/sssd.conf echo "" >> /etc/sssd/sssd.conf echo "[sssd]" >> /etc/sssd/sssd.conf echo "services = nss, pam" >> /etc/sssd/sssd.conf echo "domains = default" >> /etc/sssd/sssd.conf echo "" >> /etc/sssd/sssd.conf echo "[nss]" >> /etc/sssd/sssd.conf echo "homedir_substring = /home" >> /etc/sssd/sssd.conf
/var/log/Xorg.*.log zeigt manchmal "DFP-0: disconnected" (wie gesagt: scheint mir nicht zusammen hängend), und oft:
Fatal server error: [ 8230.904] (EE) systemd-logind disappeared (stopped/restarted?) [ 8230.904] (EE) [ 8230.904] (EE) Please consult the The X.Org Foundation support at http://wiki.x.org for help. [ 8230.904] (EE) Please also check the log file at "/var/log/Xorg.1.log" for additional information. [ 8230.905] (EE) [ 8231.167] (EE) systemd-logind: ReleaseControl failed: You are not in control of this session [ 8231.167] (EE) Server terminated with error (1). Closing log file.
Die gleiche Konfiguration (insbesondere LDAP) habe ich auf zwei anderen Laptops verwendet, und habe dort bisher nicht dieses Problem bemerkt. Daher nehme ich die o.g. Hardware Issue an.
Der Rechner ist natürlich auf dem aktuellen Stand (Ubuntu Updates), aber noch nicht auf dem neuesten Stand was die DELL BIOS/UEFI Updates angeht (falls es welche gibt).
Sollte den DELL Support fragen (nachdem ich auf BIOS Updates geprüft habe)?
Vielen Dank!
Felix