[Bug 657835] New: QOS messages are not reliable

[GStreamer (bugzilla.gnome.org)]

https://bugzilla.gnome.org/show_bug.cgi?id=657835
  GStreamer | gstreamer (core) | 0.10.34

           Summary: QOS messages are not reliable
    Classification: Platform
           Product: GStreamer
           Version: 0.10.34
        OS/Version: Linux
            Status: UNCONFIRMED
          Severity: normal
          Priority: Normal
         Component: gstreamer (core)
        AssignedTo: gstreamer-bugs at lists.freedesktop.org
        ReportedBy: tvrtko.ursulin at onelan.co.uk
         QAContact: gstreamer-bugs at lists.freedesktop.org
     GNOME version: ---


This was observed with different media, so far with mp4 video over RTSP, or
mpeg transport streams from a file or UDP streamed.

Two issues here:
1. QOS messages are sometimes not sent when frames are dropped
2. Rendered/dropped frame counts are sometimes incorrect

Examples (custom logging format from a proprietary application using PyGst):

1. MP4 over RTSP rtsp://184.72.239.149/vod/mp4:BigBuckBunny_175k.mov

2011-08-31 15:25:09.317 DEBUG Player now playing
2011-08-31 15:25:09.317 INFO  Video format 240x160 24.000000fps aspect=1.500000
interlaced=False
2011-08-31 15:25:10.750 DEBUG QOS[xvimagesink0] @ 1.395367s
rendered/dropped=27/1 (dpr=0.033534 compensation=5.488799); jitter=146ms
2011-08-31 15:25:10.750 DEBUG QOS[xvimagesink0] @ 1.437367s
rendered/dropped=27/2 (dpr=0.038695 compensation=0.000000); jitter=104ms
2011-08-31 15:25:10.751 DEBUG QOS[xvimagesink0] @ 1.478367s
rendered/dropped=27/3 (dpr=0.043790 compensation=0.000000); jitter=63ms
2011-08-31 15:25:47.068 DEBUG QOS[xvimagesink0] @ 37.661284s
rendered/dropped=859/4 (dpr=0.041169 compensation=8.390006); jitter=198ms

Notice how in all messages rendered + dropped frame count is in shortfall
compared to expected numbers which are stream time * frame rate.

2. Channel 4 (UK) DVB-T MPEG TS 25fps interlaced (stream available on request)

QOS[xvimagesink0] @ 11.478789s rendered/dropped=917/1; jitter=109ms
QOS[xvimagesink0] @ 11.488789s rendered/dropped=917/2; jitter=99ms
QOS[xvimagesink0] @ 11.498789s rendered/dropped=917/3; jitter=89ms
QOS[xvimagesink0] @ 13.278789s rendered/dropped=1082/4; jitter=229ms
QOS[xvimagesink0] @ 13.288789s rendered/dropped=1082/5; jitter=219ms
QOS[xvimagesink0] @ 13.298789s rendered/dropped=1082/6; jitter=210ms

Frame counts totally to high. Now same media via gst-launch:

Got message #579 from element "vconv" (qos): GstMessageQOS,
live=(boolean)false, running-time=(guint64)11468788889,
stream-time=(guint64)11468788889, timestamp=(guint64)70776028066666,
duration=(guint64)40000000, jitter=(gint64)42211111,
proportion=(double)0.029221459808303867, quality=(int)1000000,
format=(GstFormat)GST_FORMAT_BUFFERS, processed=(guint64)229,
dropped=(guint64)1;
Got message #621 from element "vconv" (qos): GstMessageQOS,
live=(boolean)false, running-time=(guint64)13268788889,
stream-time=(guint64)13268788889, timestamp=(guint64)70777828066666,
duration=(guint64)40000000, jitter=(gint64)161377777,
proportion=(double)0.029551520163774225, quality=(int)1000000,
format=(GstFormat)GST_FORMAT_BUFFERS, processed=(guint64)270,
dropped=(guint64)2;
Got message #752 from element "videosink-actual-sink-xvimage" (warning):
GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2866\):\
gst_base_sink_is_too_late\ \(\):\
/GstPlayBin2:playbin20/GstPlaySink:playsink0/GstBin:vbin/GstAutoVideoSink:videosink/GstXvImageSink:videosink-actual-sink-xvimage:\012There\
may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow.";
WARNING: from element
/GstPlayBin2:playbin20/GstPlaySink:playsink0/GstBin:vbin/GstAutoVideoSink:videosink/GstXvImageSink:videosink-actual-sink-xvimage:
A lot of buffers are being dropped.
Additional debug info:
gstbasesink.c(2866): gst_base_sink_is_too_late ():
/GstPlayBin2:playbin20/GstPlaySink:playsink0/GstBin:vbin/GstAutoVideoSink:videosink/GstXvImageSink:videosink-actual-sink-xvimage:
There may be a timestamping problem, or this computer is too slow.
Got message #802 from element "vconv" (qos): GstMessageQOS,
live=(boolean)false, running-time=(guint64)20828788889,
stream-time=(guint64)20828788889, timestamp=(guint64)70785388066666,
duration=(guint64)40000000, jitter=(gint64)41044444,
proportion=(double)0.030325550728272158, quality=(int)1000000,
format=(GstFormat)GST_FORMAT_BUFFERS, processed=(guint64)449,
dropped=(guint64)3;

Frame counts to low.

-- 
Configure bugmail: https://bugzilla.gnome.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are the QA contact for the bug.
You are the assignee for the bug.