Activity log for bug #1871538

Date Who What changed Old value New value Message
2020-04-08 05:57:23 Christian Ehrhardt  bug added bug
2020-04-08 05:57:33 Christian Ehrhardt  bug task added dbus (Ubuntu)
2020-04-08 05:57:53 Christian Ehrhardt  bug task added gnome-shell (Ubuntu)
2020-04-08 05:58:04 Christian Ehrhardt  tags amd64 apport-bug focal amd64 apport-bug champagne focal
2020-04-08 06:12:41 Daniel van Vugt marked as duplicate 1843982
2020-04-08 06:13:33 Daniel van Vugt bug added subscriber Daniel van Vugt
2020-04-08 08:38:34 Christian Ehrhardt  removed duplicate marker 1843982
2020-04-08 08:50:45 Sebastien Bacher bug added subscriber Sebastien Bacher
2020-04-08 08:55:34 Daniel van Vugt accountsservice (Ubuntu): status New Incomplete
2020-04-08 08:55:37 Daniel van Vugt dbus (Ubuntu): status New Incomplete
2020-04-08 08:55:40 Daniel van Vugt gnome-shell (Ubuntu): status New Incomplete
2020-04-08 09:08:25 Christian Ehrhardt  attachment added journal-gnome-restarts.log https://bugs.launchpad.net/ubuntu/+source/accountsservice/+bug/1871538/+attachment/5349396/+files/journal-gnome-restarts.log
2020-04-08 09:39:35 Sebastien Bacher accountsservice (Ubuntu): status Incomplete Invalid
2020-04-08 09:39:38 Sebastien Bacher gnome-shell (Ubuntu): status Incomplete Invalid
2020-04-08 09:43:11 Sebastien Bacher dbus (Ubuntu): importance Undecided High
2020-04-08 09:48:31 Sebastien Bacher summary Gnome Shell crashed on background upgrade of accountsservice dbus timeout-ed during an upgrade, taking services down including gdm
2020-04-08 21:46:16 Steve Beattie attachment added journalctl.log https://bugs.launchpad.net/ubuntu/+source/accountsservice/+bug/1871538/+attachment/5349957/+files/journalctl.log
2020-04-08 21:57:24 Steve Beattie bug added subscriber Steve Beattie
2020-04-14 23:52:07 Brian Murray tags amd64 apport-bug champagne focal amd64 apport-bug champagne focal rls-ff-incoming
2020-04-16 16:55:20 Brian Murray nominated for series Ubuntu Focal
2020-04-16 16:55:20 Brian Murray bug task added dbus (Ubuntu Focal)
2020-04-16 16:55:20 Brian Murray bug task added gnome-shell (Ubuntu Focal)
2020-04-16 16:55:20 Brian Murray bug task added accountsservice (Ubuntu Focal)
2020-04-22 12:32:27 Francis Ginther tags amd64 apport-bug champagne focal rls-ff-incoming amd64 apport-bug champagne focal id-5e988df7fb344884f67bc04f rls-ff-incoming
2020-04-28 12:13:41 Dan Streetman bug added subscriber Dan Streetman
2020-07-20 04:17:24 Launchpad Janitor dbus (Ubuntu Focal): status Incomplete Expired
2020-07-20 04:17:25 Launchpad Janitor dbus (Ubuntu): status Incomplete Expired
2020-07-20 05:50:24 Steve Beattie dbus (Ubuntu): status Expired Confirmed
2020-07-20 05:50:28 Steve Beattie dbus (Ubuntu Focal): status Expired Confirmed
2020-07-26 14:53:56 Oliver Old bug watch added https://github.com/systemd/systemd/issues/15316
2020-07-26 14:53:56 Oliver Old bug task added systemd
2020-07-26 14:56:16 Oliver Old bug added subscriber Oliver Old
2020-07-26 15:46:44 Bug Watch Updater systemd: status Unknown New
2020-09-10 15:20:28 Dimitri John Ledkov dbus (Ubuntu): status Confirmed Incomplete
2020-09-10 15:20:31 Dimitri John Ledkov dbus (Ubuntu Focal): status Confirmed Incomplete
2020-09-25 15:06:27 Lukas Märdian attachment added dbus.c https://bugs.launchpad.net/ubuntu/+source/accountsservice/+bug/1871538/+attachment/5414222/+files/dbus.c
2020-10-02 07:19:45 Jean-Baptiste Lallement bug added subscriber Jean-Baptiste Lallement
2020-10-06 12:59:50 Iain Lane bug added subscriber Iain Lane
2020-10-15 15:38:25 Łukasz Zemczak tags amd64 apport-bug champagne focal id-5e988df7fb344884f67bc04f rls-ff-incoming amd64 apport-bug champagne focal id-5e988df7fb344884f67bc04f
2020-11-19 16:19:30 Brian Murray tags amd64 apport-bug champagne focal id-5e988df7fb344884f67bc04f amd64 apport-bug focal id-5e988df7fb344884f67bc04f
2021-06-16 07:55:39 Lukas Märdian nominated for series Ubuntu Hirsute
2021-06-16 07:55:39 Lukas Märdian bug task added dbus (Ubuntu Hirsute)
2021-06-16 07:55:39 Lukas Märdian bug task added gnome-shell (Ubuntu Hirsute)
2021-06-16 07:55:39 Lukas Märdian bug task added accountsservice (Ubuntu Hirsute)
2021-06-16 07:56:19 Lukas Märdian tags amd64 apport-bug focal id-5e988df7fb344884f67bc04f amd64 apport-bug focal id-5e988df7fb344884f67bc04f rls-ff-incoming rls-hh-incoming
2021-06-16 07:57:07 Lukas Märdian nominated for series Ubuntu Impish
2021-06-16 07:57:07 Lukas Märdian bug task added dbus (Ubuntu Impish)
2021-06-16 07:57:07 Lukas Märdian bug task added gnome-shell (Ubuntu Impish)
2021-06-16 07:57:07 Lukas Märdian bug task added accountsservice (Ubuntu Impish)
2021-06-16 07:57:07 Lukas Märdian nominated for series Ubuntu Groovy
2021-06-16 07:57:07 Lukas Märdian bug task added dbus (Ubuntu Groovy)
2021-06-16 07:57:07 Lukas Märdian bug task added gnome-shell (Ubuntu Groovy)
2021-06-16 07:57:07 Lukas Märdian bug task added accountsservice (Ubuntu Groovy)
2021-06-16 07:57:52 Lukas Märdian tags amd64 apport-bug focal id-5e988df7fb344884f67bc04f rls-ff-incoming rls-hh-incoming amd64 apport-bug focal id-5e988df7fb344884f67bc04f rls-ff-incoming rls-hh-incoming rls-ii-incoming
2021-06-16 08:00:53 Gauthier Jolly bug added subscriber Gauthier Jolly
2021-06-16 09:13:52 Gauthier Jolly attachment added syslog https://bugs.launchpad.net/ubuntu/+source/dbus/+bug/1871538/+attachment/5505001/+files/syslog
2021-06-16 13:08:38 Lukas Märdian bug added subscriber Lukas Märdian
2021-06-17 11:05:11 Iain Lane bug watch added https://gitlab.freedesktop.org/dbus/dbus/-/issues/337
2021-06-17 11:05:11 Iain Lane bug task added dbus
2021-06-17 15:13:52 Matthieu Clemenceau tags amd64 apport-bug focal id-5e988df7fb344884f67bc04f rls-ff-incoming rls-hh-incoming rls-ii-incoming amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f rls-ff-incoming rls-hh-incoming rls-ii-incoming
2021-06-17 17:07:04 Brian Murray tags amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f rls-ff-incoming rls-hh-incoming rls-ii-incoming amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f
2021-06-22 14:46:39 Iain Lane accountsservice (Ubuntu Groovy): status New Invalid
2021-06-22 14:46:49 Iain Lane accountsservice (Ubuntu Hirsute): status New Invalid
2021-06-22 14:47:03 Iain Lane gnome-shell (Ubuntu Groovy): status New Invalid
2021-06-22 14:47:06 Iain Lane gnome-shell (Ubuntu Hirsute): status New Invalid
2021-06-22 14:47:21 Iain Lane dbus (Ubuntu Groovy): status New Incomplete
2021-06-22 14:47:25 Iain Lane dbus (Ubuntu Hirsute): status New Incomplete
2021-09-08 07:46:02 Gauthier Jolly tags amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f rls-ii-incoming
2021-09-10 15:22:57 Launchpad Janitor merge proposal linked https://code.launchpad.net/~vorlon/ubuntu-seeds/+git/platform/+merge/408418
2021-09-16 15:12:00 Lukas Märdian tags amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f rls-ii-incoming amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f
2021-11-18 06:57:01 Christian Ehrhardt  attachment added journal entries around the issues happening on unattended-upgrades https://bugs.launchpad.net/ubuntu/+source/accountsservice/+bug/1871538/+attachment/5541619/+files/fail-18Nov-6-24-07.log
2022-01-26 21:59:42 Brian Murray dbus (Ubuntu Hirsute): status Incomplete Won't Fix
2022-02-25 10:41:30 Lukas Märdian bug task added systemd (Ubuntu)
2022-02-25 10:42:04 Lukas Märdian bug task deleted systemd (Ubuntu Groovy)
2022-02-25 10:42:13 Lukas Märdian bug task deleted systemd (Ubuntu Hirsute)
2022-02-25 10:42:29 Lukas Märdian nominated for series Ubuntu Jammy
2022-02-25 10:42:29 Lukas Märdian bug task added dbus (Ubuntu Jammy)
2022-02-25 10:42:29 Lukas Märdian bug task added gnome-shell (Ubuntu Jammy)
2022-02-25 10:42:29 Lukas Märdian bug task added systemd (Ubuntu Jammy)
2022-02-25 10:42:29 Lukas Märdian bug task added accountsservice (Ubuntu Jammy)
2022-02-25 10:42:45 Lukas Märdian dbus (Ubuntu Impish): status Incomplete Invalid
2022-02-25 10:42:58 Lukas Märdian dbus (Ubuntu Jammy): status Incomplete Invalid
2022-02-25 10:43:10 Lukas Märdian dbus (Ubuntu Groovy): status Incomplete Invalid
2022-02-25 10:43:22 Lukas Märdian dbus (Ubuntu Focal): status Incomplete Invalid
2022-02-25 13:11:57 Lukas Märdian description This morning I found my computer on the login screen. But not the one of the screen log, no a new one - so something must have crashed. Logging in again confirmed that all apps were gone and the gnome shell was brought down what seems like triggered by a background update o accountsservice. As always things are not perfectly clear :-/ The following goes *back* in time through my logs one by one. Multiple apps crashed at 06:09, but we will find later that this is a follow on issue of the underlying gnome/X/... recycling. -rw-r----- 1 paelzer whoopsie 52962868 Apr 8 06:09 _usr_bin_konversation.1000.crash -rw-r----- 1 paelzer whoopsie 986433 Apr 8 06:09 _usr_lib_x86_64-linux-gnu_libexec_drkonqi.1000.crash rdkit was failing fast and giving up (that will be a different bug, it just seems broken on my system): Apr 08 06:10:13 Keschdeichel systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Successfully called chroot. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Successfully dropped privileges. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Successfully limited resources. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: pthread_create failed: Resource temporarily unavailable Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Canary thread running. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Exiting canary thread. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Demoting known real-time threads. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Demoted 0 threads. Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Failed with result 'exit-code'. Apr 08 06:10:13 Keschdeichel dbus-daemon[1208]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.1176' (uid=121 pid=> Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Start request repeated too quickly. Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Failed with result 'exit-code'. Apr 08 06:10:13 Keschdeichel systemd[1]: Failed to start RealtimeKit Scheduling Policy Service. Apr 08 06:10:13 Keschdeichel bluetoothd[1729331]: Bluetooth daemon 5.53 But that already was only triggered by a gnome restart that kicked of earlier: Apr 08 06:09:27 Keschdeichel systemd[1726656]: Started GNOME Shell on Wayland. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Shell on Wayland. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Session is initialized. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Wayland Session. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Session (session: gnome-login). X was recycleing before: Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopping GNOME Shell on X11... ... Apr 08 06:09:22 Keschdeichel /usr/lib/gdm3/gdm-x-session[10710]: (EE) systemd-logind: ReleaseControl failed: Unknown object '/org/freedesktop/login1/session/_32'. Apr 08 06:09:22 Keschdeichel /usr/lib/gdm3/gdm-x-session[10710]: (II) Server terminated successfully (0). Closing log file. It seems like some internal service broke and everything that followed was a secondary issue to that: Apr 08 06:09:19 Keschdeichel systemd[1]: NetworkManager.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: wpa_supplicant.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: thermald.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel thermald[1256]: [WARN]Terminating ... Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Got SIGTERM, quitting. Apr 08 06:09:19 Keschdeichel systemd[1]: udisks2.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel ModemManager[1308]: <info> Caught signal, shutting down... Apr 08 06:09:19 Keschdeichel systemd[1]: switcheroo-control.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface vnet0.IPv6 with address fe80::fc54:ff:fe78:26c2. Apr 08 06:09:19 Keschdeichel systemd[1]: accounts-daemon.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface strswanbr2.IPv4 with address 192.168.2.0. Apr 08 06:09:19 Keschdeichel systemd[1]: gdm.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface virbr0.IPv4 with address 192.168.122.1. Apr 08 06:09:19 Keschdeichel systemd[1]: systemd-logind.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface strswanbr1.IPv4 with address 192.168.1.0. Apr 08 06:09:19 Keschdeichel systemd[1]: systemd-machined.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lxdbr0.IPv6 with address fd42:fa18:c923:35d5::1. Apr 08 06:09:19 Keschdeichel systemd-machined[1255]: Failed to drop reference to machine scope, ignoring: Transport endpoint is not connected Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lxdbr0.IPv4 with address 10.253.194.1. Apr 08 06:09:19 Keschdeichel systemd[1]: switcheroo-control.service: Succeeded. Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface wlp4s0.IPv6 with address fe80::6832:c873:a074:2c7b. Apr 08 06:09:19 Keschdeichel systemd[1]: systemd-machined.service: Succeeded. Apr 08 06:09:19 Keschdeichel bluetoothd[1724347]: Terminating Apr 08 06:09:19 Keschdeichel systemd[1]: avahi-daemon.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface wlp4s0.IPv4 with address 10.7.0.42. Apr 08 06:09:19 Keschdeichel systemd[1]: ModemManager.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface enp0s31f6.IPv6 with address fe80::80a8:743:6b37:e561. Apr 08 06:09:19 Keschdeichel systemd[1]: polkit.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface enp0s31f6.IPv4 with address 10.7.0.69. Apr 08 06:09:19 Keschdeichel systemd[1]: bolt.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lo.IPv6 with address ::1. Apr 08 06:09:19 Keschdeichel systemd[1]: rtkit-daemon.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Apr 08 06:09:19 Keschdeichel systemd[1]: packagekit.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel wpa_supplicant[1265]: nl80211: deinit ifname=p2p-dev-wlp4s0 disabled_11b_rates=0 Apr 08 06:09:19 Keschdeichel systemd[1]: colord.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: upower.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: bluetooth.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: fwupd.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel xdg-desktop-por[11011]: xdg-desktop-portal-gtk: Fatal IO error 11 (Resource temporarily unavailable) on X server :0. Apr 08 06:09:19 Keschdeichel NetworkManager[1209]: <info> [1586318959.7797] caught SIGTERM, shutting down normally. Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: avahi-daemon 0.7 exiting. Apr 08 06:09:19 Keschdeichel systemd[1]: rtkit-daemon.service: Succeeded. Apr 08 06:09:19 Keschdeichel systemd[1]: Starting Process error reports when automatic reporting is enabled... Apr 08 06:09:19 Keschdeichel systemd[1]: colord.service: Succeeded. Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopped target GNOME X11 Session (session: ubuntu). Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopped target Current graphical user session. Apr 08 06:09:19 Keschdeichel systemd[10683]: unicast-local-avahi.path: Succeeded. Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopped Path trigger for Avahi .local domain notifications. Apr 08 06:09:19 Keschdeichel systemd[10683]: update-notifier-release.path: Succeeded. Apr 08 06:09:19 Keschdeichel gnome-shell[11036]: gnome-shell: Fatal IO error 11 (Resource temporarily unavailable) on X server :0. The last things before was systemd reload - maybe due to a background upgrade? Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: Unknown group "power" in message bus configuration file Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: [system] Reloaded configuration Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: Unknown group "power" in message bus configuration file Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: [system] Reloaded configuration Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: Unknown group "power" in message bus configuration file Apr 08 06:08:54 Keschdeichel systemd[1]: Reloading. And indeed there was an upgrade going on: 40773 2020-04-08 06:08:46 status installed libc-bin:amd64 2.31-0ubuntu7 40774 2020-04-08 06:08:54 startup archives unpack 40775 2020-04-08 06:08:54 upgrade accountsservice:amd64 0.6.55-0ubuntu10 0.6.55-0ubuntu11 40776 2020-04-08 06:08:54 status half-configured accountsservice:amd64 0.6.55-0ubuntu10 40777 2020-04-08 06:08:54 status unpacked accountsservice:amd64 0.6.55-0ubuntu10 40778 2020-04-08 06:08:54 status half-installed accountsservice:amd64 0.6.55-0ubuntu10 40779 2020-04-08 06:08:54 status triggers-pending dbus:amd64 1.12.16-2ubuntu2 40780 2020-04-08 06:09:19 status unpacked accountsservice:amd64 0.6.55-0ubuntu11 40781 2020-04-08 06:09:20 upgrade libaccountsservice0:amd64 0.6.55-0ubuntu10 0.6.55-0ubuntu11 40782 2020-04-08 06:09:20 status triggers-pending libc-bin:amd64 2.31-0ubuntu7 40783 2020-04-08 06:09:20 status half-configured libaccountsservice0:amd64 0.6.55-0ubuntu10 40784 2020-04-08 06:09:20 status unpacked libaccountsservice0:amd64 0.6.55-0ubuntu10 40785 2020-04-08 06:09:20 status half-installed libaccountsservice0:amd64 0.6.55-0ubuntu10 40786 2020-04-08 06:09:20 status unpacked libaccountsservice0:amd64 0.6.55-0ubuntu11 Nothing suspicious before that time. ProblemType: Bug DistroRelease: Ubuntu 20.04 Package: accountsservice 0.6.55-0ubuntu11 ProcVersionSignature: Ubuntu 5.3.0-45.37~18.04.1-generic 5.3.18 Uname: Linux 5.3.0-45-generic x86_64 NonfreeKernelModules: zfs zunicode zavl icp zcommon znvpair ApportVersion: 2.20.11-0ubuntu24 Architecture: amd64 CurrentDesktop: ubuntu:GNOME Date: Wed Apr 8 07:51:03 2020 InstallationDate: Installed on 2018-10-12 (543 days ago) InstallationMedia: Ubuntu 18.04.1 LTS "Bionic Beaver" - Release amd64 (20180725) SourcePackage: accountsservice UpgradeStatus: Upgraded to focal on 2020-04-03 (4 days ago) [Impact] * There's currently a deadlock between PID 1 and dbus-daemon: in some cases dbus-daemon will do NSS lookups (which are blocking) at the same time PID 1 synchronously blocks on some call to dbus-daemon (e.g. `GetConnectionUnixUser` DBus call). Let's break that by setting SYSTEMD_NSS_DYNAMIC_BYPASS=1 env var for dbus-daemon, which will disable synchronously blocking varlink calls from nss-systemd to PID 1. * This can lead to delayed boot times * It can also lead to dbus-daemon being killed/re-started, taking down other services with it, like GDM, killing user sessions on the way (e.g. on installing updates) [Test Plan] * This bug is really hard to reproduce, as can be seen from the multi-year long discussion at https://github.com/systemd/systemd/issues/15316 * Canonical's CPC team has the ability to reproduce this issue (with a relatively high probability) in their Azure test environment, due to the specific setup they are using * So our test plan is to ask CPC (@gjolly) for confirmation if the issue is fixed. [Where problems could occur] * This fix touches the communication between systemd and dbus daemon, especially the NSS lookup, so if something is broken the (user-)name resolution could be broken. * As a workaround dbus-daemon could be replaced by dbus-broker, which never showed this issue or the behaviour could be changed back by using the `SYSTEMD_NSS_DYNAMIC_BYPASS` env variable, like this: #/etc/systemd/system/dbus.service.d/override.conf [Service] Environment=SYSTEMD_NSS_DYNAMIC_BYPASS=0 [Other Info] * Fixed upstream (v251) in https://github.com/systemd/systemd/pull/22552 === Original Description === This morning I found my computer on the login screen. But not the one of the screen log, no a new one - so something must have crashed. Logging in again confirmed that all apps were gone and the gnome shell was brought down what seems like triggered by a background update o accountsservice. As always things are not perfectly clear :-/ The following goes *back* in time through my logs one by one. Multiple apps crashed at 06:09, but we will find later that this is a follow on issue of the underlying gnome/X/... recycling. -rw-r----- 1 paelzer whoopsie 52962868 Apr 8 06:09 _usr_bin_konversation.1000.crash -rw-r----- 1 paelzer whoopsie 986433 Apr 8 06:09 _usr_lib_x86_64-linux-gnu_libexec_drkonqi.1000.crash rdkit was failing fast and giving up (that will be a different bug, it just seems broken on my system): Apr 08 06:10:13 Keschdeichel systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Successfully called chroot. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Successfully dropped privileges. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Successfully limited resources. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: pthread_create failed: Resource temporarily unavailable Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Canary thread running. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Exiting canary thread. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Demoting known real-time threads. Apr 08 06:10:13 Keschdeichel rtkit-daemon[1729333]: Demoted 0 threads. Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Failed with result 'exit-code'. Apr 08 06:10:13 Keschdeichel dbus-daemon[1208]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.1176' (uid=121 pid=> Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Start request repeated too quickly. Apr 08 06:10:13 Keschdeichel systemd[1]: rtkit-daemon.service: Failed with result 'exit-code'. Apr 08 06:10:13 Keschdeichel systemd[1]: Failed to start RealtimeKit Scheduling Policy Service. Apr 08 06:10:13 Keschdeichel bluetoothd[1729331]: Bluetooth daemon 5.53 But that already was only triggered by a gnome restart that kicked of earlier: Apr 08 06:09:27 Keschdeichel systemd[1726656]: Started GNOME Shell on Wayland. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Shell on Wayland. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Session is initialized. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Wayland Session. Apr 08 06:09:27 Keschdeichel systemd[1726656]: Reached target GNOME Session (session: gnome-login). X was recycleing before: Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopping GNOME Shell on X11... ... Apr 08 06:09:22 Keschdeichel /usr/lib/gdm3/gdm-x-session[10710]: (EE) systemd-logind: ReleaseControl failed: Unknown object '/org/freedesktop/login1/session/_32'. Apr 08 06:09:22 Keschdeichel /usr/lib/gdm3/gdm-x-session[10710]: (II) Server terminated successfully (0). Closing log file. It seems like some internal service broke and everything that followed was a secondary issue to that: Apr 08 06:09:19 Keschdeichel systemd[1]: NetworkManager.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: wpa_supplicant.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: thermald.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel thermald[1256]: [WARN]Terminating ... Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Got SIGTERM, quitting. Apr 08 06:09:19 Keschdeichel systemd[1]: udisks2.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel ModemManager[1308]: <info> Caught signal, shutting down... Apr 08 06:09:19 Keschdeichel systemd[1]: switcheroo-control.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface vnet0.IPv6 with address fe80::fc54:ff:fe78:26c2. Apr 08 06:09:19 Keschdeichel systemd[1]: accounts-daemon.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface strswanbr2.IPv4 with address 192.168.2.0. Apr 08 06:09:19 Keschdeichel systemd[1]: gdm.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface virbr0.IPv4 with address 192.168.122.1. Apr 08 06:09:19 Keschdeichel systemd[1]: systemd-logind.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface strswanbr1.IPv4 with address 192.168.1.0. Apr 08 06:09:19 Keschdeichel systemd[1]: systemd-machined.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lxdbr0.IPv6 with address fd42:fa18:c923:35d5::1. Apr 08 06:09:19 Keschdeichel systemd-machined[1255]: Failed to drop reference to machine scope, ignoring: Transport endpoint is not connected Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lxdbr0.IPv4 with address 10.253.194.1. Apr 08 06:09:19 Keschdeichel systemd[1]: switcheroo-control.service: Succeeded. Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface wlp4s0.IPv6 with address fe80::6832:c873:a074:2c7b. Apr 08 06:09:19 Keschdeichel systemd[1]: systemd-machined.service: Succeeded. Apr 08 06:09:19 Keschdeichel bluetoothd[1724347]: Terminating Apr 08 06:09:19 Keschdeichel systemd[1]: avahi-daemon.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface wlp4s0.IPv4 with address 10.7.0.42. Apr 08 06:09:19 Keschdeichel systemd[1]: ModemManager.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface enp0s31f6.IPv6 with address fe80::80a8:743:6b37:e561. Apr 08 06:09:19 Keschdeichel systemd[1]: polkit.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface enp0s31f6.IPv4 with address 10.7.0.69. Apr 08 06:09:19 Keschdeichel systemd[1]: bolt.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lo.IPv6 with address ::1. Apr 08 06:09:19 Keschdeichel systemd[1]: rtkit-daemon.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Apr 08 06:09:19 Keschdeichel systemd[1]: packagekit.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel wpa_supplicant[1265]: nl80211: deinit ifname=p2p-dev-wlp4s0 disabled_11b_rates=0 Apr 08 06:09:19 Keschdeichel systemd[1]: colord.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: upower.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: bluetooth.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel systemd[1]: fwupd.service: Unexpected error response from GetNameOwner(): Connection terminated Apr 08 06:09:19 Keschdeichel xdg-desktop-por[11011]: xdg-desktop-portal-gtk: Fatal IO error 11 (Resource temporarily unavailable) on X server :0. Apr 08 06:09:19 Keschdeichel NetworkManager[1209]: <info> [1586318959.7797] caught SIGTERM, shutting down normally. Apr 08 06:09:19 Keschdeichel avahi-daemon[1204]: avahi-daemon 0.7 exiting. Apr 08 06:09:19 Keschdeichel systemd[1]: rtkit-daemon.service: Succeeded. Apr 08 06:09:19 Keschdeichel systemd[1]: Starting Process error reports when automatic reporting is enabled... Apr 08 06:09:19 Keschdeichel systemd[1]: colord.service: Succeeded. Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopped target GNOME X11 Session (session: ubuntu). Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopped target Current graphical user session. Apr 08 06:09:19 Keschdeichel systemd[10683]: unicast-local-avahi.path: Succeeded. Apr 08 06:09:19 Keschdeichel systemd[10683]: Stopped Path trigger for Avahi .local domain notifications. Apr 08 06:09:19 Keschdeichel systemd[10683]: update-notifier-release.path: Succeeded. Apr 08 06:09:19 Keschdeichel gnome-shell[11036]: gnome-shell: Fatal IO error 11 (Resource temporarily unavailable) on X server :0. The last things before was systemd reload - maybe due to a background upgrade? Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: Unknown group "power" in message bus configuration file Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: [system] Reloaded configuration Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: Unknown group "power" in message bus configuration file Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: [system] Reloaded configuration Apr 08 06:08:54 Keschdeichel dbus-daemon[1208]: Unknown group "power" in message bus configuration file Apr 08 06:08:54 Keschdeichel systemd[1]: Reloading. And indeed there was an upgrade going on: 40773 2020-04-08 06:08:46 status installed libc-bin:amd64 2.31-0ubuntu7 40774 2020-04-08 06:08:54 startup archives unpack 40775 2020-04-08 06:08:54 upgrade accountsservice:amd64 0.6.55-0ubuntu10 0.6.55-0ubuntu11 40776 2020-04-08 06:08:54 status half-configured accountsservice:amd64 0.6.55-0ubuntu10 40777 2020-04-08 06:08:54 status unpacked accountsservice:amd64 0.6.55-0ubuntu10 40778 2020-04-08 06:08:54 status half-installed accountsservice:amd64 0.6.55-0ubuntu10 40779 2020-04-08 06:08:54 status triggers-pending dbus:amd64 1.12.16-2ubuntu2 40780 2020-04-08 06:09:19 status unpacked accountsservice:amd64 0.6.55-0ubuntu11 40781 2020-04-08 06:09:20 upgrade libaccountsservice0:amd64 0.6.55-0ubuntu10 0.6.55-0ubuntu11 40782 2020-04-08 06:09:20 status triggers-pending libc-bin:amd64 2.31-0ubuntu7 40783 2020-04-08 06:09:20 status half-configured libaccountsservice0:amd64 0.6.55-0ubuntu10 40784 2020-04-08 06:09:20 status unpacked libaccountsservice0:amd64 0.6.55-0ubuntu10 40785 2020-04-08 06:09:20 status half-installed libaccountsservice0:amd64 0.6.55-0ubuntu10 40786 2020-04-08 06:09:20 status unpacked libaccountsservice0:amd64 0.6.55-0ubuntu11 Nothing suspicious before that time. ProblemType: Bug DistroRelease: Ubuntu 20.04 Package: accountsservice 0.6.55-0ubuntu11 ProcVersionSignature: Ubuntu 5.3.0-45.37~18.04.1-generic 5.3.18 Uname: Linux 5.3.0-45-generic x86_64 NonfreeKernelModules: zfs zunicode zavl icp zcommon znvpair ApportVersion: 2.20.11-0ubuntu24 Architecture: amd64 CurrentDesktop: ubuntu:GNOME Date: Wed Apr 8 07:51:03 2020 InstallationDate: Installed on 2018-10-12 (543 days ago) InstallationMedia: Ubuntu 18.04.1 LTS "Bionic Beaver" - Release amd64 (20180725) SourcePackage: accountsservice UpgradeStatus: Upgraded to focal on 2020-04-03 (4 days ago)
2022-03-08 16:09:25 Lukas Märdian systemd (Ubuntu Jammy): status New In Progress
2022-03-08 16:09:25 Lukas Märdian systemd (Ubuntu Jammy): assignee Lukas Märdian (slyon)
2022-03-10 19:18:19 Launchpad Janitor systemd (Ubuntu Jammy): status In Progress Fix Released
2022-03-23 15:25:12 Launchpad Janitor merge proposal linked https://code.launchpad.net/~enr0n/ubuntu/+source/systemd/+git/systemd/+merge/417577
2022-03-24 20:57:37 Nick Rosbrook bug added subscriber Nick Rosbrook
2022-03-28 18:16:44 Brian Murray systemd (Ubuntu Impish): status New Fix Committed
2022-03-28 18:16:47 Brian Murray bug added subscriber Ubuntu Stable Release Updates Team
2022-03-28 18:16:50 Brian Murray bug added subscriber SRU Verification
2022-03-28 18:16:57 Brian Murray tags amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f verification-needed verification-needed-impish
2022-03-28 18:23:24 Brian Murray systemd (Ubuntu Focal): status New Fix Committed
2022-03-28 18:23:36 Brian Murray tags amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f verification-needed verification-needed-impish amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f verification-needed verification-needed-focal verification-needed-impish
2022-04-07 17:18:41 Nick Rosbrook tags amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f verification-needed verification-needed-focal verification-needed-impish amd64 apport-bug focal fr-1460 id-5e988df7fb344884f67bc04f verification-done verification-done-focal verification-done-impish
2022-04-13 22:51:09 Launchpad Janitor systemd (Ubuntu Impish): status Fix Committed Fix Released
2022-04-13 22:51:23 Brian Murray removed subscriber Ubuntu Stable Release Updates Team
2022-04-13 22:54:41 Launchpad Janitor systemd (Ubuntu Focal): status Fix Committed Fix Released
2022-04-20 14:10:17 Mario Limonciello bug watch added https://github.com/fwupd/fwupd/issues/3037
2022-04-20 14:10:17 Mario Limonciello bug watch added https://github.com/systemd/systemd/issues/22737
2022-05-20 15:49:46 Bug Watch Updater dbus: status Unknown New