GLib-IO‌-CRITICAL‌ assertion failure log spam

[Siphalor]

 * csd version: 5.4.5+vanessa
 * Distribution: Linux Mint 21
 * Graphics hardware *and* driver used: see below
 * 64 bit

Detailed system information

``` System: Kernel: 5.15.0-46-generic x86_64 bits: 64 compiler: gcc v: 11.2.0 Desktop: Cinnamon 5.4.11 tk: GTK 3.24.33 wm: Mutter dm: LightDM Distro: Linux Mint 21 Vanessa base: Ubuntu 22.04 jammy Machine: Type: Laptop System: LENOVO product: 20LAS01H00 v: ThinkPad T580 serial: Chassis: type: 10 serial: Mobo: LENOVO model: 20LAS01H00 serial: UEFI: LENOVO v: N27ET46W (1.32 ) date: 05/18/2022 CPU: Info: quad core model: Intel Core i7-8550U bits: 64 type: MT MCP arch: Coffee Lake rev: A cache: L1: 256 KiB L2: 1024 KiB L3: 8 MiB Speed (MHz): avg: 797 high: 800 min/max: 400/4000 cores: 1: 800 2: 792 3: 800 4: 800 5: 795 6: 793 7: 799 8: 800 bogomips: 31999 Flags: avx avx2 ht lm nx pae sse sse2 sse3 sse4_1 sse4_2 ssse3 vmx Graphics: Device-1: Intel UHD Graphics 620 vendor: Lenovo driver: i915 v: kernel ports: active: HDMI-A-2,eDP-1 empty: DP-1,DP-2,HDMI-A-1 bus-ID: 00:02.0 chip-ID: 8086:5917 Device-2: NVIDIA GP108M [GeForce MX150] vendor: Lenovo driver: N/A pcie: speed: 8 GT/s lanes: 4 bus-ID: 02:00.0 chip-ID: 10de:1d10 Device-3: IMC Networks Integrated Camera type: USB driver: uvcvideo bus-ID: 1-8:5 chip-ID: 13d3:56a6 Display: x11 server: X.Org v: 1.21.1.3 driver: X: loaded: modesetting unloaded: vesa alternate: fbdev gpu: i915 display-ID: :0 screens: 1 Screen-1: 0 s-res: 3840x1080 s-dpi: 96 Monitor-1: HDMI-2 mapped: HDMI-A-2 pos: right model: Samsung res: 1920x1080 dpi: 305 diag: 551mm (21.7") Monitor-2: eDP-1 pos: primary,left model: BOE Display res: 1920x1080 dpi: 141 diag: 396mm (15.6") OpenGL: renderer: Mesa Intel UHD Graphics 620 (KBL GT2) v: 4.6 Mesa 22.0.5 direct render: Yes Drives: Local Storage: total: 953.88 GiB used: 721.78 GiB (75.7%) ID-1: /dev/nvme0n1 vendor: Western Digital model: PC SN520 SDAPMUW-512G size: 476.94 GiB speed: 15.8 Gb/s lanes: 2 serial: temp: 39.9 C ID-2: /dev/nvme1n1 vendor: Samsung model: MZVLB512HAJQ-000L7 size: 476.94 GiB speed: 31.6 Gb/s lanes: 4 serial: temp: 28.9 C Partition: ID-1: / size: 194.94 GiB used: 177.42 GiB (91.0%) fs: ext4 dev: /dev/nvme1n1p7 ID-2: /boot/efi size: 95 MiB used: 39.3 MiB (41.4%) fs: vfat dev: /dev/nvme1n1p2 Swap: ID-1: swap-1 type: file size: 7.45 GiB used: 1.62 GiB (21.7%) priority: -2 file: /swapfile Info: Processes: 381 Uptime: 21h 49m Memory: 15.49 GiB used: 6.13 GiB (39.6%) Init: systemd v: 249 runlevel: 5 Compilers: gcc: 11.2.0 alt: 11/9 clang: 14.0.0-1ubuntu1 Client: Cinnamon v: 5.4.11 inxi: 3.3.13 ```

Issue

I am not quite sure if this is directly related to cinnamon-settings-daemon since some other sources also seem to be triggering the lines, but linuxmint/cinnamon#11086 directed me here :) Also, most of the log spam stems from cinnamon-settings-daemon, so it is at least mildly related.

I am getting the following line spammed in my ~/.xsession-errors:

(csd-power:2327): GLib-GIO-CRITICAL **: 11:25:47.707: g_dbus_proxy_get_object_path: assertion 'G_IS_DBUS_PROXY (proxy)' failed

Log from the startup to the first few occurrences: https://hastebin.com/jabexarebe.yaml These lines get continuously printed, as of writing the current session error log is about 220k lines long.

Steps to reproduce

I have not a single clue.

Expected behaviour

Not getting these error logs.

Other information

I recently updated to Linux Mint 21 from a 20.3 installation. I can't tell though if this issue was already present on 20.3 as I only really noticed it during examination of linuxmint/cinnamon#11086.

[mtwebster]

Please run:

killall csd-power
killall csd-power (it auto-restarts)
.. until you get 'csd-power: no process found'

Then,

csd-power --verbose

Paste the output from that (up to where it starts spitting out those warnings).

Thanks.

[Siphalor]

This is what it prints (then it loops): https://hastebin.com/wasakafovi.yaml

[mtwebster]

Can you also paste the output to:

ps auxf

[Siphalor]

While trying to reduce the amount of running programs for ps, I noticed that after exiting Steam the logs abruptly stopped. After starting Steam again, they started again - so there's clearly a correlation.

Anyway, here's the process list with steam running: https://paste.siphalor.de/?a285c4e61535ae46#BZsVAsvdgjibyHd69JbddppMNChereUCDqwEWxE8cV7L

[Siphalor]

Ok, I might have found the actual correlation:

Whenever power management is inhibited, this bug begins to occur. Since Steam just generally inhibits power management, it also causes this bug while it's running.

I still think that this bug actually sits deeper than cinnamon-settings-daemon and these are just the symptoms.

---

Edit:‌ While I was pretty confident about this guess, the logs just proved me wrong - apparently it also happens when power management is not inhibited. I think I got tricked by some noise in the data and the fact that refreshing seems to be a lot slower if power management is not inhibited.

[Siphalor]

Hey, I just want to come back to this to share the current state:

I'm still experiencing these issues. Without Steam running, this gets logged occasionally (I‌ think every few minutes a single line). As soon as I‌ start Steam the rate increases to 2 lines per second and only slows down after stopping it again.

I don't really think anymore, that power management is involved in this too much. This seems to happen generally, Steam is the only correlation I can make out.