GNOME Bugzilla – Bug 633584
DVD doesn't play back smoothly
Last modified: 2012-10-16 22:10:02 UTC
When I read a DVD, the totem screen has short freeze. The film isn't in continuous. (The GSSTREAMER is the 0.10.30).
Can you run Totem from the command line with the following command and attach the resulting log here please? GST_DEBUG=*:4 GST_DEBUG_NO_COLOR=1 totem &> totem.log
Created attachment 173595 [details] Log file from totem here is the file log. I hope you will find something. I'm using Ubuntu since 3 days only so I'm not a expert. Regards,
Sorry, I should've said you actually need to try playing the DVD (for a few tens of seconds; until the freezing has occurred one or two times) and send a log of that. Thank you.
The problem is that the size of the file while be high and I counldn't load it. How could load it in the forum?
Please e-mail it to me at bugzilla@tecnocode.co.uk.
I've received the logs the following extract looks relevant. Forwarding to the nice GStreamer people. 0:00:37.697107138 3720 0x9beee18 DEBUG audioclock gstaudioclock.c:179:gst_audio_clock_get_internal_time:<GstPulseSinkClock> result 0:00:04.141107000, last_time 0:00:04.141107000 0:00:37.697149043 3720 0x9beee18 DEBUG GST_CLOCK gstsystemclock.c:592:gst_system_clock_id_wait_jitter_unlocked: entry 0x9c07b50 time 0:00:03.952490000 now 0:00:04.141107000 real 0:00:04.141107000 diff (time-now) -188617000 0:00:37.697171392 3720 0x9beee18 DEBUG GST_CLOCK gstclock.c:440:gst_clock_id_wait:<GstPulseSinkClock> done waiting entry 0x9c07b50, res: 1 0:00:37.697190669 3720 0x9beee18 DEBUG GST_CLOCK gstclock.c:236:_gst_clock_id_free: freed entry 0x9c07b50 0:00:37.697219444 3720 0x9beee18 DEBUG basesink gstbasesink.c:2414:gst_base_sink_do_sync:<autovideosink0-actual-sink-xvimage> clock returned 1, jitter 0:00:00.188617000 0:00:37.697238720 3720 0x9beee18 DEBUG GST_PERFORMANCE gstbasesink.c:2678:gst_base_sink_is_too_late:<autovideosink0-actual-sink-xvimage> buffer is too late 0:00:02.008617000 > 0:00:01.860000000 0:00:37.697304372 3720 0x9beee18 WARN basesink gstbasesink.c:2686:gst_base_sink_is_too_late:<autovideosink0-actual-sink-xvimage> warning: De nombreux tampons sont éliminés. 0:00:37.697321413 3720 0x9beee18 WARN basesink gstbasesink.c:2686:gst_base_sink_is_too_late:<autovideosink0-actual-sink-xvimage> warning: There may be a timestamping problem, or this computer is too slow. 0:00:37.697343204 3720 0x9beee18 DEBUG GST_MESSAGE gstelement.c:1730:gst_element_message_full:<autovideosink0-actual-sink-xvimage> start 0:00:37.697391256 3720 0x9beee18 INFO GST_ERROR_SYSTEM gstelement.c:1761:gst_element_message_full:<autovideosink0-actual-sink-xvimage> posting message: De nombreux tampons sont éliminés. 0:00:37.697426177 3720 0x9beee18 DEBUG GST_BUS gstbus.c:307:gst_bus_post:<bus7> [msg 0x9ae8200] posting on bus, type warning, GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; from source <autovideosink0-actual-sink-xvimage> 0:00:37.697475066 3720 0x9beee18 DEBUG bin gstbin.c:3017:gst_bin_handle_message_func:<autovideosink0> [msg 0x9ae8200] handling child autovideosink0-actual-sink-xvimage message of type warning 0:00:37.697492108 3720 0x9beee18 DEBUG bin gstbin.c:3302:gst_bin_handle_message_func:<autovideosink0> posting message upward 0:00:37.697508870 3720 0x9beee18 DEBUG GST_BUS gstbus.c:307:gst_bus_post:<bus8> [msg 0x9ae8200] posting on bus, type warning, GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; from source <autovideosink0-actual-sink-xvimage> 0:00:37.697539321 3720 0x9beee18 DEBUG bin gstbin.c:3017:gst_bin_handle_message_func:<bin0> [msg 0x9ae8200] handling child autovideosink0-actual-sink-xvimage message of type warning 0:00:37.697555804 3720 0x9beee18 DEBUG bin gstbin.c:3302:gst_bin_handle_message_func:<bin0> posting message upward 0:00:37.697572007 3720 0x9beee18 DEBUG GST_BUS gstbus.c:307:gst_bus_post:<bus5> [msg 0x9ae8200] posting on bus, type warning, GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; from source <autovideosink0-actual-sink-xvimage> 0:00:37.697601620 3720 0x9beee18 DEBUG bin gstbin.c:3017:gst_bin_handle_message_func:<video-sink> [msg 0x9ae8200] handling child autovideosink0-actual-sink-xvimage message of type warning 0:00:37.697617823 3720 0x9beee18 DEBUG bin gstbin.c:3302:gst_bin_handle_message_func:<video-sink> posting message upward 0:00:37.697634027 3720 0x9beee18 DEBUG GST_BUS gstbus.c:307:gst_bus_post:<bus26> [msg 0x9ae8200] posting on bus, type warning, GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; from source <autovideosink0-actual-sink-xvimage> 0:00:37.697670903 3720 0x9beee18 DEBUG bin gstbin.c:3017:gst_bin_handle_message_func:<vbin> [msg 0x9ae8200] handling child autovideosink0-actual-sink-xvimage message of type warning 0:00:37.697687386 3720 0x9beee18 DEBUG bin gstbin.c:3302:gst_bin_handle_message_func:<vbin> posting message upward 0:00:37.697703869 3720 0x9beee18 DEBUG GST_BUS gstbus.c:307:gst_bus_post:<bus2> [msg 0x9ae8200] posting on bus, type warning, GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; from source <autovideosink0-actual-sink-xvimage> 0:00:37.697733482 3720 0x9beee18 DEBUG bin gstbin.c:3017:gst_bin_handle_message_func:<playsink0> [msg 0x9ae8200] handling child autovideosink0-actual-sink-xvimage message of type warning 0:00:37.697749685 3720 0x9beee18 DEBUG bin gstbin.c:3302:gst_bin_handle_message_func:<playsink0> posting message upward 0:00:37.697765889 3720 0x9beee18 DEBUG GST_BUS gstbus.c:307:gst_bus_post:<bus0> [msg 0x9ae8200] posting on bus, type warning, GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; from source <autovideosink0-actual-sink-xvimage> 0:00:37.697846626 3720 0x9beee18 DEBUG bin gstbin.c:3017:gst_bin_handle_message_func:<play> [msg 0x9ae8200] handling child autovideosink0-actual-sink-xvimage message of type warning 0:00:37.697862830 3720 0x9beee18 DEBUG bin gstbin.c:3302:gst_bin_handle_message_func:<play> posting message upward 0:00:37.697878474 3720 0x9beee18 DEBUG GST_BUS gstbus.c:307:gst_bus_post:<bus1> [msg 0x9ae8200] posting on bus, type warning, GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; from source <autovideosink0-actual-sink-xvimage> 0:00:37.697919262 3720 0x9beee18 DEBUG GST_BUS gstbus.c:337:gst_bus_post:<bus1> [msg 0x9ae8200] pushing on async queue 0:00:37.697937421 3720 0x9beee18 DEBUG GST_BUS gstbus.c:342:gst_bus_post:<bus1> [msg 0x9ae8200] pushed on async queue 0:00:37.697990501 3720 0x96190a0 DEBUG GST_BUS gstbus.c:498:gst_bus_timed_pop_filtered:<bus1> got message 0x9ae8200, warning, type mask is 4294967295 0:00:37.698009219 3720 0x96190a0 DEBUG GST_BUS gstbus.c:758:gst_bus_source_dispatch:<bus1> source 0x9992fd0 calling dispatch with 0x9ae8200 0:00:37.698032965 3720 0x96190a0 WARN totem bacon-video-widget-gst-0.10.c:2118:bvw_bus_message_cb: Warning message: warning message from element 'autovideosink0-actual-sink-xvimage': GstMessageWarning, gerror=(GError)NULL, debug=(string)"gstbasesink.c\(2686\):\ gst_base_sink_is_too_late\ \(\):\ /GstPlayBin2:play/GstPlaySink:playsink0/GstBin:vbin/GstGConfVideoSink:video-sink/GstBin:bin0/GstAutoVideoSink:autovideosink0/GstXvImageSink:autovideosink0-actual-sink-xvimage:\012There\ may\ be\ a\ timestamping\ problem\,\ or\ this\ computer\ is\ too\ slow."; 0:00:37.698077385 3720 0x96190a0 DEBUG GST_BUS gstbus.c:763:gst_bus_source_dispatch:<bus1> source 0x9992fd0 handler returns 1
> "There may be a timestamping problem, or this computer is too slow." What kind of computer/CPU is this with? Does it work with current versions of GStreamer?
Moving to -bad for now, since that's where most of the dvd stuff lives (assuming resindvd/rsndvd is being used here).
grandeours@wanadoo.fr, can you respond to the question in comment #7? Thanks
Closing this bug report as no further information has been provided. Please feel free to reopen this bug if you can provide the information asked for. Thanks!