notify-manager: intermittent test failure
This test does fail sometimes a few times in a row, then succeeds a few times in a row and generally seems quite slippery!
This is running on Debian Bookworm under Sway (I'm mentioning this because I saw other test failures running GNOME shell).
Tests have been run with ninja -C _build test
, meson test -C _build test
and meson test -C _build --print-errorlogs
, sometimes it failed, sometimes it didn't (possibly the test is very timing sensitive?)
36/36 phosh:integration / notify-manager TIMEOUT 30.01s killed by signal 5 SIGTRAP
>>> MALLOC_PERTURB_=197 GSETTINGS_SCHEMA_DIR=/home/fortysixandtwo/git/phosh/_build/data G_TEST_BUILDDIR=/home/fortysixandtwo/git/phosh/_build/tests GSETTINGS_BACKEND=memory MALLOC_CHECK_=2 G_TEST_SRCDIR=/home/fortysixandtwo/git/phosh/tests G_DEBUG=gc-friendly,fatal-warnings NO_AT_BRIDGE=1 XDG_RUNTIME_DIR=/home/fortysixandtwo/git/phosh/_build/tests PYTHONDONTWRITEBYTECODE=yes /home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager
――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――― ✀ ―――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――
stdout:
# random seed: R02S3e3079bd6ae7ef40e874705d8d4079d7
1..3
# Start of phosh tests
# Start of dbus tests
# Start of notify-manager tests
# GLib-DEBUG: setenv()/putenv() are not thread-safe and should not be used after threads are created
# Spawned compositor phoc with pid 20520
# Found wayland socket wayland-0
# GLib-DEBUG: setenv()/putenv() are not thread-safe and should not be used after threads are created
# GLib-GIO-DEBUG: _g_io_module_get_default: Found default implementation memory (GMemorySettingsBackend) for ?gsettings-backend?
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GVFS-DEBUG: org.gtk.vfs.MountTracker.listMountableInfo call failed: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gtk.vfs.Daemon was not provided by any .service files (g-dbus-error-quark, 2)
#
# GLib-GIO-DEBUG: _g_io_module_get_default: Found default implementation local (GLocalVfs) for ‘gio-vfs’
# Gcr-DEBUG: registering prompter
# GnomeDesktop-DEBUG: clock_format: 24h
# GnomeDesktop-DEBUG: show_weekday: FALSE
# GnomeDesktop-DEBUG: show_full_date: TRUE
# GnomeDesktop-DEBUG: show_seconds: FALSE
# GnomeDesktop-DEBUG: format_string: %b %-e_%R
# GnomeDesktop-DEBUG: no_enspace: %b %-e_%R
# GnomeDesktop-DEBUG: replaced_format: Nov 26_17:03
# GnomeDesktop-DEBUG: is_utf8: TRUE
# GnomeDesktop-DEBUG: ret: Nov 26 17∶03
# GVFS-RemoteVolumeMonitor-DEBUG: Error: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gtk.vfs.Daemon was not provided by any .service files
#
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# phosh-session-manager-WARNING: Failed to register client: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.SessionManager was not provided by any .service files
(/home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager:20500): phosh-notify-manager-DEBUG: 17:03:40.187: Acquired name org.freedesktop.Notifications
(/home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager:20500): phosh-notify-manager-DEBUG: 17:03:40.447: DBus call GetCapabilities
# Gcr-DEBUG: unregistering prompter
# Gcr-DEBUG: disposing prompter
# Gcr-DEBUG: finalizing prompter
# phosh-torch-manager-DEBUG: Failed to get login1 session proxy: Operation was cancelled
# phosh-mode-manager-DEBUG: Failed to get hostname1 proxy: Operation was cancelled
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
ok 1 /phosh/dbus/notify-manager/caps
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: unsetenv() is not thread-safe and should not be used after threads are created
# GLib-DEBUG: setenv()/putenv() are not thread-safe and should not be used after threads are created
# GLib-DEBUG: setenv()/putenv() are not thread-safe and should not be used after threads are created
# GLib-DEBUG: setenv()/putenv() are not thread-safe and should not be used after threads are created
# GLib-DEBUG: setenv()/putenv() are not thread-safe and should not be used after threads are created
# GLib-DEBUG: setenv()/putenv() are not thread-safe and should not be used after threads are created
# Spawned compositor phoc with pid 20942
Bail out! phosh-wifimanager-FATAL-CRITICAL: secret_agent_register_cb: assertion 'PHOSH_IS_WIFI_MANAGER (self)' failed
stderr:
invoking IsSupported() failed for remote volume monitor with dbus name org.gtk.vfs.UDisks2VolumeMonitor:: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gtk.vfs.UDisks2VolumeMonitor was not provided by any .service files (g-dbus-error-quark, 2)
invoking IsSupported() failed for remote volume monitor with dbus name org.gtk.vfs.GoaVolumeMonitor:: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gtk.vfs.GoaVolumeMonitor was not provided by any .service files (g-dbus-error-quark, 2)
invoking IsSupported() failed for remote volume monitor with dbus name org.gtk.vfs.AfcVolumeMonitor:: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gtk.vfs.AfcVolumeMonitor was not provided by any .service files (g-dbus-error-quark, 2)
invoking IsSupported() failed for remote volume monitor with dbus name org.gtk.vfs.GPhoto2VolumeMonitor:: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gtk.vfs.GPhoto2VolumeMonitor was not provided by any .service files (g-dbus-error-quark, 2)
invoking IsSupported() failed for remote volume monitor with dbus name org.gtk.vfs.MTPVolumeMonitor:: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gtk.vfs.MTPVolumeMonitor was not provided by any .service files (g-dbus-error-quark, 2)
(/home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager:20500): phosh-session-manager-WARNING **: 17:03:40.187: Failed to register client: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.SessionManager was not provided by any .service files
(/home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager:20500): phosh-wifimanager-CRITICAL **: 17:03:40.515: secret_agent_register_cb: assertion 'PHOSH_IS_WIFI_MANAGER (self)' failed
――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――
Summary of Failures:
36/36 phosh:integration / notify-manager TIMEOUT 30.01s killed by signal 5 SIGTRAP
If I disable the wifi interface the tests do pass, reenabling them and it fails again.
Trying to debug the test with gdb
by running meson test -C _build --gdb
does not yield valuable information:
31/36 phosh:integration / notify-manager RUNNING
>>> GSETTINGS_BACKEND=memory MALLOC_CHECK_=2 PYTHONDONTWRITEBYTECODE=yes MALLOC_PERTURB_=55 G_TEST_BUILDDIR=/home/fortysixandtwo/git/phosh/_build/tests G_DEBUG=gc-friendly,fatal-warnings G_TEST_SRCDIR=/home/fortysixandtwo/git/phosh/tests GSETTINGS_SCHEMA_DIR=/home/fortysixandtwo/git/phosh/_build/data NO_AT_BRIDGE=1 XDG_RUNTIME_DIR=/home/fortysixandtwo/git/phosh/_build/tests gdb --quiet --nh --args /home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager
――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――― ✀ ―――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――――
Reading symbols from /home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager...
(gdb) r
Starting program: /home/fortysixandtwo/git/phosh/_build/tests/test-notify-manager
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
# random seed: R02Sf10fe22a408e3a9a5f67b949950bf5ad
1..3
# Start of phosh tests
# Start of dbus tests
# Start of notify-manager tests
[Detaching after vfork from child process 32380] #### mhmmm
Program terminated with signal SIGTRAP, Trace/breakpoint trap.
The program no longer exists.
(gdb)
Grabbing a coredump:
(gdb) bt full
#0 0x00007facaebf647a in g_logv () at /lib/x86_64-linux-gnu/libglib-2.0.so.0
#1 0x00007facaebf672f in g_log () at /lib/x86_64-linux-gnu/libglib-2.0.so.0
#2 0x0000555a8de5450a in secret_agent_register_cb (object=0x555a8f8b53d0, result=0x555a8f3d5560, user_data=0x555a8f569070) at ../src/wifimanager.c:555
self = 0x555a8f569070
agent = <optimized out>
error = 0x0
__func__ = "secret_agent_register_cb"
#3 0x00007facaeddc389 in () at /lib/x86_64-linux-gnu/libgio-2.0.so.0
#4 0x00007facaeddc3c9 in () at /lib/x86_64-linux-gnu/libgio-2.0.so.0
#5 0x00007facaebeeb84 in g_main_context_dispatch () at /lib/x86_64-linux-gnu/libglib-2.0.so.0
#6 0x00007facaebeef28 in () at /lib/x86_64-linux-gnu/libglib-2.0.so.0
#7 0x00007facaebef213 in g_main_loop_run () at /lib/x86_64-linux-gnu/libglib-2.0.so.0
#8 0x0000555a8de76738 in phosh_test_compositor_new () at ../tests/testlib.c:212
err = 0x0
argv = 0x555a8f4da4e0
run_arg = 0x0
channel = 0x555a8f329800
mainloop = 0x555a8f96bbe0
state = 0x555a8f454e30
flags = <optimized out>
comp = <optimized out>
ret = <optimized out>
outfd = 8
watch = {socket = 0x0, loop = 0x555a8f96bbe0}
id = 323
__func__ = "phosh_test_compositor_new"
#9 0x0000555a8de75aee in phosh_test_full_shell_thread (data=0x555a8f9cadc0) at ../tests/testlib-full-shell.c:45
shell = <optimized out>
flags = <optimized out>
fixture = 0x555a8f9cadc0
__func__ = "phosh_test_full_shell_thread"
#10 0x00007facaec18ecd in () at /lib/x86_64-linux-gnu/libglib-2.0.so.0
#11 0x00007facae5aeeae in start_thread (arg=0x7facaa5d6640) at pthread_create.c:463
ret = <optimized out>
pd = 0x7facaa5d6640
unwind_buf = {cancel_jmp_buf = {{jmp_buf = {140379569350208, 6316543721948428528, 140736559089022, 140736559089023, 0, 140379569350208, -6273079188883392272, -6273087972426532624}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
not_first_call = 0
#12 0x00007facae4dea5f in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
It seems I cannot reliably reproduce this though