#1072570 gnome-shell: Gnome 43.9 Wayland: UI freezes in various apps, e.g. ~3mins when starting Totem

Package:
gnome-shell
Source:
gnome-shell
Description:
graphical shell for the GNOME desktop
Submitter:
David Balch
Date:
2024-06-04 13:48:04 UTC
Severity:
normal
#1072570#5
Date:
2024-06-04 13:44:08 UTC
From:
To:
Dear Maintainer,

I keep on getting UI freezes in Gnome Wayland, where the UI won't respond for between a few seconds and a few minutes.

Possibly related: https://gitlab.gnome.org/GNOME/gnome-shell/-/issues/5453

System details:

- Dell Inc. OptiPlex 7040
- Intel® Core™ i5-6500 (four-core)
- Mesa Intel® HD Graphics 530 (SKL GT2)
- 16.0 GiB RAM
- PM951 NVMe SAMSUNG 256GB SSD
- WDC WD20EZRX-19DC0B0 2TB HDD
- "High speed with ethernet" HDMI cable (presumably 1.4)

- Debian 12 (64-bit)
- Gnome 43.9
- Extensions disabled (using the master switch in _Extensions_)
- Video problem apparent when testing with 1280x720@60 1920x1080@60 and 3840x2160@30 -
  although with lower resolutions, the periodic UI updates are more frequent,
  e.g. every 10s (rather than 30s when using 3840x2160).



   * What led up to the situation?

Just regular desktop use.

   * What exactly did you do (or not do) that was effective (or
     ineffective)?

I've noticed clear stalls in FreeCAD, but they're more noticeable in _Videos_ (AKA _Totem_),
so I've done the most testing with _Videos_:



   * What was the outcome of this action?

Using _Files_ to open a SD H.264 .mkv video with _Videos_:



   * What was the outcome of this action?

- UI stops responding (no screen updates)
- _Videos_ Window opens
- After a couple of seconds, the video's sound plays
- Sometimes, the "_Files_ is not responding" dialog appears
- Periodically the UI updates, showing an updated video frame and new mouse position (so mouse input is working)
- If I have pressed the Super key and there's a UI update the Activities overview will appear (so keyboard input is working)
- After approx 2-3 minutes, the video plays normally, and the UI starts responding.

Some videos in other formats (e.g. MPEG4 .avis) trigger the same problem, but only for ~5 seconds.

Playing the same files with VLC works immediately, with no freezing.
Playing the same files with Totem in Gnome xorg works immediately, with no freezing.


I know it's not the most powerful system but, once it's going, it can play the video fullscreen with
no freezes or frame drops that I've noticed.



   * What outcome did you expect instead?

UI does not freeze, respondint to input, with Totem playing the video immediately.



What I've tried to identify the problem...


As the screen is not updating, _System Monitor_ doesn't give me any indication of CPU spikes.
Checking the log from running _atop_ (writing to file) shows no obvious resource shortages,
with _totem_ using 49% CPU at peak. _gnome-shell_ makes an appearance in the last ~20 seconds with 7% and 10% CPU.

Using the CLI: `totem vid.mkv` gives the same results, with the following messages repeated
over-and-over in the terminal: (seemingly as long as the video is playing, so I guess it's not related):

```
(totem:20105): Gdk-CRITICAL **: 17:35:04.926: gdk_window_get_origin: assertion 'GDK_IS_WINDOW (window)' failed
(totem:20105): Gdk-CRITICAL **: 17:35:04.926: gdk_window_get_toplevel: assertion 'GDK_IS_WINDOW (window)' failed
(totem:20105): Gdk-CRITICAL **: 17:35:04.926: gdk_window_get_origin: assertion 'GDK_IS_WINDOW (window)' failed
```

Having set up [FPS logging](https://her01n.com/2022/01/14/show-fps-in-gnome/), _journalctl_ shows
FPS dropping below 1fps in apparent connection with the error `timeout from dbind`.

Relevant part of _journalctl_ log when starting video:

````
Jun 02 17:32:30 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 1.0s: 30.13 FPS, average: 2.4ms, peak: 13.4ms
Jun 02 17:32:31 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 1.0s: 28.79 FPS, average: 2.4ms, peak: 3.7ms
Jun 02 17:32:33 Optiplex gnome-shell[17165]: Failed to read extents of text caret: Failed to validate parent window: GLib.Error atspi_error: timeout from dbind
Jun 02 17:32:34 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 2.4s: 9.84 FPS, average: 1.6ms, peak: 12.5ms
Jun 02 17:32:34 Optiplex gnome-shell[17165]: Failed to read extents of focused component: Failed to validate parent window: GLib.Error atspi_error: timeout from dbind
Jun 02 17:32:35 Optiplex gnome-shell[17165]: Failed to read extents of text caret: Failed to validate parent window: GLib.Error atspi_error: timeout from dbind
Jun 02 17:32:47 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 13.1s: 0.31 FPS, average: 7.3ms, peak: 22.7ms
Jun 02 17:32:47 Optiplex gnome-shell[17165]: Failed to read extents of text caret: Failed to validate parent window: GLib.Error atspi_error: timeout from dbind
Jun 02 17:32:48 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:49 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:50 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:51 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:52 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:53 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:54 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:55 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:56 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:57 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:58 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:32:59 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:00 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:01 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:02 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:03 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:04 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:05 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:06 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:07 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:08 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:09 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:10 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:11 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:12 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:13 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:14 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:15 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:16 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:17 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:18 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:19 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:20 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:21 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:22 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:23 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:24 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:25 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:26 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:27 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:28 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:29 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:30 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:31 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:32 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:33 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:34 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:35 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:36 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout showsfrom dbind
Jun 02 17:33:37 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:38 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:39 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:40 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:41 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:42 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:43 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:44 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:45 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:46 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:47 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:48 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:49 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:50 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:51 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:52 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:53 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:54 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:56 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:33:58 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:00 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:01 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:03 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:04 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:05 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:06 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:07 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 79.9s: 0.04 FPS, average: 13.7ms, peak: 25.4ms
Jun 02 17:34:07 Optiplex gnome-shell[17165]: Failed to read extents of focused component: timeout from dbind
Jun 02 17:34:08 Optiplex PackageKit[19038]: daemon quit
Jun 02 17:34:08 Optiplex systemd[1]: packagekit.service: Deactivated successfully.
Jun 02 17:34:09 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:10 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:11 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:12 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:13 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:14 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:15 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:16 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:17 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:18 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:19 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:20 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:21 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:22 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:23 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:24 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:25 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:26 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:27 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:28 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:29 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:30 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:31 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:32 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:33 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:34 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:35 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:36 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:37 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:38 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:39 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:40 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:41 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:42 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:43 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:44 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:45 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:46 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:47 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:48 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:49 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:50 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:51 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:51 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 44.7s: 0.13 FPS, average: 6.4ms, peak: 11.8ms
Jun 02 17:34:53 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:54 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:55 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:56 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:57 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:58 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:34:59 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:35:00 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:35:01 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:35:02 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:35:03 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:35:03 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 11.3s: 0.35 FPS, average: 7.5ms, peak: 12.2ms
Jun 02 17:35:04 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 1.0s: 29.26 FPS, average: 4.6ms, peak: 21.6ms
Jun 02 17:35:04 Optiplex gnome-shell[17165]: Failed to read extents of text caret: timeout from dbind
Jun 02 17:35:05 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 1.0s: 14.99 FPS, average: 7.5ms, peak: 20.6ms
Jun 02 17:35:06 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 1.0s: 28.82 FPS, average: 2.7ms, peak: 4.6ms
Jun 02 17:35:07 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 1.0s: 29.42 FPS, average: 3.6ms, peak: 18.2ms
Jun 02 17:35:08 Optiplex gnome-shell[17165]: *** HDMI-1 frame timings over 1.1s: 28.56 FPS, average: 3.7ms, peak: 18.9ms
````