[mythtv] OpenGL vsync broken on Intel i945

Tino Keitel tino.keitel at gmx.de
Thu Nov 22 20:21:51 UTC 2007


Hi folks,

for some months now I can not use OpenGL vsync with SVN trunk
(currently multirec). When I enable it, LiveTV only shows a short
moment of too fast video every few seconds. I use Xorg with the Intel
driver and Mesa 7.0.2. Does anyone else knows about this problem? Is
there a fix/workaround? Should I open a bug?

I attached the frontend log.

Regards,
Tino

-------------- next part --------------
$ mythfrontend -v playback -geometry 960x600
Session management error: Authentication Rejected, reason : None of the authentication protocols specified are supported and host-based authentication failed
2007-11-22 21:03:30.376 Using runtime prefix = /usr
2007-11-22 21:03:31.087 Database Hostname: localhost
2007-11-22 21:03:31.107 DPMS is disabled.
2007-11-22 21:03:31.108 Empty LocalHostName.
2007-11-22 21:03:31.108 Using localhost value of dose
2007-11-22 21:03:31.146 New DB connection, total: 1
2007-11-22 21:03:31.156 Connected to database 'mythconverg' at host: localhost
2007-11-22 21:03:31.158 Total desktop dim: 1680x1050, with 1 screen[s].
2007-11-22 21:03:31.367 Using screen 0, 1680x1050 at 0,0
2007-11-22 21:03:31.379 Overriding GUI, width=960, height=600 at 0,0
2007-11-22 21:03:31.379 user: 1001 effective user: 1001 before privileged thread
2007-11-22 21:03:31.379 user: 1001 effective user: 1001 after privileged thread
2007-11-22 21:03:31.380 user: 1001 effective user: 1001 run_priv_thread
2007-11-22 21:03:31.382 Current Schema Version: 1201
2007-11-22 21:03:31.382 mythfrontend version: 0.21.20071119-98 www.mythtv.org
2007-11-22 21:03:31.383 Enabled verbose msgs:  important general playback
2007-11-22 21:03:31.493 The theme (templates) is missing a themeinfo.xml file
2007-11-22 21:03:31.588 The theme (templates) is missing a themeinfo.xml file
2007-11-22 21:03:32.060 max_width: 1680 max_height: 1050
2007-11-22 21:03:32.192 Writing settings file /home/scorpion/.mythtv/mysql.txt
2007-11-22 21:03:32.199 Closing DB connection named 'DBManager0'
2007-11-22 21:03:32.201 Connected to database 'mythconverg' at host: localhost
2007-11-22 21:03:32.210 Switching to wide mode (MythCenter-wide)
2007-11-22 21:03:32.297 Using the Qt painter
2007-11-22 21:03:32.298 Joystick disabled.
2007-11-22 21:03:32.299 New DB connection, total: 2
2007-11-22 21:03:32.300 Connected to database 'mythconverg' at host: localhost
2007-11-22 21:03:32.300 lirc init success using configuration file: /home/scorpion/.lircrc
2007-11-22 21:03:32.967 Loading from: /usr/share/mythtv/themes/MythCenter-wide/base.xml
2007-11-22 21:03:32.974 Loading from: /usr/share/mythtv/themes/default/base.xml
2007-11-22 21:03:33.022 Registering Internal as a media playback plugin.
2007-11-22 21:03:33.069 MonitorRegisterExtensions(0x100, gif,jpg,png)
2007-11-22 21:03:33.110 Connecting to backend server: 10.100.1.1:6543 (try 1 of 5)
2007-11-22 21:03:33.110 Using protocol version 3700
2007-11-22 21:03:33.111 Starting media monitor.
2007-11-22 21:03:33.118 NetworkControl: Listening for remote connections on port 6546
mount: can't find /dev/sdb in /etc/fstab or /etc/mtab
2007-11-22 21:03:33.124 Failed to mount /dev/sdb.
2007-11-22 21:03:33.127 Media status changed... (MEDIATYPE_DATA, MEDIASTAT_UNPLUGGED -> MEDIASTAT_NOTMOUNTED)
2007-11-22 21:03:33.138 MythThemedMenuPrivate: Unknown tag image in background
mount: can't find /dev/sdc in /etc/fstab or /etc/mtab
2007-11-22 21:03:33.138 Failed to mount /dev/sdc.
2007-11-22 21:03:33.141 Media status changed... (MEDIATYPE_DATA, MEDIASTAT_UNPLUGGED -> MEDIASTAT_NOTMOUNTED)
mount: can't find /dev/sdd in /etc/fstab or /etc/mtab
2007-11-22 21:03:33.153 Failed to mount /dev/sdd.
2007-11-22 21:03:33.156 Media status changed... (MEDIATYPE_DATA, MEDIASTAT_UNPLUGGED -> MEDIASTAT_NOTMOUNTED)
mount: can't find /dev/sdf in /etc/fstab or /etc/mtab
2007-11-22 21:03:33.169 Failed to mount /dev/sdf.
2007-11-22 21:03:33.172 Media status changed... (MEDIATYPE_DATA, MEDIASTAT_UNPLUGGED -> MEDIASTAT_NOTMOUNTED)
2007-11-22 21:03:34.207 TV: Attempting to change from None to WatchingLiveTV
2007-11-22 21:03:34.208 Using protocol version 3700
2007-11-22 21:03:34.317 LiveTVChain(live-dose-2007-11-22T21:03:34): ReloadAll(): Added new recording
2007-11-22 21:03:34.323 TV: StartRecorder(): took 0 ms to start recorder.
2007-11-22 21:03:34.359 detectInterlace(Ignore Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2007-11-22 21:03:34.364 NVP: Disabling Audio, params(-1,2,44100)
2007-11-22 21:03:34.517 VideoOutput: Allowed renderers: opengl,xv-blit,xshm,xlib
2007-11-22 21:03:34.518 VideoOutput: Allowed renderers (filt: dummy): xlib,xshm,xv-blit,opengl
2007-11-22 21:03:34.523 VDP: Accepting: cmp(<= 720 576,> 0 0) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,greedyhdoubleprocessdeint) filt()
2007-11-22 21:03:34.523 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,none) filt()
2007-11-22 21:03:34.523 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(libmpeg2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.523 VDP: Accepting: cmp(> 0 0) dec(xvmc) rend(xvmc-blit) osd(ia44blend) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.524 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) rend(xv-blit) osd(chromakey) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.524 VDP: LoadBestPreferences(2048x2048, 0)
2007-11-22 21:03:34.524 VDP: LoadBestPreferences(2048x2048, 60)
2007-11-22 21:03:34.525 VDP: LoadBestPreferences(720x576, 60)
2007-11-22 21:03:34.525 VideoOutput: Preferred renderer: xv-blit
2007-11-22 21:03:34.525 VideoOutput: Trying video renderer: xv-blit
2007-11-22 21:03:34.529 VDP: Accepting: cmp(<= 720 576,> 0 0) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,greedyhdoubleprocessdeint) filt()
2007-11-22 21:03:34.530 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,none) filt()
2007-11-22 21:03:34.530 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(libmpeg2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.530 VDP: Accepting: cmp(> 0 0) dec(xvmc) rend(xvmc-blit) osd(ia44blend) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.531 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) rend(xv-blit) osd(chromakey) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.531 VDP: LoadBestPreferences(2048x2048, 0)
2007-11-22 21:03:34.531 VDP: LoadBestPreferences(2048x2048, 60)
2007-11-22 21:03:34.549 VideoOutputXv: ctor
2007-11-22 21:03:34.620 XOff: 0, YOff: 0
2007-11-22 21:03:34.620 VDP: LoadBestPreferences(720x576, 60)
2007-11-22 21:03:34.620 Snapping height to avoid scaling: height: 576, top: 12
2007-11-22 21:03:34.621 Display Rect  left: 0, top: 12, width: 960, height: 576, aspect: 1.33333
2007-11-22 21:03:34.621 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2007-11-22 21:03:34.621 VideoOutputXv: Pixel dimensions: Screen 960x600, window 960x600
2007-11-22 21:03:34.639 VideoOutputXv: Estimated display dimensions: 426x266 mm  Aspect: 1.6015
2007-11-22 21:03:34.639 VideoOutputXv: Estimated window dimensions: 426x266 mm  Aspect: 1.6015
2007-11-22 21:03:34.658 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: opengl,xv-blit,xshm,xlib
2007-11-22 21:03:34.662 VDP: Accepting: cmp(<= 720 576,> 0 0) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,greedyhdoubleprocessdeint) filt()
2007-11-22 21:03:34.662 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,none) filt()
2007-11-22 21:03:34.663 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(libmpeg2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.663 VDP: Accepting: cmp(> 0 0) dec(xvmc) rend(xvmc-blit) osd(ia44blend) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.663 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) rend(xv-blit) osd(chromakey) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:34.663 VDP: LoadBestPreferences(2048x2048, 0)
2007-11-22 21:03:34.664 VDP: LoadBestPreferences(2048x2048, 60)
2007-11-22 21:03:34.664 VDP: LoadBestPreferences(720x576, 60)
2007-11-22 21:03:34.679 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  10
2007-11-22 21:03:34.679 VideoOutputXv: Adaptor#0: Intel(R) Textured Video has flag[s]: XvInputMask XvImageMask 
2007-11-22 21:03:34.679 VideoOutputXv: Has XVideo flags...
2007-11-22 21:03:34.698 VideoOutputXv: Has XV_BRIGHTNESS...
2007-11-22 21:03:34.698 VideoOutputXv: Here...
2007-11-22 21:03:34.731 VideoOutputXv: Grabbed xv port 73
2007-11-22 21:03:34.731 VideoOutputXv: XVideo surface found on port 73
2007-11-22 21:03:34.731 VideoOutputXv: XVideo Adaptor Name: 'Intel(R) Textured Video'
2007-11-22 21:03:34.758 VideoOutputXv: XVideo Format #0 is 'YUY2'
2007-11-22 21:03:34.758 VideoOutputXv: XVideo Format #1 is 'YV12'
2007-11-22 21:03:34.758 VideoOutputXv: XVideo Format #2 is 'I420'
2007-11-22 21:03:34.758 VideoOutputXv: XVideo Format #3 is 'UYVY'
2007-11-22 21:03:34.758 VideoOutputXv: Using XVideo Format 'YV12'
2007-11-22 21:03:34.758 VideoOutputXv: CreateShmImages(32): video_dim: 720x576
2007-11-22 21:03:34.938 VDP: SetVideoRenderer(xv-blit)
2007-11-22 21:03:34.938 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2007-11-22 21:03:34.958 VideoOutputXv: Chromakeying not possible with this XVideo port.
2007-11-22 21:03:34.958 Snapping height to avoid scaling: height: 576, top: 12
2007-11-22 21:03:34.958 Display Rect  left: 80, top: 12, width: 799, height: 576, aspect: 1.6015
2007-11-22 21:03:34.959 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2007-11-22 21:03:34.961 Over/underscan. V: 0, H: 0
2007-11-22 21:03:34.961 Snapping height to avoid scaling: height: 576, top: 12
2007-11-22 21:03:34.961 Display Rect  left: 80, top: 12, width: 799, height: 576, aspect: 1.6015
2007-11-22 21:03:34.961 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2007-11-22 21:03:34.961 VDP: LoadBestPreferences(720x576, 25)
2007-11-22 21:03:34.962 NVP: LoadFilters(''..) -> 0
2007-11-22 21:03:35.304 TV: StartPlayer(): took 945 ms to start player.
2007-11-22 21:03:35.304 TV: Changing from None to WatchingLiveTV
2007-11-22 21:03:35.304 NVP: ClearAfterSeek(1)
2007-11-22 21:03:35.305 VideoOutputXv: ClearAfterSeek()
2007-11-22 21:03:35.305 VideoOutputXv: DiscardFrames(0)
2007-11-22 21:03:35.305 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2007-11-22 21:03:35.306 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2007-11-22 21:03:35.306 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:35.320 New DB connection, total: 3
2007-11-22 21:03:35.321 Connected to database 'mythconverg' at host: localhost
2007-11-22 21:03:35.321 LiveTVChain(live-dose-2007-11-22T21:03:34): ReloadAll(): Added new recording
2007-11-22 21:03:35.321 The realtime priority setting is not enabled.
2007-11-22 21:03:35.325 rate: 25 speed: 1 skip: 1 = interval 40000
2007-11-22 21:03:35.325 LiveTVChain(live-dose-2007-11-22T21:03:34): SwitchTo(1)
2007-11-22 21:03:35.325 LiveTVChain(live-dose-2007-11-22T21:03:34): Entry at 1: '1002_20071122210335'
2007-11-22 21:03:35.325 JumpToProgram(void)
2007-11-22 21:03:35.333 RingBuf(/home/mythtv/recordings/1002_20071122210334.mpg): OpenFile(/home/mythtv/recordings/1002_20071122210335.mpg, 12)
2007-11-22 21:03:35.333 RingBuf(/home/mythtv/recordings/1002_20071122210335.mpg): CalcReadAheadThresh(2852118256 KB)
                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2007-11-22 21:03:35.337 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdoubleprocessdeint'
Initialize GreedyH Deinterlacer. In-Pixformat = 1 Out-Pixformat=1
greedyhdeint: size changed from 0 x 0 -> 720 x 576
2007-11-22 21:03:35.341 Using deinterlace method greedyhdoubleprocessdeint
2007-11-22 21:03:35.342 nVidiaVideoSync: Could not open device /dev/nvidia0, No such file or directory
2007-11-22 21:03:38.341 DRMVideoSync: VBlank ioctl did not work, unimplemented in this driver?
2007-11-22 21:03:38.341 OpenGLVideoSync()
2007-11-22 21:03:38.371 OpenGLVideoSync: x,y -> 551, 666
2007-11-22 21:03:38.424 Using OpenGLVideoSync
2007-11-22 21:03:38.424 Set video sync frame interval to 40000
2007-11-22 21:03:38.503 AFD: Stream #0, has id 0x201 codec id MPEG2VIDEO, type Video, bitrate 15000000 at 0x0xb3d96200
2007-11-22 21:03:38.505 VDP: Accepting: cmp(<= 720 576,> 0 0) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,greedyhdoubleprocessdeint) filt()
2007-11-22 21:03:38.505 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,none) filt()
2007-11-22 21:03:38.505 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(libmpeg2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:38.505 VDP: Accepting: cmp(> 0 0) dec(xvmc) rend(xvmc-blit) osd(ia44blend) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:38.506 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) rend(xv-blit) osd(chromakey) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:38.506 VDP: LoadBestPreferences(2048x2048, 0)
2007-11-22 21:03:38.506 VDP: LoadBestPreferences(2048x2048, 60)
2007-11-22 21:03:38.506 VDP: LoadBestPreferences(720x576, 60)
2007-11-22 21:03:38.508 VDP: Accepting: cmp(<= 720 576,> 0 0) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,greedyhdoubleprocessdeint) filt()
2007-11-22 21:03:38.508 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,none) filt()
2007-11-22 21:03:38.508 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(libmpeg2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:38.509 VDP: Accepting: cmp(> 0 0) dec(xvmc) rend(xvmc-blit) osd(ia44blend) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:38.509 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) rend(xv-blit) osd(chromakey) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:38.509 VDP: LoadBestPreferences(2048x2048, 0)
2007-11-22 21:03:38.509 VDP: LoadBestPreferences(2048x2048, 60)
2007-11-22 21:03:38.510 VDP: LoadBestPreferences(720x576, 60)
2007-11-22 21:03:38.510 AFD: InitVideoCodec() 0xb3d35d10 id(MPEG2VIDEO) type (Video).
2007-11-22 21:03:38.510 VideoOutputXv: InputChanged(720,576,1.33333) 'None'->'MPEG2'
2007-11-22 21:03:38.510 VideoOutputXv: DiscardFrames(1)
2007-11-22 21:03:38.510 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2007-11-22 21:03:38.510 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:38.511 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2007-11-22 21:03:38.511 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:38.511 VideoOutputXv: DiscardFrames(1)
2007-11-22 21:03:38.511 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2007-11-22 21:03:38.511 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:38.511 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2007-11-22 21:03:38.512 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:38.512 VideoOutputXv: DiscardFrames(1)
2007-11-22 21:03:38.512 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2007-11-22 21:03:38.512 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:38.512 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2007-11-22 21:03:38.512 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:41.423 OpenGLVideoSync::Start(): A/V Sync reported error: Bad Context
2007-11-22 21:03:41.424 Using audio as timebase
2007-11-22 21:03:41.424 Video timing method: SGI OpenGL
2007-11-22 21:03:41.424 Refresh rate: 8339, frame interval: 40000
2007-11-22 21:03:44.424 OpenGLVideoSync::Start(): A/V Sync reported error: Bad Context
2007-11-22 21:03:44.426 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2007-11-22 21:03:44.427 VideoOutputXv: Closing XVideo port 73
2007-11-22 21:03:44.431 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: opengl,xv-blit,xshm,xlib
2007-11-22 21:03:44.438 VDP: Accepting: cmp(<= 720 576,> 0 0) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,greedyhdoubleprocessdeint) filt()
2007-11-22 21:03:44.438 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(ffmpeg) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,none) filt()
2007-11-22 21:03:44.438 VDP: Accepting: cmp(<= 1280 720,> 720 576) dec(libmpeg2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:44.439 VDP: Accepting: cmp(> 0 0) dec(xvmc) rend(xvmc-blit) osd(ia44blend) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:44.439 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) rend(xv-blit) osd(chromakey) osdfade(disabled) deint(bobdeint,onefield) filt()
2007-11-22 21:03:44.439 VDP: LoadBestPreferences(2048x2048, 0)
2007-11-22 21:03:44.440 VDP: LoadBestPreferences(2048x2048, 60)
2007-11-22 21:03:44.440 VDP: LoadBestPreferences(720x576, 60)
2007-11-22 21:03:44.440 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  10
2007-11-22 21:03:44.440 VideoOutputXv: Adaptor#0: Intel(R) Textured Video has flag[s]: XvInputMask XvImageMask 
2007-11-22 21:03:44.441 VideoOutputXv: Has XVideo flags...
2007-11-22 21:03:44.441 VideoOutputXv: Has XV_BRIGHTNESS...
2007-11-22 21:03:44.441 VideoOutputXv: Here...
2007-11-22 21:03:44.441 VideoOutputXv: Grabbed xv port 73
2007-11-22 21:03:44.441 VideoOutputXv: XVideo surface found on port 73
2007-11-22 21:03:44.441 VideoOutputXv: XVideo Adaptor Name: 'Intel(R) Textured Video'
2007-11-22 21:03:44.442 VideoOutputXv: XVideo Format #0 is 'YUY2'
2007-11-22 21:03:44.442 VideoOutputXv: XVideo Format #1 is 'YV12'
2007-11-22 21:03:44.442 VideoOutputXv: XVideo Format #2 is 'I420'
2007-11-22 21:03:44.442 VideoOutputXv: XVideo Format #3 is 'UYVY'
2007-11-22 21:03:44.442 VideoOutputXv: Using XVideo Format 'YV12'
2007-11-22 21:03:44.443 VideoOutputXv: CreateShmImages(32): video_dim: 720x576
2007-11-22 21:03:44.580 VDP: SetVideoRenderer(xv-blit)
2007-11-22 21:03:44.580 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2007-11-22 21:03:44.580 VideoOutputXv: Chromakeying not possible with this XVideo port.
2007-11-22 21:03:44.581 Snapping height to avoid scaling: height: 576, top: 12
2007-11-22 21:03:44.581 Display Rect  left: 80, top: 12, width: 799, height: 576, aspect: 1.6015
2007-11-22 21:03:44.581 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2007-11-22 21:03:44.763 NVP: ClearAfterSeek(1)
2007-11-22 21:03:44.763 VideoOutputXv: ClearAfterSeek()
2007-11-22 21:03:44.763 VideoOutputXv: DiscardFrames(0)
2007-11-22 21:03:44.764 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2007-11-22 21:03:44.764 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2007-11-22 21:03:44.764 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2007-11-22 21:03:44.764 NVP: LoadFilters(''..) -> 0
2007-11-22 21:03:44.764 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2007-11-22 21:03:44.765 AFD: Using ffmpeg for video decoding
2007-11-22 21:03:44.765 AFD: Looking for decoder for MPEG2VIDEO
2007-11-22 21:03:44.765 AFD: Opened codec 0xb3d35d10, id(MPEG2VIDEO) type(Video)
2007-11-22 21:03:44.765 AFD: Stream #1, has id 0x202 codec id MP3, type Audio, bitrate 192000 at 0x0xb3d817b0
2007-11-22 21:03:44.765 AFD: Looking for decoder for MP3
2007-11-22 21:03:44.765 AFD: Opened codec 0xaaeabdb0, id(MP3) type(Audio)
2007-11-22 21:03:44.765 AFD: Stream #2, has id 0x203 codec id MP3, type Audio, bitrate 128000 at 0x0xb3d97b50
2007-11-22 21:03:44.766 AFD: Looking for decoder for MP3
2007-11-22 21:03:44.766 AFD: Opened codec 0xad4d3570, id(MP3) type(Audio)
2007-11-22 21:03:44.766 AFD: Stream #3, has id 0x204 codec id DVB_VBI, type Data, bitrate 0 at 0x0xb3d4d0b0
2007-11-22 21:03:44.766 AFD: data codec (Data)
2007-11-22 21:03:44.766 AFD: Stream #4, has id 0x3072 codec id DSMCC_B, type Data, bitrate 0 at 0x0xad4e4f80
2007-11-22 21:03:44.766 AFD: data codec (Data)
2007-11-22 21:03:44.766 AFD: Stream #5, has id 0x5074 codec id DSMCC_B, type Data, bitrate 0 at 0x0xb3d9f3d0
2007-11-22 21:03:44.766 AFD: data codec (Data)
2007-11-22 21:03:44.894 RingBuf(/home/mythtv/recordings/1002_20071122210335.mpg): CalcReadAheadThresh(0 KB)
                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2007-11-22 21:03:44.898 Opening ALSA audio device 'default'.
2007-11-22 21:03:45.035 NVP: Enabling Audio
2007-11-22 21:03:45.035 Dec: Trying to select track (w/lang)
2007-11-22 21:03:45.035 Dec: Selecting first track
2007-11-22 21:03:45.036 Dec: Selected track #1 in the Unknown language(0)
2007-11-22 21:03:45.036 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
2007-11-22 21:03:45.038 Position map filled from DB to: 131
2007-11-22 21:03:45.038 SyncPositionMap watchingrecording, from DB: 11 entries
2007-11-22 21:03:45.039 Filling position map from 132 to 244
2007-11-22 21:03:45.040 Position map filled from Encoder to: 239
2007-11-22 21:03:45.040 SyncPositionMap watchingrecording total: 20 entries
2007-11-22 21:03:45.040 SyncPositionMap, new totframes: 239, new length: 9, posMap size: 20
2007-11-22 21:03:45.041 AFD: Partial position map found
2007-11-22 21:03:45.041 AFD: Successfully opened decoder for file: "/home/mythtv/recordings/1002_20071122210335.mpg". novideo(0)
2007-11-22 21:03:45.044 NVP: DoPlay: rate: 25 speed: 1 skip: 1 => new interval 40000
2007-11-22 21:03:45.045 Set video sync frame interval to 40000
2007-11-22 21:03:45.045 NVP: Stretch Factor 1, allow passthru 
2007-11-22 21:03:45.075 RingBuf(/home/mythtv/recordings/1002_20071122210335.mpg): CalcReadAheadThresh(2852121488 KB)
                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2007-11-22 21:03:45.075 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
2007-11-22 21:03:45.077 Position map filled from DB to: 131
2007-11-22 21:03:45.077 SyncPositionMap watchingrecording, from DB: 11 entries
2007-11-22 21:03:45.078 Filling position map from 132 to 246
2007-11-22 21:03:45.079 Position map filled from Encoder to: 239
2007-11-22 21:03:45.079 SyncPositionMap watchingrecording total: 20 entries
2007-11-22 21:03:47.232 NVP: Timed out waiting for free video buffers.
2007-11-22 21:03:47.586 OpenGLVideoSync::Start(): A/V Sync reported error: Bad Context
greedyhdeint: RESET LAST FRAME
2007-11-22 21:03:47.653 WriteAudio: buffer underrun
2007-11-22 21:03:47.658 NVP: Video is 3.45 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.667 NVP: Video is 5.8125 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.676 NVP: Video is 7.38438 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.684 NVP: Video is 8.37578 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.694 NVP: Video is 8.92558 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.701 NVP: Video is 9.14417 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.709 NVP: Video is 9.10188 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.716 NVP: Video is 8.8639 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.726 NVP: Video is 8.49792 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.734 NVP: Video is 8.02343 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.741 NVP: Video is 7.4613 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.751 NVP: Video is 6.83973 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.758 NVP: Video is 6.17978 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.766 NVP: Video is 5.48483 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.773 NVP: Video is 4.7636 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.781 NVP: Video is 4.01645 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:47.789 NVP: Video is 3.25607 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:49.812 NVP: Timed out waiting for free video buffers.
2007-11-22 21:03:50.800 First A/V Sync reported error: Bad Context
2007-11-22 21:03:50.816 WriteAudio: buffer underrun
2007-11-22 21:03:50.819 NVP: Video is 5.2081 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.829 NVP: Video is 7.01232 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.847 NVP: Video is 8.19048 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.868 NVP: Video is 8.9241 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.879 NVP: Video is 9.35557 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.890 NVP: Video is 9.49792 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.904 NVP: Video is 9.42342 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.915 NVP: Video is 9.2113 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.930 NVP: Video is 8.86473 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.946 NVP: Video is 8.45477 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.959 NVP: Video is 7.99732 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.969 NVP: Video is 7.47923 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.979 NVP: Video is 6.90315 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:50.992 NVP: Video is 6.28985 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.004 NVP: Video is 5.65487 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.019 NVP: Video is 5.0099 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.031 NVP: Video is 4.36993 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.041 NVP: Video is 3.71493 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.055 NVP: Video is 3.03618 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.497 NVP: Video is 3.3544 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.506 NVP: Video is 3.6158 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.514 NVP: Video is 3.61185 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.522 NVP: Video is 3.40887 frames behind audio (too slow), dropping frame to catch up.
2007-11-22 21:03:51.533 NVP: Video is 3.05665 frames behind audio (too slow), dropping frame to catch up.
Signal: Interrupt
Ungrabbing XVideo port: 73
Mutex destroy failure: Device or resource busy


More information about the mythtv-dev mailing list