>> Subject: [mythtv] Problems with Bob Playback >> >> >> I have a problem with Changeset 8510 where playback gets severely jerky >> after a pause/play. >> >> Some specifics: >> >> Only appears to effect the bob deinterlacer (which is the most useful >> one >> IMHO) >> I use PAL DVB in australia. >> Is quite repeatable. >> I am using svideo from an FX 5200. >> Problem occurs for both Standard and libmpeg2 playback. >> Skipping forward in playback does not appear to cause the problem. >> Switching timestretch to 1.05 or 0.95 makes it smooth again, but >> switching >> back to 1.00 causes it to start jerking again. > Rob R <[EMAIL PROTECTED]> wrote: > > What does your frontend log/console output show when it's being jerky?
This is what I found with mythfrontend -v playback: [EMAIL PROTECTED]:~$ cat frontend.log 2006-01-15 08:56:14.719 Using runtime prefix = /usr 2006-01-15 08:56:14.748 New DB connection, total: 1 2006-01-15 08:56:14.755 Total desktop dim: 720x576, with 1 screen[s]. 2006-01-15 08:56:14.759 Using screen 0, 720x576 at 0,0 2006-01-15 08:56:14.765 Enabling Settings Cache. 2006-01-15 08:56:14.766 Clearing Settings Cache. 2006-01-15 08:56:14.766 user: 105 effective user: 105 before privileged thread 2006-01-15 08:56:14.767 user: 105 effective user: 105 after privileged thread 2006-01-15 08:56:14.768 user: 105 effective user: 105 run_priv_thread 2006-01-15 08:56:14.770 Current Schema Version: 1121 2006-01-15 08:56:14.772 mythfrontend version: 0.19.20051208-1 www.mythtv.org 2006-01-15 08:56:14.772 Enabled verbose msgs: important general playback 2006-01-15 08:56:14.935 max_width: 720 max_height: 576 2006-01-15 08:56:14.937 lang0: eng 2006-01-15 08:56:14.938 lang: eng 2006-01-15 08:56:14.945 lang1: eng 2006-01-15 08:56:14.946 lang: eng 2006-01-15 08:56:15.038 Total desktop dim: 720x576, with 1 screen[s]. 2006-01-15 08:56:15.041 Using screen 0, 720x576 at 0,0 2006-01-15 08:56:15.068 Switching to square mode (blue) 2006-01-15 08:56:15.386 New DB connection, total: 2 2006-01-15 08:56:15.389 Joystick disabled. 2006-01-15 08:56:15.401 Clearing Settings Cache for 'Language'. 2006-01-15 08:56:15.402 Clearing Settings Cache. 2006-01-15 08:56:15.431 Registering Internal as a media playback plugin. 2006-01-15 08:56:15.465 Registering MythDVD DVD Media Handler as a media handler 2006-01-15 08:56:15.466 Registering MythDVD VCD Media Handler as a media handler 2006-01-15 08:56:16.597 Registering MythMusic Media Handler as a media handler SIP listening on IP Address 10.1.1.24:5060 NAT address 10.1.1.24 SIP: Cannot register; proxy, username or password not set 2006-01-15 08:56:17.095 Starting media monitor. 2006-01-15 08:56:20.665 All Programs 2006-01-15 08:56:20.928 Connecting to backend server: 127.0.0.1:6543 (try 1 of 5) 2006-01-15 08:56:20.936 Using protocol version 22 2006-01-15 08:56:21.568 TV: Attempting to change from None to WatchingPreRecorded 2006-01-15 08:56:21.569 RingBuf(/myth/tv/1007_20060114142400.mpg): OpenFile(/myth/tv/1007_20060114142400.mpg, 6) 0: start_time: 2397.503 duration: 115.916 1: start_time: 4281.229 duration: 115.910 2: start_time: 4281.245 duration: 115.916 stream: start_time: 26638.927 duration: 22218.418 bitrate=415 kb/s 2006-01-15 08:56:21.764 AFD: Stream #0, has id 0x1284 codec id DVB_VBI, type Data at 0x0x81f4340 2006-01-15 08:56:21.765 AFD: data codec (Data) 2006-01-15 08:56:21.765 AFD: Stream #1, has id 0x1282 codec id MP3, type Audio at 0x0x8256ff0 2006-01-15 08:56:21.765 AFD: Looking for decoder for MP3 2006-01-15 08:56:21.790 AFD: Opened codec 0x823cb40, id(MP3) type(Audio) 2006-01-15 08:56:21.790 AFD: Audio Track #1 is A/V stream #1 and has 2 channels in the English language(6647399). 2006-01-15 08:56:21.790 AFD: Stream #2, has id 0x1281 codec id MPEG2VIDEO, type Video at 0x0x823ce80 2006-01-15 08:56:21.795 detectInterlace(Detect Scan, Detect Scan, 25, 576) ->Interlaced Scan 2006-01-15 08:56:21.795 Interlaced: Interlaced Scan video_height: 576 fps: 25 2006-01-15 08:56:21.795 AFD: Looking for decoder for MPEG2VIDEO 2006-01-15 08:56:21.795 AFD: Opened codec 0x87816e0, id(MPEG2VIDEO) type(Video) 2006-01-15 08:56:21.795 RingBuf:CalcReadAheadThresh(15256 KB) -> threshhold(750 KB) readblocksize(250 KB) 2006-01-15 08:56:21.795 AFD: Selected track 1: English MP2 2ch (A/V Stream #1) 2006-01-15 08:56:21.795 AFD: Initializing audio parms from audio track #1 2006-01-15 08:56:21.795 AFD: Audio format changed from id(NONE) -1Hz -1ch 0bps ; id(NONE) -1Hz -1ch 0bps to id( MP3) 48000Hz 2ch 16bps ; id( MP3) 48000Hz 2ch 16bps 2006-01-15 08:56:21.797 Opening audio device '/dev/dsp'. 2006-01-15 08:56:21.798 Opening OSS audio device '/dev/dsp'. 2006-01-15 08:56:21.807 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2006-01-15 08:56:21.869 Position map filled from DB to: 32196 2006-01-15 08:56:21.870 SyncPositionMap prerecorded, from DB: 2684 entries 2006-01-15 08:56:21.871 SyncPositionMap, new totframes: 32196, new length: 1287, posMap size: 2684 2006-01-15 08:56:21.872 AFD: Position map found 2006-01-15 08:56:21.872 AFD: Successfully opened decoder for file: "/myth/tv/1007_20060114142400.mpg". novideo(0) 2006-01-15 08:56:21.880 VideoOutputXv: ctor 2006-01-15 08:56:21.890 Over/underscan. V: 0, H: 0, XOff: 0, YOff: 0 2006-01-15 08:56:21.896 Snapping width to avoid scaling: dispwoff 720, dispxoff: 0 2006-01-15 08:56:21.897 Image size. dispxoff 0, dispyoff: 72, dispwoff: 720, disphoff: 432 2006-01-15 08:56:21.898 Image size. imgx 0, imgy: 0, imgw: 720, imgh: 576 2006-01-15 08:56:21.898 VideoOutputXv: Pixel dimensions: Screen 720x576, window 720x576 2006-01-15 08:56:21.899 VideoOutputXv: Estimated display dimensions: 244x195 mm Aspect: 1.25128 2006-01-15 08:56:21.899 VideoOutputXv: Estimated window dimensions: 244x195 mm Aspect: 1.25128 2006-01-15 08:56:21.901 VideoOutputXv: @ j=3 Looking for flag[s]: XvInputMask XvImageMask 2006-01-15 08:56:21.902 VideoOutputXv: Adaptor: 0 has flag[s]: XvInputMask XvImageMask 2006-01-15 08:56:21.903 VideoOutputXv: XVideo surface found on port 177 2006-01-15 08:56:21.904 VideoOutputXv: XVideo Format #0 is 'YUY2' 2006-01-15 08:56:21.905 VideoOutputXv: XVideo Format #1 is 'YV12' 2006-01-15 08:56:21.905 VideoOutputXv: XVideo Format #2 is 'UYVY' 2006-01-15 08:56:21.905 VideoOutputXv: XVideo Format #3 is 'I420' 2006-01-15 08:56:21.906 VideoOutputXv: Using XVideo Format 'I420' 2006-01-15 08:56:22.002 Snapping width to avoid scaling: dispwoff 720, dispxoff: 0 2006-01-15 08:56:22.002 Image size. dispxoff 0, dispyoff: 85, dispwoff: 720, disphoff: 405 2006-01-15 08:56:22.003 Image size. imgx 0, imgy: 0, imgw: 720, imgh: 576 2006-01-15 08:56:23.569 NVP: ClearAfterSeek() 2006-01-15 08:56:23.569 TV: StartPlayer(): took 1970 ms to start player. 2006-01-15 08:56:23.570 VideoOutputXv: ClearAfterSeek() 2006-01-15 08:56:23.571 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2006-01-15 08:56:23.571 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2006-01-15 08:56:23.574 Realtime priority would require SUID as root. 2006-01-15 08:56:23.575 TV: Changing from None to WatchingPreRecorded 2006-01-15 08:56:23.601 AFD: DoFastForward(57 (1), do discard frames) 2006-01-15 08:56:23.601 Dec: DoFastForward(57 (1), do discard frames) 2006-01-15 08:56:23.602 AFD: SeekReset(60, 0, do flush, do discard) 2006-01-15 08:56:23.602 AFD: SeekReset() flushing 2006-01-15 08:56:23.602 VideoBuffers::DiscardFrames(1): UAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2006-01-15 08:56:23.602 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2006-01-15 08:56:23.602 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2006-01-15 08:56:23.603 NVP: ClearAfterSeek() 2006-01-15 08:56:23.603 VideoOutputXv: ClearAfterSeek() 2006-01-15 08:56:23.603 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2006-01-15 08:56:23.603 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2006-01-15 08:56:23.733 Using deinterlace method bobdeint 2006-01-15 08:56:23.836 nVidiaVideoSync: VBlank ioctl did not work, unimplemented in this driver? 2006-01-15 08:56:23.963 DRMVideoSync: Could not open device /dev/dri/card0, No such device or address 2006-01-15 08:56:23.967 OpenGLVideoSync: GLX extensions: GLX_EXT_visual_info GLX_EXT_visual_rating GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGI_video_sync GLX_SGI_swap_control GLX_ARB_multisample GLX_NV_float_buffer GLX_ARB_get_proc_address 2006-01-15 08:56:23.968 OpenGLVideoSync: x,y -> 361, 289 2006-01-15 08:56:24.076 Using OpenGLVideoSync 2006-01-15 08:56:24.079 Set video sync frame interval to 40000 2006-01-15 08:56:24.079 Video sync method can't support double framerate (refresh rate too low for bob deint) 2006-01-15 08:56:24.079 Set video sync frame interval to 40000 2006-01-15 08:56:24.082 Using deinterlace method onefield 2006-01-15 08:56:24.096 Using audio as timebase 2006-01-15 08:56:24.096 Video timing method: SGI OpenGL 2006-01-15 08:56:24.097 Refresh rate: 40000, frame interval: 40000 2006-01-15 08:56:24.219 NVP: Video is 3.01892 frames ahead of audio, dropping frame. 2006-01-15 08:56:24.220 NVP: Video is 3.03292 frames ahead of audio, dropping frame. 'video_output' mean = '37773.65', std. dev. = '8150.90', fps = '26.47' 'video_output' mean = '39796.64', std. dev. = '1510.01', fps = '25.13' 2006-01-15 08:56:35.228 NVP: Changing speed to 0 2006-01-15 08:56:35.228 rate: 25 speed: 1 skip: 1 = interval 40000 2006-01-15 08:56:35.229 Set video sync frame interval to 40000 2006-01-15 08:56:36.140 NVP: Play( 1.0, normal 1, unpause audio 1) 2006-01-15 08:56:36.143 NVP: Changing speed to 1 2006-01-15 08:56:36.143 NVP: DoPlay: rate: 25 speed: 1 skip: 1 => new interval 39999 2006-01-15 08:56:36.144 Set video sync frame interval to 39999 2006-01-15 08:56:36.144 Set video sync frame interval to 39999 2006-01-15 08:56:36.146 Using deinterlace method bobdeint 2006-01-15 08:56:36.146 NVP: Stretch Factor 1, allow passthru 2006-01-15 08:56:36.340 NVP: Video is 3.71842 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.343 NVP: Video is 5.22011 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.345 NVP: Video is 6.11513 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.351 NVP: Video is 6.54889 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.353 NVP: Video is 6.66169 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.356 NVP: Video is 6.50879 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.373 NVP: Video is 6.16285 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.376 NVP: Video is 5.75967 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.379 NVP: Video is 5.22601 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.381 NVP: Video is 4.59451 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.397 NVP: Video is 3.8834 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.399 NVP: Video is 3.1938 frames ahead of audio, dropping frame. 'video_output' mean = '46785.88', std. dev. = '93627.05', fps = '21.37' 2006-01-15 08:56:36.779 NVP: Video is 3.39006 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.787 NVP: Video is 3.46756 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.790 NVP: Video is 3.32568 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.899 NVP: Video is 3.15353 frames ahead of audio, dropping frame. 2006-01-15 08:56:36.902 NVP: Video is 3.04015 frames ahead of audio, dropping frame. 2006-01-15 08:56:37.079 NVP: Video is 3.25408 frames ahead of audio, dropping frame. 2006-01-15 08:56:37.081 NVP: Video is 3.24058 frames ahead of audio, dropping frame. 2006-01-15 08:56:37.199 NVP: Video is 3.28066 frames ahead of audio, dropping frame. 2006-01-15 08:56:37.202 NVP: Video is 3.26051 frames ahead of audio, dropping frame. 2006-01-15 08:56:37.207 NVP: Video is 3.01413 frames ahead of audio, dropping frame. 2006-01-15 08:56:37.462 NVP: Video is 3.39121 frames ahead of audio, dropping frame. [EMAIL PROTECTED]:~$ The interesting part seems to be this: 2006-01-15 08:56:24.079 Video sync method can't support double framerate (refresh rate too low for bob deint) Information about the modeline I am using from XFree log: (**) NVIDIA(0): Mode "720x576i": 13.9 MHz, 15.6 kHz, 50.0 Hz (I) The modeline from XF86Config-4: # 720x576i 50 Hz Modeline "720x576i" 13.875 720 744 808 888 576 582 588 625 -HSync -VSync interlace This is a 50 Hz interlaced modeline, so it should sync at 50 Hz which should be perfect for displaying PAL DVB because it is interlaced 25 FPS as shown by the following logs. 2006-01-15 08:56:21.795 detectInterlace(Detect Scan, Detect Scan, 25, 576) ->Interlaced Scan 2006-01-15 08:56:21.795 Interlaced: Interlaced Scan video_height: 576 fps: 25 I wondered if it was an issue because the modeline is interlaced, so I changed it to a non interlaced version as follows: (**) NVIDIA(0): Mode "720x576p": 27.8 MHz, 31.2 kHz, 50.0 Hz (II) NVIDIA(0): Setting mode "720x576p" Modeline "720x576p" 27.75 720 744 808 888 576 582 588 625 -HSync -VSync The error message about the video sync method went away, but the problem with the jerkiness still occurs after resuming from a pause. The "Video is n frames ahead of audio , dropping frame" messages still appear. Any Ideas? Greg Frost _______________________________________________ mythtv-dev mailing list mythtv-dev@mythtv.org http://mythtv.org/cgi-bin/mailman/listinfo/mythtv-dev