Bug 132262 – [GLIB] http/tests/media/video-redirect.html is flaky timing out and crashing on Wayland

• Component: WebCore Misc.
• Status: REOPENED

[Xabier Rodríguez Calvar]

http/tests/media/video-redirect.html [ Timeout Pass ]

[Lauro Moura]

As of ~r280524:

GTK-Release - Still sparsely timing out
GTK-Debug - No error
GTK-Wayland - Flaky timeout/crashes since forever

WPE-Release - Flaky crashing since r276255 (first crash)
WPE-Debug - No error

I couldn't reproduce the crashes locally, both with WPE and GTK-Wayland.

Sample traces in the next comments

[Lauro Moura]

Created attachment 434753 [details]
WPE build r280524 (2549)

Thread 1:

Thread 1 (Thread 0x7f9480aaf9c0 (LWP 28209)):
#0  __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
#1  0x00007f9484a86855 in __GI_abort () at abort.c:79
#2  0x00007f9485269eed in g_mutex_unlock_slowpath (mutex=<optimized out>, prev=<optimized out>) at ../glib/gthread-posix.c:1505
#3  0x00007f9481dd2836 in object_set_property (object=object@entry=0x5599fb7cae20 [GstPlayBin], pspec=pspec@entry=0x5599fb549860 [GParamFlags], value=value@entry=0x7ffd1c4ad7f0, nqueue=nqueue@entry=0x5599fb658140) at ../gobject/gobject.c:1565
#4  0x00007f9481dd4fa9 in g_object_set_valist (object=0x5599fb7cae20 [GstPlayBin], first_property_name=<optimized out>, var_args=0x7ffd1c4ad8a0) at ../gobject/gobject.c:2465
#5  0x00007f9481dd58b4 in g_object_set (_object=0x5599fb7cae20, first_property_name=0x7f948be7e1d0 "flags") at ../gobject/gobject.c:2635
#6  0x00007f948a1083fc in WebCore::MediaPlayerPrivateGStreamer::updateDownloadBufferingFlag() () at /app/webkit/WebKitBuild/Release/lib/libWPEWebKit-1.1.so.0
#7  0x00007f948a11a7c0 in WebCore::MediaPlayerPrivateGStreamer::handleMessage(_GstMessage*) () at /app/webkit/WebKitBuild/Release/lib/libWPEWebKit-1.1.so.0
#8  0x00007f9481dd03df in g_cclosure_marshal_VOID__BOXEDv (closure=closure@entry=0x5599fb7adc10, return_value=return_value@entry=0x0, instance=instance@entry=0x5599fb7bc580, args=args@entry=0x7ffd1c4add10, marshal_data=marshal_data@entry=0x0, n_params=n_params@entry=1, param_types=0x5599fb467760) at ../gobject/gmarshal.c:1686
#9  0x00007f9481dcd209 in _g_closure_invoke_va (closure=closure@entry=0x5599fb7adc10, return_value=return_value@entry=0x0, instance=instance@entry=0x5599fb7bc580, args=args@entry=0x7ffd1c4add10, n_params=1, param_types=0x5599fb467760) at ../gobject/gclosure.c:873
#10 0x00007f9481de68ef in g_signal_emit_valist (instance=0x5599fb7bc580, signal_id=<optimized out>, detail=452, var_args=var_args@entry=0x7ffd1c4add10) at ../gobject/gsignal.c:3406
#11 0x00007f9481de6ad3 in g_signal_emit (instance=instance@entry=0x5599fb7bc580, signal_id=<optimized out>, detail=<optimized out>) at ../gobject/gsignal.c:3553
#12 0x00007f9484fe95ac in gst_bus_async_signal_func (bus=0x5599fb7bc580 [GstBus|bus34], message=0x7f7f68001ab0 [GstMessage], data=<optimized out>) at ../gst/gstbus.c:1295
#13 0x00007f9484fea4ac in gst_bus_source_dispatch (source=0x5599fb7da3c0, callback=0x7f9484fe9550 <gst_bus_async_signal_func>, user_data=0x0) at ../gst/gstbus.c:851
#14 0x00007f94852162bf in g_main_dispatch (context=0x5599fb339d00) at ../glib/gmain.c:3344
#15 g_main_context_dispatch (context=0x5599fb339d00) at ../glib/gmain.c:4062
#16 0x00007f9485216668 in g_main_context_iterate (context=0x5599fb339d00, block=block@entry=1, dispatch=dispatch@entry=1, self=<optimized out>) at ../glib/gmain.c:4138
#17 0x00007f9485216983 in g_main_loop_run (loop=0x5599fb339df0) at ../glib/gmain.c:4336
#18 0x00007f948bd86cd8 in WTF::RunLoop::run() () at /app/webkit/WebKitBuild/Release/lib/libWPEWebKit-1.1.so.0
#19 0x00007f94880054ec in WebKit::WebProcessMain(int, char**) () at /app/webkit/WebKitBuild/Release/lib/libWPEWebKit-1.1.so.0
#20 0x00007f9484a88062 in __libc_start_main (main=0x5599fa61e790 <main>, argc=4, argv=0x7ffd1c4ae118, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffd1c4ae108) at ../csu/libc-start.c:308
#21 0x00005599fa61e7ce in _start () at ../sysdeps/x86_64/start.S:120

Relevant STDERR:

STDERR: Attempt to unlock mutex that was not locked
STDERR: WPEWebProcess terminated (pid 28209) because the process crashed

[Lauro Moura]

Created attachment 434754 [details]
WPE build r280518 (2544)

Thread 1 (Thread 0x7f4ae4ff9700 (LWP 23730)):
#0  __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
#1  0x00007f4bdb413855 in __GI_abort () at abort.c:79
#2  0x00007f4bdbbf6eed in g_mutex_unlock_slowpath (mutex=<optimized out>, prev=<optimized out>) at ../glib/gthread-posix.c:1505
#3  0x00007f4bdbbf7b52 in g_mutex_unlock (mutex=<optimized out>) at ../glib/gthread-posix.c:1528
#4  0x00007f4b843ac20f in activate_group (target=GST_STATE_PAUSED, group=0x559297ada228, playbin=0x559297ada060 [GstPlayBin|video-2]) at ../gst/playback/gstplaybin2.c:5474
#5  setup_next_source (playbin=playbin@entry=0x559297ada060 [GstPlayBin|video-2], target=<optimized out>) at ../gst/playback/gstplaybin2.c:5725
#6  0x00007f4b843ad50d in gst_play_bin_handle_message (bin=<optimized out>, msg=0x7f4aec07fc00 [GstMessage]) at ../gst/playback/gstplaybin2.c:3068
#7  0x00007f4bdb96495c in bin_bus_handler (bus=<optimized out>, message=<optimized out>, bin=<optimized out>) at ../gst/gstbin.c:3301
#8  0x00007f4bdb97686e in gst_bus_post (bus=bus@entry=0x559297a71040 [GstBus|bus33], message=message@entry=0x7f4aec07fc00 [GstMessage]) at ../gst/gstbus.c:359
#9  0x00007f4bdb98c29a in gst_element_post_message_default (element=element@entry=0x7f4aec014cd0 [GstURIDecodeBin|uridecodebin1], message=0x7f4aec07fc00 [GstMessage]) at ../gst/gstelement.c:2080
#10 0x00007f4bdb967fc0 in gst_bin_post_message (element=0x7f4aec014cd0 [GstURIDecodeBin|uridecodebin1], msg=0x7f4aec07fc00 [GstMessage]) at ../gst/gstmessage.h:368
#11 0x00007f4bdb98f99a in gst_element_post_message (element=0x7f4aec014cd0 [GstURIDecodeBin|uridecodebin1], message=0x7f4aec07fc00 [GstMessage]) at ../gst/gstelement.c:2123
#12 0x00007f4bdb96495c in bin_bus_handler (bus=<optimized out>, message=<optimized out>, bin=<optimized out>) at ../gst/gstbin.c:3301
#13 0x00007f4bdb97686e in gst_bus_post (bus=bus@entry=0x559297adc670 [GstBus|bus44], message=message@entry=0x7f4aec07fc00 [GstMessage]) at ../gst/gstbus.c:359
#14 0x00007f4bdb98c29a in gst_element_post_message_default (element=element@entry=0x7f4ae80314b0 [GstDecodeBin|decodebin1], message=0x7f4aec07fc00 [GstMessage]) at ../gst/gstelement.c:2080
#15 0x00007f4bdb967fc0 in gst_bin_post_message (element=0x7f4ae80314b0 [GstDecodeBin|decodebin1], msg=0x7f4aec07fc00 [GstMessage]) at ../gst/gstmessage.h:368
#16 0x00007f4bdb98f99a in gst_element_post_message (element=0x7f4ae80314b0 [GstDecodeBin|decodebin1], message=0x7f4aec07fc00 [GstMessage]) at ../gst/gstelement.c:2123
#17 0x00007f4b84379601 in gst_decode_bin_handle_message (bin=0x7f4ae80314b0 [GstDecodeBin|decodebin1], msg=<optimized out>) at ../gst/playback/gstdecodebin2.c:5668
#18 0x00007f4bdb96495c in bin_bus_handler (bus=<optimized out>, message=<optimized out>, bin=<optimized out>) at ../gst/gstbin.c:3301
#19 0x00007f4bdb97686e in gst_bus_post (bus=bus@entry=0x559297a71700 [GstBus|bus45], message=message@entry=0x7f4aec07fc00 [GstMessage]) at ../gst/gstbus.c:359
#20 0x00007f4bdb98c29a in gst_element_post_message_default (element=0x7f4b1006cdb0 [GstQTDemux|qtdemux1], message=0x7f4aec07fc00 [GstMessage]) at ../gst/gstelement.c:2080
#21 0x00007f4bdb98f99a in gst_element_post_message (element=element@entry=0x7f4b1006cdb0 [GstQTDemux|qtdemux1], message=0x7f4aec07fc00 [GstMessage]) at ../gst/gstelement.c:2123
#22 0x00007f4bdb98ff3e in gst_element_message_full_with_details (element=0x7f4b1006cdb0 [GstQTDemux|qtdemux1], type=type@entry=GST_MESSAGE_ERROR, domain=domain@entry=2783, code=code@entry=9, text=text@entry=0x7f4ab800f9b0 "This file contains no playable streams.", debug=debug@entry=0x7f4ab8005ff0 "http://127.0.0.1:8000/media/resources/counting-captioned.mov", file=0x7f4b5c2da515 "../gst/isomp4/qtdemux.c", function=0x7f4b5c2e2160 <__func__.90> "gst_qtdemux_post_no_playable_stream_error", line=484, structure=0x7f4ab800c950) at ../gst/gstelement.c:2259
#23 0x00007f4b5c286552 in gst_qtdemux_post_no_playable_stream_error (qtdemux=qtdemux@entry=0x7f4b1006cdb0 [GstQTDemux|qtdemux1]) at ../gst/isomp4/qtdemux.c:484
#24 0x00007f4b5c2af0a9 in gst_qtdemux_loop (pad=0x7f4aec04c390 [GstPad|sink]) at ../gst/isomp4/qtdemux.c:6496
#25 0x00007f4bdb9e5257 in gst_task_func (task=0x7f4b10192a70 [GstTask|qtdemux1:sink]) at ../gst/gsttask.c:384
#26 0x00007f4bdbbce6b4 in g_thread_pool_thread_proxy (data=<optimized out>) at ../glib/gthreadpool.c:354
#27 0x00007f4bdbbcddb1 in g_thread_proxy (data=0x7f4aec00b800) at ../glib/gthread.c:826
#28 0x00007f4bd92654d2 in start_thread (arg=<optimized out>) at pthread_create.c:477
#29 0x00007f4bdb4ef323 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95

Relevant STDERR:

STDERR: Attempt to unlock mutex that was not locked
STDERR: WPEWebProcess terminated (pid 22019) because the process crashed

[Lauro Moura]

Created attachment 434755 [details]
GTK Wayland build r280524 (2536)

Thread 1 (Thread 0x7ffaa50cfe80 (LWP 32038)):
#0  __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
#1  0x00007ffaa7198855 in __GI_abort () at abort.c:79
#2  0x00007ffaa784beed in g_mutex_unlock_slowpath (mutex=<optimized out>, prev=<optimized out>) at ../glib/gthread-posix.c:1505
#3  0x00007ffaa78f7836 in object_set_property (object=object@entry=0x559ccce37e90 [GstPlayBin], pspec=pspec@entry=0x559cccd70120 [GParamFlags], value=value@entry=0x7ffe4e67c1e0, nqueue=nqueue@entry=0x559ccccc1ea0) at ../gobject/gobject.c:1565
#4  0x00007ffaa78f9fa9 in g_object_set_valist (object=0x559ccce37e90 [GstPlayBin], first_property_name=<optimized out>, var_args=0x7ffe4e67c290) at ../gobject/gobject.c:2465
#5  0x00007ffaa78fa8b4 in g_object_set (_object=0x559ccce37e90, first_property_name=0x7ffab024dcee "flags") at ../gobject/gobject.c:2635
#6  0x00007ffaaf7d94e4 in _ZN7WebCore27MediaPlayerPrivateGStreamer27updateDownloadBufferingFlagEv () at /app/webkit/WebKitBuild/Release/lib/libwebkit2gtk-4.1.so.0
#7  0x00007ffaaf7ec354 in _ZN7WebCore27MediaPlayerPrivateGStreamer13handleMessageEP11_GstMessage () at /app/webkit/WebKitBuild/Release/lib/libwebkit2gtk-4.1.so.0
#8  0x00007ffaa78f53df in g_cclosure_marshal_VOID__BOXEDv (closure=closure@entry=0x559ccce3a970, return_value=return_value@entry=0x0, instance=instance@entry=0x7ff9f4009c20, args=args@entry=0x7ffe4e67c700, marshal_data=marshal_data@entry=0x0, n_params=n_params@entry=1, param_types=0x559ccc7ca240) at ../gobject/gmarshal.c:1686
#9  0x00007ffaa78f2209 in _g_closure_invoke_va (closure=closure@entry=0x559ccce3a970, return_value=return_value@entry=0x0, instance=instance@entry=0x7ff9f4009c20, args=args@entry=0x7ffe4e67c700, n_params=1, param_types=0x559ccc7ca240) at ../gobject/gclosure.c:873
#10 0x00007ffaa790b8ef in g_signal_emit_valist (instance=0x7ff9f4009c20, signal_id=<optimized out>, detail=1368, var_args=var_args@entry=0x7ffe4e67c700) at ../gobject/gsignal.c:3406
#11 0x00007ffaa790bad3 in g_signal_emit (instance=instance@entry=0x7ff9f4009c20, signal_id=<optimized out>, detail=<optimized out>) at ../gobject/gsignal.c:3553
#12 0x00007ffaa69e65ac in gst_bus_async_signal_func (bus=0x7ff9f4009c20 [GstBus], message=0x7ffa20011300 [GstMessage], data=<optimized out>) at ../gst/gstbus.c:1295
#13 0x00007ffaa69e74ac in gst_bus_source_dispatch (source=0x559ccce22650, callback=0x7ffaa69e6550 <gst_bus_async_signal_func>, user_data=0x0) at ../gst/gstbus.c:851
#14 0x00007ffaa77f82bf in g_main_dispatch (context=0x559ccc690a00) at ../glib/gmain.c:3344
#15 g_main_context_dispatch (context=0x559ccc690a00) at ../glib/gmain.c:4062
#16 0x00007ffaa77f8668 in g_main_context_iterate (context=0x559ccc690a00, block=block@entry=1, dispatch=dispatch@entry=1, self=<optimized out>) at ../glib/gmain.c:4138
#17 0x00007ffaa77f8983 in g_main_loop_run (loop=0x559ccc723ee0) at ../glib/gmain.c:4336
#18 0x00007ffaab058088 in _ZN3WTF7RunLoop3runEv () at /app/webkit/WebKitBuild/Release/lib/libjavascriptcoregtk-4.1.so.0
#19 0x00007ffaad560fef in _ZN6WebKit20AuxiliaryProcessMainINS_17WebProcessMainGtkEEEiiPPc () at /app/webkit/WebKitBuild/Release/lib/libwebkit2gtk-4.1.so.0
#20 0x00007ffaa719a062 in __libc_start_main (main=0x559ccb4ea850 <main>, argc=4, argv=0x7ffe4e67cb08, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7ffe4e67caf8) at ../csu/libc-start.c:308
#21 0x0000559ccb4ea88e in _start () at ../sysdeps/x86_64/start.S:120

Relevant STDERR:

STDERR: Attempt to unlock mutex that was not locked
STDERR: WebKitWebProcess terminated (pid 32038) because the process crashed

[Philippe Normand]

Seems to crash only in Debug bots now:

Thread 1 (Thread 0x7fe98bbd4280 (LWP 146596)):
#0  WTFCrash() () at /app/webkit/Source/WTF/wtf/Assertions.cpp:333
#1  0x00007fe99de6e9a9 in WTFCrashWithInfo(int, char const*, char const*, int) () at /app/webkit/WebKitBuild/WPE/Debug/WTF/Headers/wtf/Assertions.h:778
#2  0x00007fe9a5dd6cd2 in WebCore::EmptyOriginAccessPatterns::singleton() () at /app/webkit/Source/WebCore/page/OriginAccessPatterns.cpp:75
#3  0x00007fe9a643cfb7 in WebCore::MediaPlayerPrivateGStreamer::loadNextLocation() (this=0x7fe982156ec0) at /app/webkit/Source/WebCore/platform/graphics/gstreamer/MediaPlayerPrivateGStreamer.cpp:2721
#4  0x00007fe9a643cbcf in WebCore::MediaPlayerPrivateGStreamer::mediaLocationChanged(_GstMessage*) (this=0x7fe982156ec0, message=0x555d890131f0 [None]) at /app/webkit/Source/WebCore/platform/graphics/gstreamer/MediaPlayerPrivateGStreamer.cpp:2665
#5  0x00007fe9a6437d3e in WebCore::MediaPlayerPrivateGStreamer::handleMessage(_GstMessage*) (this=0x7fe982156ec0, message=0x555d890131f0 [None]) at /app/webkit/Source/WebCore/platform/graphics/gstreamer/MediaPlayerPrivateGStreamer.cpp:1769
#6  0x00007fe9a643e560 in operator()(GstMessage*) const (__closure=0x7fe9827aa5c8, message=0x555d890131f0 [None]) at /app/webkit/Source/WebCore/platform/graphics/gstreamer/MediaPlayerPrivateGStreamer.cpp:2993
#7  0x00007fe9a646a27d in WTF::Detail::CallableWrapper<WebCore::MediaPlayerPrivateGStreamer::createGSTPlayBin(const WTF::URL&)::<lambda(GstMessage*)>, void, _GstMessage*>::call(_GstMessage *) (this=0x7fe9827aa5c0, in#0=0x555d890131f0 [None]) at /app/webkit/WebKitBuild/WPE/Debug/WTF/Headers/wtf/Function.h:53
#8  0x00007fe9a64063da in WTF::Function<void (_GstMessage*)>::operator()(_GstMessage*) const (this=0x555d88da11c0, in#0=0x555d890131f0 [None]) at /app/webkit/WebKitBuild/WPE/Debug/WTF/Headers/wtf/Function.h:82
#9  0x00007fe9a63ff3b3 in operator()(GstBus*, GstMessage*, GstElement*) const (__closure=0x0, message=0x555d890131f0 [None], pipeline=0x555d88ff46f0 [GstElement|video-16]) at /app/webkit/Source/WebCore/platform/graphics/gstreamer/GStreamerCommon.cpp:492
#10 0x00007fe9a63ff3fd in _FUN(GstBus*, GstMessage*, GstElement*) () at /app/webkit/Source/WebCore/platform/graphics/gstreamer/GStreamerCommon.cpp:492
#11 0x00007fe991f5863a in g_cclosure_marshal_VOID__BOXEDv (closure=0x555d88e1f250, return_value=<optimized out>, instance=0x555d88f848d0, args=<optimized out>, marshal_data=<optimized out>, n_params=<optimized out>, param_types=0x555d88b6f010) at ../gobject/gmarshal.c:1686
#12 0x00007fe991f74a83 in _g_closure_invoke_va (param_types=0x555d88b6f010, n_params=<optimized out>, args=0x7ffc90823a90, instance=0x555d88f848d0, return_value=<optimized out>, closure=<optimized out>) at ../gobject/gclosure.c:895
#13 g_signal_emit_valist (instance=<optimized out>, signal_id=17, detail=<optimized out>, var_args=var_args@entry=0x7ffc90823a90) at ../gobject/gsignal.c:3472
#14 0x00007fe991f74c03 in g_signal_emit (instance=instance@entry=0x555d88f848d0, signal_id=<optimized out>, detail=<optimized out>) at ../gobject/gsignal.c:3622
#15 0x00007fe993298d3b in gst_bus_async_signal_func (bus=0x555d88f848d0 [GstBus|bus316], message=0x555d890131f0 [None], data=<optimized out>) at ../gst/gstbus.c:1280
#16 0x00007fe9932995b7 in gst_bus_source_dispatch (source=source@entry=0x555d88ffee00, callback=0x7fe993298ce0 <gst_bus_async_signal_func>, user_data=0x0) at ../gst/gstbus.c:821
#17 0x00007fe993490d36 in g_main_dispatch (context=0x555d88aed120) at ../glib/gmain.c:3460
#18 g_main_context_dispatch (context=0x555d88aed120) at ../glib/gmain.c:4200
#19 0x00007fe9934ee2b8 in g_main_context_iterate.isra.0 (context=0x555d88aed120, block=block@entry=1, dispatch=dispatch@entry=1, self=<optimized out>) at ../glib/gmain.c:4276
#20 0x00007fe9934903ff in g_main_loop_run (loop=0x555d88aed260) at ../glib/gmain.c:4479
#21 0x00007fe9a1d43f66 in WTF::RunLoop::run() () at /app/webkit/Source/WTF/wtf/glib/RunLoopGLib.cpp:108
#22 0x00007fe99f7f77e1 in WebKit::AuxiliaryProcessMainBase<WebKit::WebProcess, true>::run(int, char**) (this=0x7ffc90823d90, argc=4, argv=0x7ffc90823f58) at /app/webkit/Source/WebKit/Shared/AuxiliaryProcessMain.h:72
#23 0x00007fe99f7f487f in WebKit::AuxiliaryProcessMain<WebKit::WebProcessMainWPE>(int, char**) (argc=4, argv=0x7ffc90823f58) at /app/webkit/Source/WebKit/Shared/AuxiliaryProcessMain.h:98
#24 0x00007fe99f7f1321 in WebKit::WebProcessMain(int, char**) (argc=4, argv=0x7ffc90823f58) at /app/webkit/Source/WebKit/WebProcess/wpe/WebProcessMainWPE.cpp:75
#25 0x0000555d8828b8e9 in main(int, char**) (argc=4, argv=0x7ffc90823f58) at /app/webkit/Source/WebKit/WebProcess/EntryPoint/unix/WebProcessMain.cpp:31

STDERR: ASSERTION FAILED: !isInWebProcess()
STDERR: /app/webkit/Source/WebCore/page/OriginAccessPatterns.cpp(75) : static const WebCore::EmptyOriginAccessPatterns& WebCore::EmptyOriginAccessPatterns::singleton()

[Philippe Normand]

Pull request: https://github.com/WebKit/WebKit/pull/22463

[EWS]

Committed 272778@main (4792e094b47d): <https://commits.webkit.org/272778@main>

Reviewed commits have been landed. Closing PR #22463 and removing active labels.

[Radar WebKit Bug Importer]

<rdar://problem/120662875>

[Philippe Normand]

Needs follow-up gardening

[Radar WebKit Bug Importer]

<rdar://problem/120662919>

[Philippe Normand]

Pull request: https://github.com/WebKit/WebKit/pull/22541

[EWS]

Committed 272805@main (d24c5a44dc2d): <https://commits.webkit.org/272805@main>

Reviewed commits have been landed. Closing PR #22541 and removing active labels.

Cash seems still happening in Glib for both Release and Debug.

Crash

[Philippe Normand]

(In reply to zsun from comment #14)
> Crash

Can you share the backtrace?

STDERR: webkitpy.common.system.logutils: [DEBUG] Debug logging enabled.
STDERR: flatpakutils: [DEBUG] Using flatpak user dir: /home/ziran/WebKit/WebKitBuild/UserFlatpak
STDERR: flatpakutils: [DEBUG] Building WPE port in /home/ziran/WebKit/WebKitBuild/WPE/Release
STDERR: flatpakutils: [DEBUG] Running flatpak --version
STDERR: flatpakutils: [DEBUG] Running flatpak remote-list --help
STDERR: flatpakutils: [DEBUG] Running flatpak remote-list --user --columns=name,title,url
STDERR: flatpakutils: [DEBUG] Running flatpak list --help
STDERR: flatpakutils: [DEBUG] Running flatpak list --user --columns=application,arch,branch,origin -a
STDERR: flatpakutils: [DEBUG] Running: coredumpctl --since=@1725468434.452632 dump
STDERR: 
STDERR: flatpakutils: [DEBUG] Found a11y address b'unix:abstract=/tmp/dbus-huaGs8qfVA,guid=74b91fe39c2901f2a3f2f7f666c47c54'
STDERR: flatpakutils: [DEBUG] Running: flatpak run --user --die-with-parent --filesystem=host --allow=devel --share=network --talk-name=org.gtk.vfs --talk-name=org.gtk.vfs.* --session-bus --no-a11y-bus --filesystem=/tmp/webkit-flatpak-a11y-sockets-t0hehkhz --env=AT_SPI_BUS_ADDRESS=unix:path=/tmp/webkit-flatpak-a11y-sockets-t0hehkhz/tmp57_slxqg --device=all --device=dri --share=ipc --socket=pulseaudio --socket=session-bus --socket=system-bus --socket=wayland --socket=x11 --system-talk-name=org.a11y.Bus --system-talk-name=org.freedesktop.GeoClue2 --talk-name=org.freedesktop.Flatpak --talk-name=org.freedesktop.secrets --env=TEST_RUNNER_INJECTED_BUNDLE_FILENAME=/app/webkit/WebKitBuild/Release/lib/libTestRunnerInjectedBundle.so --env=PATH=/usr/lib/sdk/llvm18/bin:/usr/bin:/usr/lib/sdk/rust-stable/bin/ --env=TZ=America/Los_Angeles --env=GTK_MODULES=gail:atk-bridge --env=DISPLAY=:1 --env=WEBKIT_FLATPAK_USER_DIR=/home/ziran/WebKit/WebKitBuild/UserFlatpak --env=WEBKIT_FLATPAK_LD_PRELOAD=/home/ziran/WebKit/WebKitBuild/WPE/Release/lib/libsigaction-disabler.so --command=gdb org.webkit.Sdk -ex thread apply all backtrace --batch /app/webkit/WebKitBuild/WPE/Release/bin/WPEWebProcess /run/host//tmp/tmpngz_mbk_
STDERR: 
STDERR: BFD: warning: /run/host//tmp/tmpngz_mbk_ has a segment extending past end of file
STDERR: 
STDERR: warning: Can't open file /tmp/WebKitTestRunners-fukrh03t/Cache/2219388714/Version 17/Blobs/9BAC1E95AD30CE2BA9409D69E26378D0C526A0D2 during file-backed mapping note processing
STDERR: 
STDERR: warning: Can't open file /tmp/WebKitTestRunners-fukrh03t/Cache/2219388714/Version 17/Blobs/90A0216BBBF8A1D6009DB1815548C76E6183E0C0 during file-backed mapping note processing
STDERR: 
STDERR: warning: Can't open file /tmp/WebKitTestRunners-fukrh03t/Cache/2219388714/Version 17/Blobs/3123B5B4D132A18CA0E93CBC1D0B139D7F60E1FD during file-backed mapping note processing
STDERR: 
STDERR: warning: Can't open file /tmp/WebKitTestRunners-fukrh03t/Cache/2219388714/Version 17/Blobs/0F8E0C9271DA04605540CF81F09BB455AE85196E during file-backed mapping note processing
STDERR: 
STDERR: warning: Can't open file /tmp/WebKitTestRunners-fukrh03t/Cache/2219388714/Version 17/Blobs/2C884216063773F7EC000F010DE6301EFD328519 during file-backed mapping note processing
STDERR: 
STDERR: warning: Can't open file /tmp/WebKitTestRunners-fukrh03t/appcache/mesa_shader_cache/index during file-backed mapping note processing
STDERR: 
STDERR: warning: Can't open file /memfd:mesa-shared (deleted) during file-backed mapping note processing
STDERR: 
STDERR: warning: Can't open file /memfd:WebKitSharedMemory (deleted) during file-backed mapping note processing
STDERR: 
STDERR: warning: Error reading shared library list entry at 0xdaa6893d68844591
STDERR: Cannot access memory at address 0x7f46b08099d67834
STDERR: Cannot access memory at address 0x7f46b08099d6782c
STDERR: Failed to read a valid object file image from memory.
STDERR: 
STDERR: (WPEWebProcess:182750): GLib-CRITICAL **: 09:47:14.639: g_timer_continue: assertion 'timer->active == FALSE' failed
STDERR: WPEWebProcess terminated (pid 182750) for reason: crash

[Philippe Normand]

There should be a -crash-log.txt file in the results directory. Please attach it here.

Created attachment 472499 [details]
crash log

[Philippe Normand]

This is useless sadly :(

No, not very useful. I'll keep an eye on this test and if I see any useful log, will add in.

[Nils K]

(In reply to zsun from comment #16)
> STDERR: (WPEWebProcess:182750): GLib-CRITICAL **: 09:47:14.639:
> g_timer_continue: assertion 'timer->active == FALSE' failed
> STDERR: WPEWebProcess terminated (pid 182750) for reason: crash

I have encountered the same GLib-CRITICAL error message in the wild on a few devices since we enabled G_DEBUG=fatal-criticals recently. Should I create a separate issue for that?

[Michael Catanzaro]

Of course, with a backtrace please, following the instructions: https://handbook.gnome.org/issues/stack-traces.html

[Nils K]

Okay, just did so. If they turn out to be related the new one is bug #279911(In reply to Michael Catanzaro from comment #22)
> Of course, with a backtrace please, following the instructions:
> https://handbook.gnome.org/issues/stack-traces.html

Okay, just did so. If they turn out to be related the new one is bug #279911.

PS: Is the advantage of "bt full" vs "bt" useful? I have so far only ever submitted the normal "bt" (as I did not knew about the full one) but I could definitely update existing reports with the more complete backtrace if that is helpful.

[Michael Catanzaro]

'bt full' is often critical because it shows local variables, so yes, that should be your default. But it's too verbose to paste directly into bug reports, so you really have to use an attachment. The normal 'bt' can be pasted directly into the bug report if it's short enough, which increases the odds of a developer looking at it. And if the problem is simple/obvious from the shorter form of the backtrace, then 'bt full' might not be needed at all.

GStreamer bugs sometimes require 'thread apply all bt' simply because there might be thread safety errors. The developers will request this type of backtrace if needed.