Bug 290537

Summary:	[GStreamer][1.26] Critical warnings in volume element
Product:	WebKit	Reporter:	Philippe Normand <philn>
Component:	Platform	Assignee:	Philippe Normand <philn>
Status:	RESOLVED FIXED
Severity:	Normal	CC:	webkit-bug-importer
Priority:	P2	Keywords:	InRadar
Version:	WebKit Nightly Build
Hardware:	Unspecified
OS:	Unspecified

Philippe Normand

Reported 2025-03-27 08:43:11 PDT

When running imported/w3c/web-platform-tests/mixed-content/gen/ tests Thread 1 (Thread 0x7f26217fa6c0 (LWP 715620)): #0 g_logv (log_domain=0x7f28ef2509e3 "GStreamer", log_level=G_LOG_LEVEL_CRITICAL, format=<optimized out>, args=args@entry=0x7f26217f94a0) at ../glib/gmessages.c:1422 #1 0x00007f28ef3e07a3 in g_log (log_domain=log_domain@entry=0x7f28ef2509e3 "GStreamer", log_level=log_level@entry=G_LOG_LEVEL_CRITICAL, format=format@entry=0x7f28ef438f92 "%s: assertion '%s' failed") at ../glib/gmessages.c:1460 #2 0x00007f28ef3e361d in g_return_if_fail_warning (log_domain=log_domain@entry=0x7f28ef2509e3 "GStreamer", pretty_function=pretty_function@entry=0x7f28ef27d350 <__func__.8.lto_priv.34> "gst_segment_to_stream_time", expression=expression@entry=0x7f28ef25a5e3 "segment->format == format") at ../glib/gmessages.c:2930 #3 0x00007f28ef209e5a in gst_segment_to_stream_time (segment=segment@entry=0x55bab0a771c0, format=format@entry=GST_FORMAT_TIME, position=<optimized out>) at ../gst/gstsegment.c:528 #4 0x00007f28543810e9 in volume_before_transform (base=0x55bab0a770a0 [GstBaseTransform|volume], buffer=<optimized out>) at ../gst/volume/gstvolume.c:859 #5 0x00007f28ec0c8f73 in gst_base_transform_chain (pad=pad@entry=0x55bab0a77530 [GstPad|sink], parent=parent@entry=0x55bab0a770a0 [GstObject|volume], buffer=buffer@entry=0x7f260802a210) at ../libs/gst/base/gstbasetransform.c:2339 #6 0x00007f28ef1e791c in gst_pad_chain_data_unchecked (pad=pad@entry=0x55bab0a77530 [GstPad|sink], type=type@entry=4112, data=data@entry=0x7f260802a210) at ../gst/gstpad.c:4518 #7 0x00007f28ef1eb634 in gst_pad_push_data (pad=pad@entry=0x55bab0a73e50 [GstPad|src], type=type@entry=4112, data=data@entry=0x7f260802a210) at ../gst/gstpad.c:4811 #8 0x00007f28ef1eba04 in gst_pad_push (pad=0x55bab0a73e50 [GstPad|src], buffer=0x7f260802a210) at ../gst/gstpad.c:4930 #9 0x00007f28ec0c904c in gst_base_transform_chain (pad=pad@entry=0x55bab0a73a40 [GstPad|sink], parent=parent@entry=0x55bab0a734d0 [GstObject|audioresample0], buffer=buffer@entry=0x7f260802a210) at ../libs/gst/base/gstbasetransform.c:2391 #10 0x00007f28ef1e791c in gst_pad_chain_data_unchecked (pad=pad@entry=0x55bab0a73a40 [GstPad|sink], type=type@entry=4112, data=data@entry=0x7f260802a210) at ../gst/gstpad.c:4518 #11 0x00007f28ef1eb634 in gst_pad_push_data (pad=pad@entry=0x55bab0a6f340 [GstPad|src], type=type@entry=4112, data=data@entry=0x7f260802a210) at ../gst/gstpad.c:4811 #12 0x00007f28ef1eba04 in gst_pad_push (pad=0x55bab0a6f340 [GstPad|src], buffer=0x7f260802a210) at ../gst/gstpad.c:4930 #13 0x00007f28ec0c904c in gst_base_transform_chain (pad=pad@entry=0x55bab0a6ef10 [GstPad|sink], parent=parent@entry=0x55bab0a6e960 [GstObject|audioconvert0], buffer=buffer@entry=0x7f260802a210) at ../libs/gst/base/gstbasetransform.c:2391 #14 0x00007f28ef1e791c in gst_pad_chain_data_unchecked (pad=pad@entry=0x55bab0a6ef10 [GstPad|sink], type=type@entry=4112, data=data@entry=0x7f260802a210) at ../gst/gstpad.c:4518 #15 0x00007f28ef1eb634 in gst_pad_push_data (pad=pad@entry=0x55bab0a69390 [GstPad|src], type=type@entry=4112, data=data@entry=0x7f260802a210) at ../gst/gstpad.c:4811 #16 0x00007f28ef1eba04 in gst_pad_push (pad=0x55bab0a69390 [GstPad|src], buffer=buffer@entry=0x7f260802a210) at ../gst/gstpad.c:4930 #17 0x00007f28543de488 in gst_queue_push_one (queue=0x55bab0a68af0 [GstQueue|queue0]) at ../plugins/elements/gstqueue.c:1485 #18 gst_queue_loop (pad=<optimized out>) at ../plugins/elements/gstqueue.c:1640 #19 0x00007f28ef224654 in gst_task_func (task=0x7f26140f5bb0 [GstTask|queue0:src]) at ../gst/gsttask.c:399 #20 0x00007f28ef40e4f2 in g_thread_pool_thread_proxy (data=<optimized out>) at ../glib/gthreadpool.c:350 #21 0x00007f28ef40b862 in g_thread_proxy (data=0x7f28780018e0) at ../glib/gthread.c:831 #22 0x00007f28eebb8e39 in start_thread (arg=<optimized out>) at pthread_create.c:444 #23 0x00007f28eec408c4 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:100 STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4777:gst_pad_push_data:<oggdemux0:src_4deedab9> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<multiqueue0:sink_0> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4777:gst_pad_push_data:<multiqueue0:src_0> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4777:gst_pad_push_data:<oggdemux0:src_5d3faa93> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<multiqueue0:sink_1> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<theoradec0:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4777:gst_pad_push_data:<multiqueue0:src_1> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.303: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<vorbisdec0:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<vorbisdec0:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<src_1:proxypad9> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<decodebin0:src_1> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<src_1:proxypad11> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<uridecodebin0:src_1> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<inputselector1:sink_0> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<inputselector1:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<playsink:audio_sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<audio_sink:proxypad12> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<audiotee:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<audiotee:src_0> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<streamsynchronizer0:sink_1> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<streamsynchronizer0:src_1> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<abin:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<sink:proxypad21> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<filter-convert:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<filter-convert:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<scaletempo0:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<scaletempo0:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<aqueue:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<aqueue:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<aconv:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<sink:proxypad19> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<conv:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<conv:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<resample:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<resample:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<src:proxypad20> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<aconv:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<audio-sink:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<sink:proxypad1> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<audioTee:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<audioTee:src_0> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<queue0:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<queue0:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<audioconvert0:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<audioconvert0:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<audioresample0:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4777:gst_pad_push_data:<audioresample0:src> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-WARNING **: 06:45:02.312: ../gst/gstpad.c:4487:gst_pad_chain_data_unchecked:<volume:sink> Got data flow before segment event STDERR: STDERR: (WPEWebProcess:715487): GStreamer-CRITICAL **: 06:45:02.312: gst_segment_to_stream_time: assertion 'segment->format == format' failed

Attachments
Add attachment proposed patch, testcase, etc.

Philippe Normand

Comment 1 2025-03-27 09:02:53 PDT

Might be related with this issue in oggdemux... :( (gdb) bt #0 _g_log_abort (breakpoint=<optimized out>) at ../glib/gmessages.c:431 #1 g_logv (log_domain=0x7fd918d5b2f7 "GStreamer", log_level=G_LOG_LEVEL_WARNING, format=<optimized out>, args=args@entry=0x7fd6737fd060) at ../glib/gmessages.c:1287 #2 0x00007fd918ed3723 in g_log (log_domain=log_domain@entry=0x7fd918d5b2f7 "GStreamer", log_level=log_level@entry=G_LOG_LEVEL_WARNING, format=format@entry=0x7fd918d6dfd0 "../gstreamer/subprojects/gstreamer/gst/gstpad.c:4777:%s:<%s:%s> Got data flow before segment event") at ../glib/gmessages.c:1329 #3 0x00007fd918cc170e in gst_pad_push_data (pad=pad@entry=0x7fd664186540 [GstPad|src_4deedab9], type=type@entry=4112, data=data@entry=0x7fd66c039000) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4777 #4 0x00007fd918cc8de8 in gst_pad_push (pad=pad@entry=0x7fd664186540 [GstPad|src_4deedab9], buffer=buffer@entry=0x7fd66c039000) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4930 #5 0x00007fd868197eae in gst_ogg_demux_chain_peer (pad=pad@entry=0x7fd664186540 [GstOggPad|src_4deedab9], packet=packet@entry=0x7fd6737fd310, push_headers=1) at ../gstreamer/subprojects/gst-plugins-base/ext/ogg/gstoggdemux.c:852 #6 0x00007fd86819b590 in gst_ogg_pad_submit_packet (pad=0x7fd664186540 [GstOggPad|src_4deedab9], packet=0x7fd6737fd310) at ../gstreamer/subprojects/gst-plugins-base/ext/ogg/gstoggdemux.c:1277 #7 gst_ogg_pad_stream_out (pad=pad@entry=0x7fd664186540 [GstOggPad|src_4deedab9], npackets=<optimized out>, npackets@entry=0) at ../gstreamer/subprojects/gst-plugins-base/ext/ogg/gstoggdemux.c:1325 #8 0x00007fd86819ce21 in gst_ogg_pad_submit_page (pad=0x7fd664186540 [GstOggPad|src_4deedab9], page=page@entry=0x7fd6737fd4f0) at ../gstreamer/subprojects/gst-plugins-base/ext/ogg/gstoggdemux.c:2078 #9 0x00007fd8681a309f in gst_ogg_demux_handle_page (ogg=ogg@entry=0x7fd66417b760 [GstOggDemux|oggdemux0], page=page@entry=0x7fd6737fd4f0, discont=discont@entry=0) at ../gstreamer/subprojects/gst-plugins-base/ext/ogg/gstoggdemux.c:4656 #10 0x00007fd8681a388d in gst_ogg_demux_chain (pad=<optimized out>, parent=0x7fd66417b760 [GstObject|oggdemux0], buffer=<optimized out>) at ../gstreamer/subprojects/gst-plugins-base/ext/ogg/gstoggdemux.c:4735 #11 0x00007fd918cbebae in gst_pad_chain_data_unchecked (pad=pad@entry=0x7fd66417bc00 [GstPad|sink], type=type@entry=4112, data=data@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4518 #12 0x00007fd918cc180a in gst_pad_push_data (pad=pad@entry=0x7fd66c0311f0 [GstPad|src], type=type@entry=4112, data=data@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4811 #13 0x00007fd918cc8de8 in gst_pad_push (pad=0x7fd66c0311f0 [GstPad|src], buffer=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4930 #14 0x00007fd918cbebae in gst_pad_chain_data_unchecked (pad=pad@entry=0x7fd66c004340 [GstPad|sink], type=type@entry=4112, data=data@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4518 #15 0x00007fd918cc180a in gst_pad_push_data (pad=pad@entry=0x7fd66c032c50 [GstPad|proxypad6], type=type@entry=4112, data=data@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4811 #16 0x00007fd918cc8de8 in gst_pad_push (pad=pad@entry=0x7fd66c032c50 [GstPad|proxypad6], buffer=buffer@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4930 #17 0x00007fd918caa024 in gst_proxy_pad_chain_default (pad=0x7fd66c032870 [GstPad|sink], parent=<optimized out>, buffer=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstghostpad.c:127 #18 0x00007fd918cbebae in gst_pad_chain_data_unchecked (pad=pad@entry=0x7fd66c032870 [GstPad|sink], type=type@entry=4112, data=data@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4518 #19 0x00007fd918cc180a in gst_pad_push_data (pad=pad@entry=0x7fd66c036c30 [GstPad|src], type=type@entry=4112, data=data@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4811 #20 0x00007fd918cc8de8 in gst_pad_push (pad=0x7fd66c036c30 [GstPad|src], buffer=buffer@entry=0x7fd66c039570) at ../gstreamer/subprojects/gstreamer/gst/gstpad.c:4930 #21 0x00007fd88c20a84b in gst_queue2_push_one (queue=0x7fd66c036210 [GstQueue2|queue2-0]) at ../gstreamer/subprojects/gstreamer/plugins/elements/gstqueue2.c:3093 #22 gst_queue2_loop (pad=<optimized out>) at ../gstreamer/subprojects/gstreamer/plugins/elements/gstqueue2.c:3218 #23 0x00007fd918cfbc93 in gst_task_func (task=0x7fd66c037750 [GstTask|queue2-0:src]) at ../gstreamer/subprojects/gstreamer/gst/gsttask.c:399 #24 0x00007fd918f053d2 in g_thread_pool_thread_proxy (data=<optimized out>) at ../glib/gthreadpool.c:336 #25 0x00007fd918f041c2 in g_thread_proxy (data=0x7fd8980010d0) at ../glib/gthread.c:890 #26 0x00007fd918730324 in start_thread (arg=<optimized out>) at pthread_create.c:448 #27 0x00007fd9187b3cfc in __GI___clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78

Philippe Normand

Comment 2 2025-03-27 11:07:17 PDT

Indeed, regression introduced by https://gitlab.freedesktop.org/gstreamer/gstreamer/-/merge_requests/937

Philippe Normand

Comment 3 2025-04-07 04:45:04 PDT

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

EWS

Comment 4 2025-05-02 01:42:08 PDT

Committed 294419@main (97a032c9d850): <https://commits.webkit.org/294419@main> Reviewed commits have been landed. Closing PR #43742 and removing active labels.

Radar WebKit Bug Importer

Comment 5 2025-05-02 01:43:14 PDT

<rdar://problem/150506616>

Note You need to log in before you can comment on or make changes to this bug.