Bug 2180768 - GDM takes "long" before allowing mouse moves and showing the user list.
Summary: GDM takes "long" before allowing mouse moves and showing the user list.
Keywords:
Status: CLOSED ERRATA
Alias: None
Product: Fedora
Classification: Fedora
Component: accountsservice
Version: 38
Hardware: Unspecified
OS: Unspecified
unspecified
unspecified
Target Milestone: ---
Assignee: Ray Strode [halfline]
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks: F38FinalBlocker
TreeView+ depends on / blocked
 
Reported: 2023-03-22 08:52 UTC by Florian Apolloner
Modified: 2023-03-26 00:20 UTC (History)
9 users (show)

Fixed In Version: accountsservice-23.11.69-2.fc38
Clone Of:
Environment:
Last Closed: 2023-03-26 00:20:53 UTC
Type: Bug
Embargoed:


Attachments (Terms of Use)
gdm log (41.39 KB, text/plain)
2023-03-22 08:52 UTC, Florian Apolloner
no flags Details


Links
System ID Private Priority Status Summary Last Updated
freedesktop.org Gitlab accountsservice accountsservice merge_requests 127 0 None opened daemon: Fix boot delay 2023-03-24 16:19:12 UTC

Description Florian Apolloner 2023-03-22 08:52:04 UTC
Created attachment 1952693 [details]
gdm log

Description of problem:

Since a recent (?) update of GDM on Fedora 38 GDM starts and shows an empty userlist (and I cannot move the mouse). After a while the user list pops up and I can log in. Attached is the GDM debug log, let me know if I can provide more.

Version-Release number of selected component (if applicable):
GDM 43.0

How reproducible:
always

Steps to Reproduce:
1. Boot the system
2. See GDM starting up
3. Wait a few seconds till the user list displays

Comment 1 Fedora Blocker Bugs Application 2023-03-22 09:08:53 UTC
Proposed as a Blocker for 38-final by Fedora user apollo13 using the blocker tracking app because:

 This delays the login process by a while and used to work during f38 beta already.

Comment 2 Geraldo Simião 2023-03-22 13:51:02 UTC
oh, this looks like my sddm bug https://bugzilla.redhat.com/show_bug.cgi?id=2179998
I'll try to reproduce this too.

Comment 3 Geraldo Simião 2023-03-22 13:54:53 UTC
(In reply to Florian Apolloner from comment #0)
> Created attachment 1952693 [details]
> gdm log
> 
> Description of problem:
> 
> Since a recent (?) update of GDM on Fedora 38 GDM starts and shows an empty
> userlist (and I cannot move the mouse). After a while the user list pops up
> and I can log in. Attached is the GDM debug log, let me know if I can
> provide more.
> 
> Version-Release number of selected component (if applicable):
> GDM 43.0
> 
> How reproducible:
> always
> 
> Steps to Reproduce:
> 1. Boot the system
> 2. See GDM starting up
> 3. Wait a few seconds till the user list displays

What exatcly is you version of gdm? Whats the output of the command: rpm -qa|grep gdm

Comment 4 Florian Apolloner 2023-03-22 19:21:51 UTC
gdm version is: gdm-43.0-7.fc38.x86_64

The ssdm bug looks similar, but in gdm I cannot even move the mouse till it unfreezes (at which it also shows the userlist). In the video of the ssdm bug you can see that the mouse is always moveable and the userlist is also visible already. gdm solely shows "user not listed" (or similar) while frozen.

The freeze is >5 seconds, CPU is "AMD Ryzen 7 PRO 5850U with Radeon Graphics", so not exactly slow (that said it is put into powersave mode)…

Comment 5 Geraldo Simião 2023-03-23 12:21:21 UTC
Yeah, you're right, the sddm bug is absolutely not related to this here. For the sddm a fix is already out, and confirmed, and it is on sddm-breeze (theme).

Comment 6 Lukas Ruzicka 2023-03-23 15:34:48 UTC
I am not seeing this on my laptop, so this can be hardware specific.

Comment 7 Adam Williamson 2023-03-23 17:05:52 UTC
What user accounts do you have on your system? Is there already a session of some kind (e.g. a console login or some other desktop running somehow) when this happens? Do you have any kind of non-standard login config (autologin or anything like that?)

The obvious jump in the logs is here:

Mar 22 09:43:29 apollo13 gdm[1591]: Gdm: GdmSession: Emitting 'session-started' signal with pid '1696'
Mar 22 09:43:29 apollo13 gdm[1591]: Gdm: GdmDisplay: Greeter started
Mar 22 09:43:29 apollo13 gdm[1591]: Gdm: GdmManager: trying to register new display
Mar 22 09:43:29 apollo13 gdm[1591]: Gdm: GdmCommon: Found session c1 for PID 1696, using
Mar 22 09:43:29 apollo13 gdm[1591]: Gdm: GdmLocalDisplayFactory: display status changed: 2
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmCommon: Found session c1 for PID 1714, using
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmManager: trying to register new session on display 0x55a6c69ae890
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmDisplay: session registered: yes
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmLocalDisplayFactory: session registered on display, looking for any background displays to kill
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmManager: trying to open new session
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmCommon: Found session c1 for PID 1714, using
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmSession: Considering session (null) for username (null)
Mar 22 09:43:31 apollo13 gdm[1591]: GdmDBusServer: new connection 0x7f3964001b90
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmSession: Handling new connection from outside
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmManager: client with pid 1714 connected
Mar 22 09:43:31 apollo13 gdm[1591]: Gdm: GdmDisplay: Got timed login details for display: 0
Mar 22 09:43:40 apollo13 gdm[1591]: Gdm: GdmManager: trying to open reauthentication channel for user florian
Mar 22 09:43:40 apollo13 gdm[1591]: Gdm: GdmCommon: Found session c1 for PID 1714, using
Mar 22 09:43:40 apollo13 gdm[1591]: Gdm: GdmManager: looking for login screen session for user florian on seat seat0
Mar 22 09:43:40 apollo13 gdm[1591]: Gdm: GdmManager: no matching sessions found

we jump two seconds then another nine seconds. I'm not 100% sure what's going on there just from the messages, but it's clearly trying to do something about a session for user 'florian'...

Like Lukas, I can't reproduce this either on my own laptop or on a VM running on it. I tried several reboots of the VM on GNOME 44-rc, then updated to 44.0 from updates-testing and tried several reboots, couldn't reproduce it either.

Comment 8 Florian Apolloner 2023-03-23 18:16:43 UTC
Hi Adam,

I only have local user accounts. This happens immediately after booting, so there is nothing logged in yet. I also do not have autologin enabled and I can't remember any non-standard configuration. It also happens if I logout and relogin.

Any ideas on how to debug this further? Short of login in next to it and running strace I don't see many options :/

Comment 9 Adam Williamson 2023-03-23 18:36:50 UTC
well, the thing to do would be to figure out what's going on during the delay, I guess. It should be easiest for Ray, since he's the maintainer. If we're feeling really enthusiastic we can get the gdm source, poke through it for the log messages from around the time of the delay (above), and look at what's actually going on when those messages are logged, and that may help.

I'll poke Ray on chat and see if he's able to take a look.

Comment 10 Geraldo Simião 2023-03-23 18:57:05 UTC
Until now I didn't achieve to reproduce this one at my VMs. I'll try further, since this cam be a very problematic thing when we're affected.

Comment 11 Florian Apolloner 2023-03-23 19:34:59 UTC
Correction: If I logout GDM reshows properly, also a systemctl restart gdm shows it correctly. So there goes my idea of using strace :D So all in all, this happens only during boot (and as such the first login)

Comment 12 Ray Strode [halfline] 2023-03-24 13:16:15 UTC
this doesn't sound like a GDM issue.  It might be an accountsservice issue.

It's possible the recent accountsservice update is causing this I suppose.

What version of accountsservice do you have installed

Comment 13 Florian Apolloner 2023-03-24 13:19:20 UTC
accountsservice-23.11.69-1.fc38.x86_64
accountsservice-libs-23.11.69-1.fc38.x86_64

Comment 14 Ray Strode [halfline] 2023-03-24 13:30:20 UTC
can you try "dnf downgrade accountsservice" and see if that resolves your issue? I'll try to reproduce in a vm in the meanwhile

Comment 15 Ray Strode [halfline] 2023-03-24 13:32:59 UTC
hmm can't reproduce just upgrading accountsservice. It might also be a gnome-shell bug I suppose. i'll try a full update and see if that makes me reproduce.

Comment 16 Florian Apolloner 2023-03-24 14:10:36 UTC
Mhm, downgrade to which version and where from should I get it? If I execute your command it says I am at the lowest available version.

Comment 18 Ray Strode [halfline] 2023-03-24 14:16:04 UTC
(uh sorry for the duplicate urls in that command making it look longer than it needs to be, it should still work, or you can prune out the dupes if you want)

Comment 19 Florian Apolloner 2023-03-24 14:19:58 UTC
Jupp downgrading to 22.08 fixes it. I guess we can reassign to accountsservice.

Comment 20 Ray Strode [halfline] 2023-03-24 14:22:31 UTC
thanks. if you run

"coredumpctl" do you see any crasshes for accountsservice ?

can you post the output of:

sudo grep '.*'  -Er /var/lib/AccountsService/users/

?

Comment 21 Florian Apolloner 2023-03-24 14:25:45 UTC
No crashes for accountsservice.

Output of the command:
/var/lib/AccountsService/users/florian:[User]
/var/lib/AccountsService/users/florian:Session=gnome
/var/lib/AccountsService/users/florian:Icon=/usr/share/pixmaps/faces/mountain.jpg
/var/lib/AccountsService/users/florian:SystemAccount=false

Comment 22 Ray Strode [halfline] 2023-03-24 15:15:05 UTC
can you run

sudo systemctl edit --full accounts-daemon.service

and change the ExecStart line to

ExecStart=/usr/libexec/accounts-daemon --debug

(so add --debug to the end of it)

save and quit, reboot, reproduce and then attach the full unfiltered output of

journactl -b ?

Comment 23 Ray Strode [halfline] 2023-03-24 15:16:45 UTC
(no luck reproducing here unfortunately)

Comment 24 Florian Apolloner 2023-03-24 15:25:01 UTC
I do not feel confident enough to share the whole log here, but I think you are on to something (this is the full log -- at least for the timerange shown) -- is there any chance that this happens because accounts-daemon waits for the network to be "online"? Note that in this case I booted the Laptop in airplane mode /o\

Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmManager: trying to register new session on display 0x55e37b47c740
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmDisplay: session registered: yes
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmLocalDisplayFactory: session registered on display, looking for any background displays to kill
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmManager: trying to open new session
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmCommon: Found session c1 for PID 1713, using
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmSession: Considering session (null) for username (null)
Mar 24 16:19:45 apollo13 gdm[1591]: GdmDBusServer: new connection 0x7fab0c001b90
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmSession: Handling new connection from outside
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmManager: client with pid 1713 connected
Mar 24 16:19:45 apollo13 gdm[1591]: Gdm: GdmDisplay: Got timed login details for display: 0
Mar 24 16:19:46 apollo13 systemd[1]: systemd-rfkill.service: Deactivated successfully.
Mar 24 16:19:46 apollo13 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 24 16:19:47 apollo13 NetworkManager[1580]: <info>  [1679671187.9630] manager: startup complete
Mar 24 16:19:47 apollo13 systemd[1]: Finished NetworkManager-wait-online.service - Network Manager Wait Online.
Mar 24 16:19:47 apollo13 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 24 16:19:47 apollo13 systemd[1]: Reached target network-online.target - Network is Online.
Mar 24 16:19:52 apollo13 systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 24 16:19:52 apollo13 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: root
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: bin
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: daemon
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: adm
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: lp
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: sync
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: shutdown
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: halt
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: mail
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: operator
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: games
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: ftp
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: nobody
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: dbus
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: apache
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: tss
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: systemd-network
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: systemd-oom
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: systemd-resolve
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: qemu
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: polkitd
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: avahi
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: unbound
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: nm-openconnect
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: geoclue
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: usbmuxd
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: gluster
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: rtkit
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: saslauth
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: dnsmasq
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: rpc
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: colord
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: rpcuser
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: openvpn
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: nm-openvpn
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: pipewire
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: abrt
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: flatpak
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: gdm
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: gnome-initial-setup
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: vboxadd
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: sshd
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: chrony
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: tcpdump
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: systemd-coredump
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: systemd-timesync
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: loaded user: florian
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: akmods
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: postgres
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: consul
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: clevis
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: cockpit-ws
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: cockpit-wsinstance
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: pesign
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: nomad
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: skipping user: openvswitch
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: loaded user: gdm
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: user gdm 42 excluded
Mar 24 16:19:53 apollo13 accounts-daemon[1378]: (accounts-daemon:1378): DEBUG: user florian 1000 not excluded
Mar 24 16:19:54 apollo13 gdm[1591]: Gdm: GdmManager: trying to open reauthentication channel for user florian
Mar 24 16:19:54 apollo13 gdm[1591]: Gdm: GdmCommon: Found session c1 for PID 1713, using

Comment 25 Ray Strode [halfline] 2023-03-24 15:36:06 UTC
 there does seem to be an odd delay after starting accountsservice before the users are loaded, and it finally does kick into gear after network-online.target is reached. I don't know why that would be the case though.

if you don't want to give the whole log, can you give

journalctl -b |grep accounts

? i'd like to see when systemd starts the service and when it enters the main loop.

Comment 26 Florian Apolloner 2023-03-24 15:40:40 UTC
I just "disabled" the wait online service by asking it to simply run `/bin/true`.

The relevant logs around the jump (full accounts-daemon logs below):

Mar 24 16:35:36 apollo13 gdm[1604]: Gdm: GdmDisplay: Got timed login details for display: 0
Mar 24 16:35:36 apollo13 systemd[1693]: Starting xdg-permission-store.service - sandboxed app permission store...
Mar 24 16:35:36 apollo13 systemd[1693]: Started xdg-permission-store.service - sandboxed app permission store.
Mar 24 16:35:36 apollo13 wireplumber[1788]: <WpPortalPermissionStorePlugin:0x563b63b69070> Failed to call Lookup: GDBus.Error:org.freedesktop.portal.Error.NotFound: No entry for camera
Mar 24 16:35:36 apollo13 wireplumber[1788]: <WpPortalPermissionStorePlugin:0x563b63b69070> Failed to call Lookup: GDBus.Error:org.freedesktop.portal.Error.NotFound: No entry for camera
Mar 24 16:35:37 apollo13 systemd[1]: systemd-rfkill.service: Deactivated successfully.
Mar 24 16:35:37 apollo13 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-rfkill comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 24 16:35:38 apollo13 NetworkManager[1594]: <info>  [1679672138.4183] manager: startup complete
Mar 24 16:35:42 apollo13 systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Mar 24 16:35:42 apollo13 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? re>
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: root


The full accounts-daemon logs:

Mar 24 16:35:31 apollo13 systemd[1]: Starting accounts-daemon.service - Accounts Service...
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: entering main loop
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: Changing permission of /var/lib/AccountsService/users/florian to 0600
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: root
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: bin
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: daemon
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: adm
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: lp
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: sync
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: shutdown
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: halt
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: mail
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: operator
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: games
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: ftp
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nobody
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: dbus
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: apache
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: tss
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-network
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-oom
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-resolve
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: qemu
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: polkitd
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: avahi
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: unbound
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nm-openconnect
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: geoclue
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: usbmuxd
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gluster
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rtkit
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: saslauth
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: dnsmasq
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rpc
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: colord
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rpcuser
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: openvpn
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nm-openvpn
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: pipewire
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: abrt
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: flatpak
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gdm
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gnome-initial-setup
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: vboxadd
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: sshd
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: chrony
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: tcpdump
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-coredump
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-timesync
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: loaded user: florian
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: akmods
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: postgres
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: consul
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: clevis
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: cockpit-ws
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: cockpit-wsinstance
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: pesign
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nomad
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: openvswitch
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: started daemon version 23.11.0
Mar 24 16:35:31 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: failed to load autologin conf file: Unsupported Display Manager
Mar 24 16:35:31 apollo13 systemd[1]: Started accounts-daemon.service - Accounts Service.
Mar 24 16:35:31 apollo13 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=accounts-daemon comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 24 16:35:33 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: user florian 1000 not excluded
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: root
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: bin
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: daemon
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: adm
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: lp
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: sync
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: shutdown
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: halt
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: mail
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: operator
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: games
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: ftp
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nobody
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: dbus
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: apache
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: tss
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-network
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-oom
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-resolve
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: qemu
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: polkitd
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: avahi
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: unbound
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nm-openconnect
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: geoclue
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: usbmuxd
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gluster
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rtkit
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: saslauth
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: dnsmasq
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rpc
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: colord
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rpcuser
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: openvpn
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nm-openvpn
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: pipewire
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: abrt
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: flatpak
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gdm
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gnome-initial-setup
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: vboxadd
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: sshd
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: chrony
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: tcpdump
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-coredump
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-timesync
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: loaded user: florian
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: akmods
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: postgres
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: consul
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: clevis
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: cockpit-ws
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: cockpit-wsinstance
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: pesign
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nomad
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: openvswitch
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: loaded user: gdm
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: user gdm 42 excluded
Mar 24 16:35:43 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: user florian 1000 not excluded
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: trying to track new user with username florian
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: finding user 'florian' state 1
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: waiting for user manager to load before finding user 'florian'
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: Finding a graphical session for user 0
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: Failed to identify the current session
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: seat unloaded, so trying to set loaded property
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: Seat wouldn't load, so giving up on it and setting loaded property
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: user manager now loaded, proceeding with fetch user request for user 'florian'
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: finding user 'florian' state 2
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: Looking for user 'florian' in accounts service
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: already loaded, so not setting loaded property
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: Found object path of user 'florian': /org/freedesktop/Accounts/User1000
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: finding user 'florian' state 3
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: user 'florian' fetched
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: user florian is now loaded
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: user florian was not yet known, adding it
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: tracking user 'florian'
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: not yet loaded, so not emitting user-added signal
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: no pending users, trying to set loaded property
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: already loaded, so not setting loaded property
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: finished handling request for user 'florian'
Mar 24 16:35:44 apollo13 gdm-password][2243]: accountsservice: ActUserManager: unrefing manager owned by fetch user request
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: root
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: bin
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: daemon
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: adm
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: lp
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: sync
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: shutdown
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: halt
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: mail
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: operator
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: games
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: ftp
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nobody
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: dbus
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: apache
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: tss
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-network
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-oom
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-resolve
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: qemu
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: polkitd
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: avahi
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: unbound
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nm-openconnect
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: geoclue
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: usbmuxd
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gluster
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rtkit
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: saslauth
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: dnsmasq
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rpc
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: colord
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: rpcuser
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: openvpn
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nm-openvpn
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: pipewire
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: abrt
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: flatpak
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gdm
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: gnome-initial-setup
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: vboxadd
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: sshd
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: chrony
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: tcpdump
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-coredump
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: systemd-timesync
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: loaded user: florian
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: akmods
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: postgres
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: consul
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: clevis
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: cockpit-ws
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: cockpit-wsinstance
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: pesign
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: nomad
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: skipping user: openvswitch
Mar 24 16:35:57 apollo13 accounts-daemon[1383]: (accounts-daemon:1383): DEBUG: loaded user: gdm
Mar 24 16:35:57 apollo13 gdm-password][2243]: accountsservice: ActUserManager: sending user-changed signal for user florian
Mar 24 16:35:57 apollo13 gdm-password][2243]: accountsservice: ActUserManager: sent user-changed signal for user florian
Mar 24 16:35:57 apollo13 gdm-password][2243]: accountsservice: ActUserManager: updating user florian
Mar 24 16:35:58 apollo13 gdm-password][2243]: accountsservice: ActUserManager: sending user-changed signal for user florian
Mar 24 16:35:58 apollo13 gdm-password][2243]: accountsservice: ActUserManager: sent user-changed signal for user florian
Mar 24 16:35:58 apollo13 gdm-password][2243]: accountsservice: ActUserManager: updating user florian

Comment 27 Ray Strode [halfline] 2023-03-24 15:46:25 UTC
hmm I wonder if it's related to this commit:

https://gitlab.freedesktop.org/accountsservice/accountsservice/-/commit/0e712e935abd26499ff5995ab363e5bfd9ee7c4c

The

PrivateNetwork=true

is wrong at aleast, since accountsservice may need to query the network for remote user cases (maybe not relevant to you of course).

Comment 28 Ray Strode [halfline] 2023-03-24 15:47:34 UTC
can you do

sudo systemctl edit --full accounts-daemon.service

and change

 PrivateNetwork=true 

to

 PrivateNetwork=false

?

Comment 29 Florian Apolloner 2023-03-24 15:52:27 UTC
No change.

Comment 30 Ray Strode [halfline] 2023-03-24 16:08:02 UTC
okay i think i see the issue. it's from this commit, i believe:

https://gitlab.freedesktop.org/accountsservice/accountsservice/-/commit/836a9135fe2d8fdc7d6de3a6d11fb9a5fd05f926

it adds a 10 second latency to reloading wtmp, but the code has this:

        if (priv->reload_id > 0) {•
                /* reload pending -- finish call in reload_users_timeout */•
                g_queue_push_tail (priv->pending_list_cached_users, data);•
        } else {•
                finish_list_cached_users (data);•
        }•

So it won't respond to any user list requests until the 10 seconds is up.

Comment 31 Ray Strode [halfline] 2023-03-24 16:21:56 UTC
i'm doing an untested scratch build here:

https://koji.fedoraproject.org/koji/taskinfo?taskID=99089111

Assuming it builds, do you mind giving it a try?

Comment 32 Florian Apolloner 2023-03-24 16:24:09 UTC
Sure thing, will test once the builds are here.

Comment 33 Florian Apolloner 2023-03-24 16:28:58 UTC
Jupp, the scratch build fixes the issue. Thank you very much! Do you need anything else from me to move this forward?

Comment 34 Ray Strode [halfline] 2023-03-24 16:43:15 UTC
nope, thanks for all the help. much appreciated

Comment 35 Fedora Update System 2023-03-24 16:57:44 UTC
FEDORA-2023-a5af7d5db0 has been submitted as an update to Fedora 38. https://bodhi.fedoraproject.org/updates/FEDORA-2023-a5af7d5db0

Comment 36 Fedora Update System 2023-03-25 02:45:20 UTC
FEDORA-2023-a5af7d5db0 has been pushed to the Fedora 38 testing repository.

You can provide feedback for this update here: https://bodhi.fedoraproject.org/updates/FEDORA-2023-a5af7d5db0

See also https://fedoraproject.org/wiki/QA:Updates_Testing for more information on how to test updates.

Comment 37 Fedora Update System 2023-03-26 00:20:53 UTC
FEDORA-2023-a5af7d5db0 has been pushed to the Fedora 38 stable repository.
If problem still persists, please make note of it in this bug report.


Note You need to log in before you can comment on or make changes to this bug.