Bug#1029557: debian-edu-config: Session exits on first login on roaming-workstation fails

To: Debian Bug Tracking System <submit@bugs.debian.org>
Subject: Bug#1029557: debian-edu-config: Session exits on first login on roaming-workstation fails
From: Nico Winkelsträter <nico.winkelstraeter@initos.com>
Date: Tue, 24 Jan 2023 14:53:27 +0100
Message-id: <[🔎] 4c9fdfab-e8eb-d2c8-5899-250f8b6f94d7@initos.com>
Reply-to: Nico Winkelsträter <nico.winkelstraeter@initos.com>, 1029557@bugs.debian.org

Package: debian-edu-config
Version: 2.11.56+deb11u4
Severity: normal

Dear Maintainer,

When a user tries to log in at a romaing workstation for the very first time
the login prompt disappears, stays on the empty default-background for a few
seconds and the returns to lightdm with a brief black-screen.

On the second try everything works as expected.


I suspect that pam_mklocaluser does not properly initialize the environment

because the logs show some errors from pulseaudio as well as lightdmtrying to

write to the wrong home directory:

Jan 24 14:08:38 am-5254007fbccd.intern pulseaudio[5100]: Failed to create
secure directory (/skole/tjener/home0/teste
s/.config/pulse): Datei oder Verzeichnis nicht gefunden

Jan 24 14:08:47 am-5254007fbccd.intern lightdm[5053]: Error writing X

authority: Failed to open X authority/skole/tjener/home0/testes/.Xauthority:

No such file or directory

This occurs on a debian-edu deployment which has been in use for about ayear

and I could also reproduce this behavior locally on a fresh install with one
mainserver VM an one romaing-workstation VM.

Regards
Nico Winkelsträter


--
Mit freundlichen Grüßen

Nico Winkelsträter
Trainee Administrator

initOS GmbH
Innungsstraße 7
21244 Buchholz i.d.N.

Phone:   +49 4105 56156-33
Fax:     +49 4105 56156-10

Email:   nico.winkelstraeter@initos.com
Web:     http://www.initos.com

Geschäftsführung:
Dr.-Ing. Frederik Kramer & Dipl.-Ing. (FH) Torsten Francke

Sitz der Gesellschaft: Rosengarten – Klecken
Amtsgericht Tostedt, HRB 205226
Steuer-Nr: 15/200/53247
USt-IdNr: DE815580155

Jan 24 14:08:37 am-5254007fbccd.intern lightdm[5053]: pam_sss(lightdm:auth): authentication success; logname= uid=0 euid=0 tty=:0 ruser= rhost= user=testes
Jan 24 14:08:37 am-5254007fbccd.intern lightdm[5053]: gkr-pam: unable to locate daemon control file
Jan 24 14:08:37 am-5254007fbccd.intern lightdm[5053]: gkr-pam: stashed password to try later in open session
Jan 24 14:08:37 am-5254007fbccd.intern lightdm[5053]: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files
Jan 24 14:08:37 am-5254007fbccd.intern lightdm[608]: g_dbus_connection_call_sync_internal: assertion 'G_IS_DBUS_CONNECTION (connection)' failed
Jan 24 14:08:37 am-5254007fbccd.intern lightdm[608]: g_dbus_connection_call_sync_internal: assertion 'G_IS_DBUS_CONNECTION (connection)' failed
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Stopping Session c8 of user lightdm.
Jan 24 14:08:37 am-5254007fbccd.intern lightdm[4969]: pam_unix(lightdm-greeter:session): session closed for user lightdm
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: session-c8.scope: Succeeded.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Stopped Session c8 of user lightdm.
Jan 24 14:08:37 am-5254007fbccd.intern systemd-logind[603]: Removed session c8.
Jan 24 14:08:37 am-5254007fbccd.intern lightdm[5053]: pam_unix(lightdm:session): session opened for user testes(uid=1007) by (uid=0)
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Created slice User Slice of UID 1007.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Starting User Runtime Directory /run/user/1007...
Jan 24 14:08:37 am-5254007fbccd.intern pulseaudio[4990]: Unable to set sw params: Keine Berechtigung
Jan 24 14:08:37 am-5254007fbccd.intern pulseaudio[4990]: Failed to set software parameters: Keine Berechtigung
Jan 24 14:08:37 am-5254007fbccd.intern pulseaudio[4990]: Error opening PCM device front:0: Datei oder Verzeichnis nicht gefunden
Jan 24 14:08:37 am-5254007fbccd.intern systemd-logind[603]: New session 40 of user testes.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[4973]: pulseaudio.service: Succeeded.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Finished User Runtime Directory /run/user/1007.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Starting User Manager for UID 1007...
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: pam_unix(systemd-user:session): session opened for user testes(uid=1007) by (uid=0)
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Queued start job for default target Main User Target.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Created slice User Application Slice.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Reached target Paths.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Reached target Timers.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Starting D-Bus User Message Bus Socket.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on GnuPG network certificate management daemon.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on GnuPG cryptographic agent and passphrase cache.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on Multimedia System.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on debconf communication socket.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on Sound System.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Listening on D-Bus User Message Bus Socket.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Reached target Sockets.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Reached target Basic System.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Started User Manager for UID 1007.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[1]: Started Session 40 of user testes.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Started Multimedia Service.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Starting Sound Service...
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5077 of process 5077 owned by '1007' high priority at nice level -11.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 9 threads of 5 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 9 threads of 5 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 9 threads of 5 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5079 of process 5077 owned by '1007' RT at priority 20.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 10 threads of 5 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Started D-Bus User Message Bus.
Jan 24 14:08:37 am-5254007fbccd.intern pipewire[5077]: Failed to receive portal pid: org.freedesktop.DBus.Error.NameHasNoOwner: Could not get PID of name 'org.freedesktop.portal.Desktop': no such name
Jan 24 14:08:37 am-5254007fbccd.intern pam_mklocaluser[5053]: Creating local passwd/shadow entry uid=1007(testes) gid=1006(testes) gecos='Test Test' home=/home/testes
Jan 24 14:08:37 am-5254007fbccd.intern pam_mklocaluser[5053]: Creating local home directory for user 'testes'
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5083 of process 5083 owned by '1007' high priority at nice level -11.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 11 threads of 6 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern ldapsearch[5089]: DIGEST-MD5 common mech free
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5078 of process 5078 owned by '1007' high priority at nice level -11.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 12 threads of 7 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 12 threads of 7 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern pulseaudio[5078]: Failed to create secure directory (/skole/tjener/home0/testes/.config/pulse): Datei oder Verzeichnis nicht gefunden
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 12 threads of 7 processes of 3 users.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Main process exited, code=exited, status=1/FAILURE
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Failed with result 'exit-code'.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Failed to start Sound Service.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Reached target Main User Target.
Jan 24 14:08:37 am-5254007fbccd.intern systemd[5060]: Startup finished in 114ms.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5085 of process 5083 owned by '1007' RT at priority 20.
Jan 24 14:08:37 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 13 threads of 7 processes of 3 users.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Scheduled restart job, restart counter is at 1.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Stopped Sound Service.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Starting Sound Service...
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5097 of process 5097 owned by '1007' high priority at nice level -11.
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 13 threads of 7 processes of 3 users.
Jan 24 14:08:38 am-5254007fbccd.intern pulseaudio[5097]: Failed to create secure directory (/skole/tjener/home0/testes/.config/pulse): Datei oder Verzeichnis nicht gefunden
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Main process exited, code=exited, status=1/FAILURE
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Failed with result 'exit-code'.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Failed to start Sound Service.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Scheduled restart job, restart counter is at 2.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Stopped Sound Service.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Starting Sound Service...
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5098 of process 5098 owned by '1007' high priority at nice level -11.
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 13 threads of 7 processes of 3 users.
Jan 24 14:08:38 am-5254007fbccd.intern pulseaudio[5098]: Failed to create secure directory (/skole/tjener/home0/testes/.config/pulse): Datei oder Verzeichnis nicht gefunden
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Main process exited, code=exited, status=1/FAILURE
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Failed with result 'exit-code'.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Failed to start Sound Service.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Scheduled restart job, restart counter is at 3.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Stopped Sound Service.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Starting Sound Service...
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5099 of process 5099 owned by '1007' high priority at nice level -11.
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 13 threads of 7 processes of 3 users.
Jan 24 14:08:38 am-5254007fbccd.intern pulseaudio[5099]: Failed to create secure directory (/skole/tjener/home0/testes/.config/pulse): Datei oder Verzeichnis nicht gefunden
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Main process exited, code=exited, status=1/FAILURE
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Failed with result 'exit-code'.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Failed to start Sound Service.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Scheduled restart job, restart counter is at 4.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Stopped Sound Service.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Starting Sound Service...
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5100 of process 5100 owned by '1007' high priority at nice level -11.
Jan 24 14:08:38 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 13 threads of 7 processes of 3 users.
Jan 24 14:08:38 am-5254007fbccd.intern pulseaudio[5100]: Failed to create secure directory (/skole/tjener/home0/testes/.config/pulse): Datei oder Verzeichnis nicht gefunden
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Main process exited, code=exited, status=1/FAILURE
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Failed with result 'exit-code'.
Jan 24 14:08:38 am-5254007fbccd.intern systemd[5060]: Failed to start Sound Service.
Jan 24 14:08:39 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Scheduled restart job, restart counter is at 5.
Jan 24 14:08:39 am-5254007fbccd.intern systemd[5060]: Stopped Sound Service.
Jan 24 14:08:39 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Start request repeated too quickly.
Jan 24 14:08:39 am-5254007fbccd.intern systemd[5060]: pulseaudio.service: Failed with result 'exit-code'.
Jan 24 14:08:39 am-5254007fbccd.intern systemd[5060]: Failed to start Sound Service.
Jan 24 14:08:39 am-5254007fbccd.intern systemd[5060]: pulseaudio.socket: Failed with result 'service-start-limit-hit'.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: Stopping User Manager for UID 124...
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped target Main User Target.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopping Accessibility services bus...
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopping D-Bus User Message Bus...
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopping Virtual filesystem service...
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopping Multimedia Service...
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: pipewire.service: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped Multimedia Service.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[5060]: run-user-124-gvfs.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[2317]: run-user-124-gvfs.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: run-user-124-gvfs.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[2119]: run-user-124-gvfs.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: run-user-124-gvfs.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: gvfs-daemon.service: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped Virtual filesystem service.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: dbus.service: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped D-Bus User Message Bus.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: at-spi-dbus-bus.service: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped Accessibility services bus.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped target Basic System.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped target Paths.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped target Sockets.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Stopped target Timers.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: dbus.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed D-Bus User Message Bus Socket.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: dirmngr.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed GnuPG network certificate management daemon.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: gpg-agent-browser.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: gpg-agent-extra.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: gpg-agent-ssh.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: gpg-agent.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed GnuPG cryptographic agent and passphrase cache.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: pipewire.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed Multimedia System.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: pk-debconf-helper.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed debconf communication socket.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: pulseaudio.socket: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Closed Sound System.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Removed slice User Application Slice.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Reached target Shutdown.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: systemd-exit.service: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Finished Exit the Session.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4973]: Reached target Exit the Session.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[4975]: pam_unix(systemd-user:session): session closed for user lightdm
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: user@124.service: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: Stopped User Manager for UID 124.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: Stopping User Runtime Directory /run/user/124...
Jan 24 14:08:47 am-5254007fbccd.intern systemd[5060]: run-user-124.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[2317]: run-user-124.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[2119]: run-user-124.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: run-user-124.mount: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: user-runtime-dir@124.service: Succeeded.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: Stopped User Runtime Directory /run/user/124.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: Removed slice User Slice of UID 124.
Jan 24 14:08:47 am-5254007fbccd.intern systemd[1]: user-124.slice: Consumed 1.195s CPU time.
Jan 24 14:08:47 am-5254007fbccd.intern su[5105]: (to testes) testes on none
Jan 24 14:08:47 am-5254007fbccd.intern su[5105]: pam_unix(su-l:session): session opened for user testes(uid=1007) by (uid=0)
Jan 24 14:08:47 am-5254007fbccd.intern pam_mklocaluser[5105]: pam_unix(su-l:session): session closed for user testes
Jan 24 14:08:47 am-5254007fbccd.intern pam_mklocaluser[5053]: gkr-pam: gnome-keyring-daemon started properly and unlocked keyring
Jan 24 14:08:47 am-5254007fbccd.intern lightdm[5053]: Error writing X authority: Failed to open X authority /skole/tjener/home0/testes/.Xauthority: No such file or directory
Jan 24 14:08:47 am-5254007fbccd.intern systemd-logind[603]: Session 40 logged out. Waiting for processes to exit.
Jan 24 14:08:48 am-5254007fbccd.intern lightdm[5144]: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files
Jan 24 14:08:48 am-5254007fbccd.intern lightdm[5144]: pam_unix(lightdm-greeter:session): session opened for user lightdm(uid=124) by (uid=0)
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: Created slice User Slice of UID 124.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: Starting User Runtime Directory /run/user/124...
Jan 24 14:08:48 am-5254007fbccd.intern systemd-logind[603]: New session c9 of user lightdm.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: session-40.scope: Succeeded.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: session-40.scope: Consumed 10.129s CPU time.
Jan 24 14:08:48 am-5254007fbccd.intern systemd-logind[603]: Removed session 40.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: Finished User Runtime Directory /run/user/124.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: Starting User Manager for UID 124...
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: pam_unix(systemd-user:session): session opened for user lightdm(uid=124) by (uid=0)
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Queued start job for default target Main User Target.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Created slice User Application Slice.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Reached target Paths.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Reached target Timers.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Starting D-Bus User Message Bus Socket.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on GnuPG network certificate management daemon.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on GnuPG cryptographic agent and passphrase cache.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on Multimedia System.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on debconf communication socket.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on Sound System.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Listening on D-Bus User Message Bus Socket.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Reached target Sockets.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Reached target Basic System.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: Started User Manager for UID 124.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Started Multimedia Service.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[1]: Started Session c9 of user lightdm.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Starting Sound Service...
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5164 of process 5164 owned by '124' high priority at nice level -11.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 9 threads of 5 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Started D-Bus User Message Bus.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 9 threads of 5 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 9 threads of 5 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5166 of process 5164 owned by '124' RT at priority 20.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 10 threads of 5 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern pipewire[5164]: Failed to receive portal pid: org.freedesktop.DBus.Error.NameHasNoOwner: Could not get PID of name 'org.freedesktop.portal.Desktop': no such name
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5168 of process 5168 owned by '124' high priority at nice level -11.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 11 threads of 6 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 11 threads of 6 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 11 threads of 6 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5169 of process 5168 owned by '124' RT at priority 20.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 12 threads of 6 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5165 of process 5165 owned by '124' high priority at nice level -11.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 13 threads of 7 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern pulseaudio[5165]: Disabling timer-based scheduling because running inside a VM.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 13 threads of 7 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5172 of process 5165 owned by '124' RT at priority 5.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 14 threads of 7 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern pulseaudio[5165]: Disabling timer-based scheduling because running inside a VM.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 14 threads of 7 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Successfully made thread 5177 of process 5165 owned by '124' RT at priority 5.
Jan 24 14:08:48 am-5254007fbccd.intern rtkit-daemon[1187]: Supervising 15 threads of 7 processes of 3 users.
Jan 24 14:08:48 am-5254007fbccd.intern dbus-daemon[488]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.272' (uid=124 pid=5165 comm="/usr/bin/pulseaudio --daemonize=no --log-target=jo")
Jan 24 14:08:48 am-5254007fbccd.intern dbus-daemon[488]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found.
Jan 24 14:08:48 am-5254007fbccd.intern pulseaudio[5165]: GetManagedObjects() failed: org.freedesktop.systemd1.NoSuchUnit: Unit dbus-org.bluez.service not found.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Started Sound Service.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Reached target Main User Target.
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Startup finished in 153ms.
Jan 24 14:08:48 am-5254007fbccd.intern dbus-daemon[5167]: [session uid=124 pid=5167] Activating via systemd: service name='org.a11y.Bus' unit='at-spi-dbus-bus.service' requested by ':1.4' (uid=124 pid=5170 comm="/usr/sbin/lightdm-gtk-greeter ")
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Starting Accessibility services bus...
Jan 24 14:08:48 am-5254007fbccd.intern dbus-daemon[5167]: [session uid=124 pid=5167] Successfully activated service 'org.a11y.Bus'
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Started Accessibility services bus.
Jan 24 14:08:48 am-5254007fbccd.intern dbus-daemon[5167]: [session uid=124 pid=5167] Activating via systemd: service name='org.gtk.vfs.Daemon' unit='gvfs-daemon.service' requested by ':1.6' (uid=124 pid=5170 comm="/usr/sbin/lightdm-gtk-greeter ")
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Starting Virtual filesystem service...
Jan 24 14:08:48 am-5254007fbccd.intern dbus-daemon[5167]: [session uid=124 pid=5167] Successfully activated service 'org.gtk.vfs.Daemon'
Jan 24 14:08:48 am-5254007fbccd.intern systemd[5148]: Started Virtual filesystem service.
Jan 24 14:08:49 am-5254007fbccd.intern at-spi-bus-launcher[5187]: dbus-daemon[5187]: Activating service name='org.a11y.atspi.Registry' requested by ':1.0' (uid=124 pid=5170 comm="/usr/sbin/lightdm-gtk-greeter ")
Jan 24 14:08:49 am-5254007fbccd.intern at-spi-bus-launcher[5187]: dbus-daemon[5187]: Successfully activated service 'org.a11y.atspi.Registry'
Jan 24 14:08:49 am-5254007fbccd.intern at-spi-bus-launcher[5214]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry

Reply to:

Follow-Ups:
- Bug#1029557: debian-edu-config: Session exits on first login on roaming-workstation fails
  - From: Petter Reinholdtsen <pere@hungry.com>

Prev by Date: Re: [Season of Docs - Announcements] Announcing Google Season of Docs 2023
Next by Date: Bug#1029557: debian-edu-config: Session exits on first login on roaming-workstation fails
Previous by thread: Re: [Season of Docs - Announcements] Announcing Google Season of Docs 2023
Next by thread: Bug#1029557: debian-edu-config: Session exits on first login on roaming-workstation fails
Index(es):
- Date
- Thread