On Tue Oct 31 18:32:42 2023 +0000, Alfred Agrell wrote:
No, sorry, my bad, I cleaned up those logs too hard.
01e4:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 1000, late -0.4180444, timestamp -0.2. 01e4:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 1.0000000000000000e+00, diff 0, timestamp 0. 0:00:00.153596244 5139 0x7fba10037860 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=0 stream_time=-1 diff=0 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 1000, late -0.4443777, timestamp -0.193. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 1.0000000000000000e+00, diff 0, timestamp 0. 0:00:00.160425790 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=0 stream_time=-1 diff=0 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.063711, timestamp 0.221. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -637110, timestamp 2210000. 0:00:00.574499800 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=221000000 stream_time=-1 diff=-63711000 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.0640444, timestamp 0.254. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -640444, timestamp 2540000. 0:00:00.607456059 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=254000000 stream_time=27955556 diff=-64044400 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.0633777, timestamp 0.288. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -633777, timestamp 2880000. 0:00:00.640834761 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=288000000 stream_time=61955556 diff=-63377700 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.062711, timestamp 0.322. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -627110, timestamp 3220000. 0:00:00.674681804 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=322000000 stream_time=95955556 diff=-62711000 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.0640444, timestamp 0.354. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -640444, timestamp 3540000. 0:00:00.707600604 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=354000000 stream_time=127955556 diff=-64044400 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.0633777, timestamp 0.388. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -633777, timestamp 3880000. 0:00:00.741135357 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=388000000 stream_time=161955556 diff=-63377700 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.063711, timestamp 0.421. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -637110, timestamp 4210000. 0:00:00.774577068 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=421000000 stream_time=194955556 diff=-63711000 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.0590443, timestamp 0.459. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -590443, timestamp 4590000. 0:00:00.812276144 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=459000000 stream_time=232955556 diff=-59044300 01dc:trace:quartz:source_quality_control_Notify filter 00379A98, sender 0AAB11EC, type 0, proportion 2000, late -0.0553776, timestamp 0.496. 01dc:trace:quartz:wg_parser_stream_notify_qos stream 0x7fba100afe30, underflow 0, proportion 5.0000000000000000e-01, diff -553776, timestamp 4960000. 0:00:00.849423973 5139 0x7fba1004a2f0 ERROR WINE dlls/winegstreamer/wg_parser.c:477:wg_parser_stream_notify_qos: timestamp*100=496000000 stream_time=269955556 diff=-55377600
The third wg_parser_stream_notify_qos call has timestamp*100 = 221000000, 0.221 seconds. But the stream_time is only 27955556, which is 0.027 seconds; adding a -0.063 seconds diff to that goes out of bounds. I have the offending mpeg file extracted; should I upload it somewhere, or is that copyrightly improper? It's 518148 bytes.
Copying offline discussion here; yes, this is coming from the application sink, not ours, and I think clamping is probably the right thing to do.