Question

6

snapd-desktop-integration syslog spam

rated 0 times [ 6] [ 0] / answers: 1 / hits: 5994 / 2 Years ago, fri, august 12, 2022, 2:45:52

For the past three days we are getting log spammed with these messages every few seconds from almost all of our machines:

2 11:13:59 11:13:59 ZT1 user.5 snapd-desktop-i[2823704]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:00 11:14:00 ZT1 daemon.5 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:00 11:14:00 ZT1 daemon.4 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:01 11:14:01 PATG daemon.5 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:01 11:14:01 PATG daemon.4 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:01 11:14:01 E450 user.5 snapd-desktop-i[397538]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:02 11:14:02 ZT1 user.5 snapd-desktop-i[2823808]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:02 11:14:02 ZT1 daemon.5 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:02 11:14:02 ZT1 daemon.4 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:03 11:14:03 PATG daemon.5 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:03 11:14:03 PATG daemon.4 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:03 11:14:03 E450 user.5 snapd-desktop-i[397617]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:04 11:14:04 ZT1 user.5 snapd-desktop-i[2823937]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:05 11:14:05 ZT1 daemon.5 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:05 11:14:05 ZT1 daemon.4 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:05 11:14:05 PATG daemon.5 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:05 11:14:05 PATG daemon.4 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:06 11:14:06 E450 user.5 snapd-desktop-i[397694]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:06 11:14:06 ZT1 user.5 snapd-desktop-i[2824038]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:07 11:14:07 ZT1 daemon.5 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:07 11:14:07 ZT1 daemon.4 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:08 11:14:08 PATG daemon.4 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:08 11:14:08 E450 user.5 snapd-desktop-i[397779]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:08 11:14:08 ZT1 user.5 snapd-desktop-i[2824167]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:09 11:14:09 ZT1 daemon.5 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:09 11:14:09 ZT1 daemon.4 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:10 11:14:10 PATG daemon.5 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:10 11:14:10 PATG daemon.4 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:10 11:14:10 E450 user.5 snapd-desktop-i[397847]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:11 11:14:11 ZT1 user.5 snapd-desktop-i[2824261]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:11 11:14:11 ZT1 daemon.5 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:11 11:14:11 ZT1 daemon.4 systemd[1207]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:12 11:14:12 PATG daemon.5 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

2 11:14:12 11:14:12 PATG daemon.4 systemd[5140]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

2 11:14:12 11:14:12 E450 user.5 snapd-desktop-i[397915]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

2 11:14:13 11:14:13 ZT1 user.5 snapd-desktop-i[2824373]:  Not loading module "atk-bridge": The functionality is provided by GTK natively. Please try to not load it.

The only updates that we've applied in the time period that these messages started were for passwd and login, so we backed them out:

====================================================================



Aptitude 0.8.13: log report

Fri, Dec  2 2022 11:56:27 -0800



  IMPORTANT: this log only lists intended actions; actions which fail

  due to dpkg problems may not be completed.



Will install 1 packages, and remove 0 packages.

========================================

[DOWNGRADE] login:amd64 1:4.8.1-2ubuntu2.1 -> 1:4.8.1-2ubuntu2

========================================



Log complete.



=======================================================================



Aptitude 0.8.13: log report

Fri, Dec  2 2022 12:03:00 -0800



  IMPORTANT: this log only lists intended actions; actions which fail

  due to dpkg problems may not be completed.



Will install 1 packages, and remove 0 packages.

4096 B of disk space will be freed

========================================

[HOLD, DEPENDENCIES] login:amd64 1:4.8.1-2ubuntu2

[DOWNGRADE] passwd:amd64 1:4.8.1-2ubuntu2.1 -> 1:4.8.1-2ubuntu2

========================================



Log complete.



======================================================================

But it made no difference.

We also see repetitive messages like this:



 2 12:39:17 12:39:16 E450 daemon.5 systemd[1022]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Main process exited, code=exited, status=1/FAILURE

 2 12:39:17 12:39:16 E450 daemon.4 systemd[1022]:  snap.snapd-desktop-integration.snapd-desktop-integration.service: Failed with result 'exit-code'.

So we're guessing it's possibly something that snapd changed or updated.

It's happening to another user as well:

snapd-desktop-integration flooding syslog

Our systems are all running Ubuntu 22.04.

Would greatly appreciate any hints as to where to look to solve this.

EDIT: See Dan Christensen's answer below for a useful bypass to this problem.

EDIT 2 March 2023: Stable version 2023-02-21 (57) appears to have eliminated the repetitive syslog messages and solved the problem. (Please see my answer below.)

Answers

Only authorized users can answer the question. Please sign in first, or register a free account.

memorrappin

Add To Favorites

Follow

Total Points: 325

Total Questions: 122

Total Answers: 100

Location: Armenia

Member since Sat, Sep 12, 2020

4 Years ago

memorrappin questions

1 How to replace cat with bat system-wide Ubuntu 22.04

Tue, Aug 23, 22, 13:34, 2 Years ago

1 Filtering content of command with grep

Thu, Jan 12, 23, 01:52, 1 Year ago

1 Poetry installation fails on Ubuntu

Fri, Sep 9, 22, 05:27, 2 Years ago

1 Remove a specific snap package

Sun, Apr 3, 22, 16:14, 2 Years ago

1 How do I get Nvidia graphics working with kernel 5.10 on Ubuntu 20.10?

Mon, Jan 24, 22, 16:48, 2 Years ago

View All

answered 2 Years ago horicgly · Accepted Answer

EDIT 28 February 2023: Stable version 2023-02-21 (57) appears to have eliminated the repetitive syslog messages. (Please see all the comments under Sergio's answer.)

Here is the repaired version info:

~$ snap info snapd-desktop-integration

name:      snapd-desktop-integration

summary:   Desktop Integration for snapd

publisher: Canonical✓

store-url: https://snapcraft.io/snapd-desktop-integration

contact:   https://github.com/snapcore/snapd-desktop-integration

license:   unset

description: |

Provides a user session daemon used to provide a bridge between the user's session and snapd. 

Used for things like automatic theme installation.

services:

snapd-desktop-integration: simple, enabled, inactive

snap-id:      IrwRHakqtzhFRHJOOPxKVPU0Kk7Erhcu

tracking:     latest/stable

refresh-date: today at 15:17 PST

channels:

latest/stable:    0.1 2023-02-21 (57) 438kB -

latest/candidate: 0.1 2023-02-23 (59) 442kB -

latest/beta:      ↑                         

latest/edge:      0.1 2023-02-23 (59) 442kB -

installed:          0.1            (57) 438kB -`

EDIT 21 January 2023: candidate version 57 produces these repetitive syslog messages when we installed it after ssh'ing to a test system:

21 10:11:52 10:11:52 ZT1 kern.5 kernel: [261316.069573] audit: type=1107 audit(1674324712.162:358): pid=830 uid=106 auid=4294967295 ses=4294967295 subj=unconfined msg='apparmor="DENIED" operation="dbus_method_call" bus="system" path="/org/freedesktop/login1" interface="org.freedesktop.DBus.Properties" member="GetAll" mask="send" name=":1.3" pid=1145400 label="snap.snapd-desktop-integration.snapd-desktop-integration" peer_pid=881 peer_label="unconfined"

21 10:11:52 10:11:52 ZT1 kern.5 kernel: [261316.069573] exe="/usr/bin/dbus-daemon" sauid=106 hostname=? addr=? terminal=?'

21 10:11:52 10:11:52 ZT1 kern.5 kernel: [261316.069831] audit: type=1107 audit(1674324712.162:359): pid=830 uid=106 auid=4294967295 ses=4294967295 subj=unconfined msg='apparmor="DENIED" operation="dbus_method_call" bus="system" path="/org/freedesktop/login1" interface="org.freedesktop.login1.Manager" member="ListSessions" mask="send" name=":1.3" pid=1145400 label="snap.snapd-desktop-integration.snapd-desktop-integration" peer_pid=881 peer_label="unconfined"

21 10:11:52 10:11:52 ZT1 kern.5 kernel: [261316.069831] exe="/usr/bin/dbus-daemon" sauid=106 hostname=? addr=? terminal=?'

21 10:11:54 10:11:54 ZT1 user.5 snapd-desktop-i[1145502]: Failed to do gtk init. Waiting for a new session with desktop capabilities.

21 10:11:54 10:11:54 ZT1 kern.5 kernel: [261318.318431] audit: type=1326 audit(1674324714.410:360): auid=1001 uid=1001 gid=1001 ses=152 subj=snap.snapd-desktop-integration.snapd-desktop-integration pid=1145502 comm="snapd-desktop-i" exe="/snap/snapd-desktop-integration/57/usr/bin/snapd-desktop-integration" sig=0 arch=c000003e syscall=314 compat=0 ip=0x7fb4631a6a3d code=0x50000

21 10:11:54 10:11:54 ZT1 user.5 snapd-desktop-i[1145502]: Failed to get session list (check that login-session-observe interface is connected). Forcing a reload.

21 10:11:54 10:11:54 ZT1 kern.5 kernel: [261318.321048] audit: type=1107 audit(1674324714.410:361): pid=830 uid=106 auid=4294967295 ses=4294967295 subj=unconfined msg='apparmor="DENIED" operation="dbus_method_call" bus="system" path="/org/freedesktop/login1" interface="org.freedesktop.DBus.Properties" member="GetAll" mask="send" name=":1.3" pid=1145502 label="snap.snapd-desktop-integration.snapd-desktop-integration" peer_pid=881 peer_label="unconfined"

21 10:11:54 10:11:54 ZT1 kern.5 kernel: [261318.321048] exe="/usr/bin/dbus-daemon" sauid=106 hostname=? addr=? terminal=?'

21 10:11:54 10:11:54 ZT1 user.5 snapd-desktop-i[1145502]: Loop exited. Forcing reload.

EDIT 3 January 2023: if you are testing candidate version 55 you can stop the repetitive messages by running:

sudo snap connect snapd-desktop-integration:login-session-observe

Please see Sergio's comment below. The goal is to eliminate the need for this step and make it autoconnect.

EDIT 17 December 2022: we tested candidate version 55 on two machines to which we were ssh'd. It fixed the atk-bridge messages, but caused a different set of messages every few seconds:

17 10:42:52 10:42:52 PATG user.5 snapd-desktop-i[53867]: Failed to get session list (check that login-session-observe interface is connected). Forcing a reload.

17 10:42:52 10:42:52 PATG user.5 snapd-desktop-i[53867]: Loop exited. Forcing reload.

17 10:42:52 10:42:52 PATG kern.5 kernel: [246586.108424] audit: type=1107 audit(1671302572.982:370): pid=1182 uid=102 auid=4294967295 ses=4294967295 subj=unconfined msg='apparmor="DENIED" operation="dbus_method_call" bus="system" path="/org/freedesktop/login1" interface="org.freedesktop.DBus.Properties" memb er="GetAll" mask="send" name=":1.11" pid=53867 label="snap.snapd-desktop-integration.snapd-desktop-integration" peer_pid=1280 peer_label="unconfined"

17 10:42:52 10:42:52 PATG kern.5 kernel: [246586.108424] exe="/usr/bin/dbus-daemon" sauid=102 hostname=? addr=? terminal=?'

17 10:42:52 10:42:52 PATG kern.5 kernel: [246586.108847] audit: type=1107 audit(1671302572.982:371): pid=1182 uid=102 auid=4294967295 ses=4294967295 subj=unconfined msg='apparmor="DENIED" operation="dbus_method_call" bus="system" path="/org/freedesktop/login1" interface="org.freedesktop.login1.Manager" membe r="ListSessions" mask="send" name=":1.11" pid=53867 label="snap.snapd-desktop-integration.snapd-desktop-integration" peer_pid=1280 peer_label="unconfined"

17 10:42:52 10:42:52 PATG kern.5 kernel: [246586.108847] exe="/usr/bin/dbus-daemon" sauid=102 hostname=? addr=? terminal=?'

17 10:42:55 10:42:55 PATG user.5 snapd-desktop-i[53945]: Failed to do gtk init. Waiting for a new session with desktop capabilities.

17 10:42:55 10:42:55 PATG kern.5 kernel: [246588.351735] audit: type=1326 audit(1671302575.223:372): auid=1000 uid=1000 gid=1000 ses=10 subj=snap.snapd-desktop-integration.snapd-desktop-integration pid=53945 comm="snapd-desktop-i" exe="/snap/snapd-desktop-integration/55/usr/bin/snapd-desktop-integration" sig= 0 arch=c000003e syscall=314 compat=0 ip=0x7f0aba0cda3d code=0x50000

17 10:42:55 10:42:55 PATG kern.5 kernel: [246588.355602] audit: type=1107 audit(1671302575.227:373): pid=1182 uid=102 auid=4294967295 ses=4294967295 subj=unconfined msg='apparmor="DENIED" operation="dbus_method_call" bus="system" path="/org/freedesktop/login1" interface="org.freedesktop.DBus.Properties" memb er="GetAll" mask="send" name=":1.11" pid=53945 label="snap.snapd-desktop-integration.snapd-desktop-integration" peer_pid=1280 peer_label="unconfined"

17 10:42:55 10:42:55 PATG kern.5 kernel: [246588.355602] exe="/usr/bin/dbus-daemon" sauid=102 hostname=? addr=? terminal=?'

The sequence repeated every few seconds until we uninstalled the package. (Both machines had users logged into to graphical sessions at the time we did the test, if that matters.)

EDIT 12 December 2022: candidate version 49 did not fix the repetitive "atk-bridge" messages that occur when you ssh to a machine that has snapd-desktop-integration installed, though it may fix the messages from the GDM session:

https://github.com/snapcore/snapd-desktop-integration/pull/41#issuecomment-1344603344

EDIT 9 December 2022: Here is the result of testing candidate version 49:

https://github.com/snapcore/snapd-desktop-integration/pull/41#issuecomment-1344589269

EDIT 7 December 2022: Here is the commit:

https://github.com/sergio-costas/snapd-desktop-integration/commit/a5652377cc5c8f20ea311a0dd28d44a63c4551c2

EDIT 6 December 2022: Here is the pull request:

https://github.com/snapcore/snapd-desktop-integration/pull/41

The recommendation per the package authors is:

...follow the pull request, when that gets merged it will be published to the candidate channel within a couple of hours automatically.

They also add:

It's a rather complicated fix, that is a bit risky so it will take a couple days to get properly reviewed. But once it's thoroughly reviewed, we'll get going in the testing process right away.

EDIT 4 December 2022: I emailed one of the package authors. They have someone working on the issue and are hopeful they'll have a fix this week.

====

The problem must have been caused by a faulty snap upgrade sometime around 29 November 2022.

Unfortunately the information in snap changes is already overwritten.

The repetitive messages stopped on all of our machines at about 2100 GMT on 2 December 2022 but they restarted again today (3 December).

We noticed that the "atk-bridge...please try to not load it" messages start again as soon as we ssh to any of the machines.

We used htop in user tree view to kill off tasks until we could see that it was "systemd --user" repeatedly launching atk-bridge. If we kill that systemd task, atk-bridge stops respawning and the atk-bridge syslog messages stop (but not the other ones).

In the meantime, we applied Dan Christensen's bypass (which also gets rid of the atk-bridge messages) so no need to kill off any tasks after ssh'ing.