[mythtv-users] VDPAU Issues?

robert Larson dewmanstl at gmail.com
Wed Jan 26 23:38:04 UTC 2011


Hey Everyone,
Last night the wife and I were watching a show that was being recorded
(even though I know that this isn't the design of myth) however, when
watching the show the sytem would stutter at times. So checking the
log file I came across some items I am not to sure about and thought
that maybe there might be an issue with VDPAU.


Here is some snippets:

First the version:

 mythbackend --version
Please attach all output as a file in bug reports.
MythTV Version   : v0.24-116-g61c78f5
MythTV Branch    : fixes/0.24
Network Protocol : 63
Library API      : 0.24.20101129-1
QT Version       : 4.6.2
Options compiled in:
 linux debug using_alsa using_jack using_oss using_pulse
using_pulseoutput using_backend using_bindings_perl
using_bindings_python using_directfb using_dvb using_firewire
using_frontend using_hdhomerun using_hdpvr using_iptv using_ivtv
using_joystick_menu using_lirc using_mheg using_opengl_video
using_opengl_vsync using_qtdbus using_qtwebkit using_v4l using_x11
using_xrandr using_xv using_bindings_perl using_bindings_python
using_mythtranscode using_opengl using_vdpau using_ffmpeg_threads
using_live using_mheg

Now the Python Bindings:

 mythpython --version
MythTV Python Bindings
  local versions
    bindings version:   0.24.0.1
    ttvdb version:      1.2.1
    tmdb version:       v0.2.5
  external versions
    lxml version:       2.2.4
    MySQLdb version:    1.2.2.final.0
  protocol versions
    backend:            63
    schema:             1264
    video schema:       1038
    music schema:       1017
    netvision schema:   1007

And finally the entries from the frontend log:

2011-01-25 20:13:09.265 NetworkControl: New connection established.
2011-01-25 20:13:19.268 TV: Attempting to change from None to WatchingRecording
2011-01-25 20:13:19.382 MythCoreContext: Connecting to backend server:
192.168.1.251:6543 (try 1 of 1)
2011-01-25 20:13:19.383 Using protocol version 63
2011-01-25 20:13:19.716 AFD: Opened codec 0xaf1f2f10, id(MPEG2VIDEO) type(Video)
2011-01-25 20:13:19.717 AFD: codec AC3 has 2 channels
2011-01-25 20:13:19.717 AFD: Opened codec 0xaf1ecf20, id(AC3) type(Audio)
2011-01-25 20:13:19.798 AO: Opening audio device '/dev/dsp' ch 2(2) sr
48000 sf signed 16 bit reenc 0
2011-01-25 20:13:19.810 AudioPlayer: Enabling Audio
2011-01-25 20:13:19.927 Clearing OpenGL painter cache.
2011-01-25 20:13:20.163 VDPAU: Created 2 output surfaces.
2011-01-25 20:13:20.163 VDPAU: Version 1
2011-01-25 20:13:20.163 VDPAU: Information NVIDIA VDPAU Driver Shared
Library  270.18  Tue Jan 18 22:04:57 PST 2011
2011-01-25 20:13:20.164 VDPAU: Created VDPAU render device 1280x720
2011-01-25 20:13:20.266 Player(0): Forcing decode extra audio option
on (Video method requires it).
2011-01-25 20:13:20.275 FilterManager: Failed to load filter
'colorspace', no such filter exists
2011-01-25 20:13:20.283 OSD: Base theme size: 1280x720
2011-01-25 20:13:20.283 OSD: Scaling factors: 1x1
2011-01-25 20:13:20.535 OSD: Base theme size: 1280x720
2011-01-25 20:13:20.535 OSD: Scaling factors: 1x1
2011-01-25 20:13:20.619 Player(0): Video sync method can't support
double framerate (refresh rate too low for 2x deint)
2011-01-25 20:13:20.621 Player(0): Video timing method: USleep with busy wait
2011-01-25 20:13:20.623 TV: Changing from None to WatchingRecording
2011-01-25 20:13:20.652 VDPAU: Added 2 output surfaces (total 4, max 4)

Then about 2 seconds later there is roughly 30 lines of this
Player(0): Waited 100ms for video buffers AAAAAAAAAAAAAaALL


Here is a a backend section:

2011-01-25 20:13:24.670 RecBase(1:1):
GetKeyframePositions(49582,9223372036854775807,#19) out of 3421
2011-01-25 20:13:45.618 AutoExpire: CalcParams(): Max required Free
Space: 3.0 GB w/freq: 7 min
2011-01-25 20:17:04.839 MainServer::ANN Monitor
2011-01-25 20:17:04.851 adding: dell as a client (events: 2)
2011-01-25 20:20:04.173 MainServer::ANN Monitor
2011-01-25 20:20:04.185 adding: dell as a client (events: 0)
2011-01-25 20:20:35.200 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:20:46.595 AutoExpire: CalcParams(): Max required Free
Space: 3.0 GB w/freq: 7 min
2011-01-25 20:20:58.988 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:21:08.491 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:21:08.509 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:22:41.198 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:22:51.831 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:23:00.170 UPnpMedia: BuildMediaMap VIDEO scan starting
in :/media/extv/videos/:
2011-01-25 20:23:00.268 UPnpMedia: BuildMediaMap Done. Found 69 objects
2011-01-25 20:23:31.870 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:23:31.886 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:24:11.229 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:24:19.553 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:25:30.807 RecBase(1:1):
GetKeyframePositions(49864,9223372036854775807,#2986) out of 6407
2011-01-25 20:25:40.999 RecBase(1:1):
GetKeyframePositions(93394,9223372036854775807,#41) out of 6448
2011-01-25 20:25:44.386 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:26:05.072 RecBase(1:1):
GetKeyframePositions(94000,9223372036854775807,#100) out of 6548
2011-01-25 20:26:40.380 RecBase(1:1):
GetKeyframePositions(95440,9223372036854775807,#147) out of 6695
2011-01-25 20:27:26.824 RecBase(1:1):
GetKeyframePositions(97558,9223372036854775807,#189) out of 6884
2011-01-25 20:27:47.594 AutoExpire: CalcParams(): Max required Free
Space: 3.0 GB w/freq: 7 min
2011-01-25 20:27:52.604 RecBase(1:1):
GetKeyframePositions(100351,9223372036854775807,#104) out of 6988
2011-01-25 20:28:06.501 RecBase(1:1):
GetKeyframePositions(101893,9223372036854775807,#57) out of 7045
2011-01-25 20:28:20.385 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:30:04.301 MainServer::ANN Monitor
2011-01-25 20:30:04.313 adding: dell as a client (events: 0)
2011-01-25 20:30:35.489 [mpeg2video @ 0x1215aa0]invalid mb type in B
Frame at 72 20
2011-01-25 20:30:35.504 [mpeg2video @ 0x1215aa0]Warning MVs not available
2011-01-25 20:32:23.485 [mpeg2video @ 0x1215aa0]mb incr damaged
2011-01-25 20:32:23.496 [mpeg2video @ 0x1215aa0]Warning MVs not available
2011-01-25 20:34:48.516 AutoExpire: CalcParams(): Max required Free
Space: 3.0 GB w/freq: 7 min
2011-01-25 20:38:18.122 RecBase(1:1):
GetKeyframePositions(102733,9223372036854775807,#2506) out of 9551
2011-01-25 20:39:08.402 RecBase(1:1):
GetKeyframePositions(139387,9223372036854775807,#207) out of 9758
2011-01-25 20:39:23.658 RecBase(1:1):
GetKeyframePositions(142396,9223372036854775807,#63) out of 9821
2011-01-25 20:39:23.835 AFD: Audio stream changed
2011-01-25 20:39:38.599 RecBase(1:1):
GetKeyframePositions(143314,9223372036854775807,#62) out of 9883
2011-01-25 20:40:03.902 MainServer::ANN Monitor
2011-01-25 20:40:03.917 adding: dell as a client (events: 0)
2011-01-25 20:41:40.775 AFD: Audio stream changed
2011-01-25 20:41:49.510 AutoExpire: CalcParams(): Max required Free
Space: 3.0 GB w/freq: 7 min
2011-01-25 20:42:17.995 RecBase(1:1):
GetKeyframePositions(144208,9223372036854775807,#652) out of 10535
2011-01-25 20:47:53.265 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:48:50.479 AutoExpire: CalcParams(): Max required Free
Space: 3.0 GB w/freq: 7 min
2011-01-25 20:48:56.065 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:49:45.896 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:50:04.478 MainServer::ANN Monitor
2011-01-25 20:50:04.486 adding: dell as a client (events: 0)
2011-01-25 20:51:34.620 RecBase(1:1):
GetKeyframePositions(153763,9223372036854775807,#2304) out of 12839
2011-01-25 20:52:36.513 Error: offset>181, pes length & current cannot
be queried
2011-01-25 20:53:06.290 UPnpMedia: BuildMediaMap VIDEO scan starting
in :/media/extv/videos/:
2011-01-25 20:53:06.450 UPnpMedia: BuildMediaMap Done. Found 69 objects
2011-01-25 20:53:54.564 RecBase(1:1):
GetKeyframePositions(187129,9223372036854775807,#578) out of 13417
2011-01-25 20:54:55.757 RecBase(1:1):
GetKeyframePositions(195514,9223372036854775807,#252) out of 13669
2011-01-25 20:55:51.473 AutoExpire: CalcParams(): Max required Free
Space: 3.0 GB w/freq: 7 min
2011-01-25 20:56:00.206 RecBase(1:1):
GetKeyframePositions(199189,9223372036854775807,#265) out of 13934
2011-01-25 20:56:48.802 RecBase(1:1):
GetKeyframePositions(203047,9223372036854775807,#198) out of 14132
2011-01-25 21:00:04.427 MainServer::ANN Monitor
2011-01-25 21:00:04.440 adding: dell as a client (events: 0)
2011-01-25 21:00:30.021 TVRec(1): Changing from RecordingOnly to None
2011-01-25 21:00:30.137 Finished recording The Biggest Loser: channel 1251
2011-01-25 21:00:30.140 Updating status for "The Biggest Loser" on
cardid 1 (Recording => Recorded)
2011-01-25 21:00:30.234 scheduler: Finished recording: The Biggest
Loser: channel 1251
2011-01-25 21:00:30.283 Reschedule requested for id 0.
2011-01-25 21:00:30.665 Finished recording The Biggest Loser: channel 1251
2011-01-25 21:00:30.670 MainServer, Error: PREVIEW_SUCCESS but no receivers.
2011-01-25 21:00:30.964 TVRec(4): Changing from RecordingOnly to None


And last a snip of Xorg.log

(--) PCI:*(0:1:0:0) 10de:0421:1682:230a nVidia Corporation G86
[GeForce 8500 GT] rev 161, Mem @ 0xde000000/16777216,
0xc0000000/268435456, 0xdc000000/33554432, I/O @ 0x0000dc80/128, BIOS
@ 0x????????/131072
(--) PCI: (0:4:2:0) 14f1:8800:11bd:0051 Conexant Systems, Inc.
CX23880/1/2/3 PCI Video and Audio Decoder rev 5, Mem @
0xd8000000/16777216
(II) Open ACPI successful (/var/run/acpid.socket)
(II) LoadModule: "extmod"
(II) Loading /usr/lib/xorg/modules/extensions/libextmod.so
(II) Module extmod: vendor="X.Org Foundation"
	compiled for 1.7.6, module version = 1.0.0
	Module class: X.Org Server Extension
	ABI class: X.Org Server Extension, version 2.0
(II) Loading extension MIT-SCREEN-SAVER
(II) Loading extension XFree86-VidModeExtension
(II) Loading extension XFree86-DGA
(II) Loading extension DPMS
(II) Loading extension XVideo
(II) Loading extension XVideo-MotionCompensation
(II) Loading extension X-Resource
(II) LoadModule: "dbe"
(II) Loading /usr/lib/xorg/modules/extensions/libdbe.so
(II) Module dbe: vendor="X.Org Foundation"
	compiled for 1.7.6, module version = 1.0.0
	Module class: X.Org Server Extension
	ABI class: X.Org Server Extension, version 2.0
(II) Loading extension DOUBLE-BUFFER
(II) LoadModule: "glx"
(II) Loading /usr/lib/xorg/extra-modules/libglx.so
(II) Module glx: vendor="NVIDIA Corporation"
	compiled for 4.0.2, module version = 1.0.0
	Module class: X.Org Server Extension
(II) NVIDIA GLX Module  270.18  Tue Jan 18 22:02:12 PST 2011
(II) Loading extension GLX
(II) LoadModule: "record"
(II) Loading /usr/lib/xorg/modules/extensions/librecord.so
(II) Module record: vendor="X.Org Foundation"
	compiled for 1.7.6, module version = 1.13.0
	Module class: X.Org Server Extension
	ABI class: X.Org Server Extension, version 2.0
(II) Loading extension RECORD
(II) LoadModule: "dri"
(II) Loading /usr/lib/xorg/modules/extensions/libdri.so
(II) Module dri: vendor="X.Org Foundation"
	compiled for 1.7.6, module version = 1.0.0
	ABI class: X.Org Server Extension, version 2.0
(II) Loading extension XFree86-DRI
(II) LoadModule: "dri2"
(II) Loading /usr/lib/xorg/modules/extensions/libdri2.so
(II) Module dri2: vendor="X.Org Foundation"
	compiled for 1.7.6, module version = 1.1.0
	ABI class: X.Org Server Extension, version 2.0
(II) Loading extension DRI2
(II) LoadModule: "nvidia"
(II) Loading /usr/lib/xorg/extra-modules/nvidia_drv.so
(II) Module nvidia: vendor="NVIDIA Corporation"
	compiled for 4.0.2, module version = 1.0.0
	Module class: X.Org Video Driver
(II) NVIDIA dlloader X Driver  270.18  Tue Jan 18 21:46:12 PST 2011
(II) NVIDIA Unified Driver for all Supported NVIDIA GPUs
(II) Primary Device is: PCI 01 at 00:00:0
(II) Loading sub module "fb"
(II) LoadModule: "fb"
(II) Loading /usr/lib/xorg/modules/libfb.so
(II) Module fb: vendor="X.Org Foundation"
	compiled for 1.7.6, module version = 1.0.0
	ABI class: X.Org ANSI C Emulation, version 0.4
(II) Loading sub module "wfb"
(II) LoadModule: "wfb"
(II) Loading /usr/lib/xorg/modules/libwfb.so
(II) Module wfb: vendor="X.Org Foundation"
	compiled for 1.7.6, module version = 1.0.0
	ABI class: X.Org ANSI C Emulation, version 0.4
(II) Loading sub module "ramdac"
(II) LoadModule: "ramdac"
(II) Module "ramdac" already built-in
(**) NVIDIA(0): Depth 16, (--) framebuffer bpp 16
(==) NVIDIA(0): RGB weight 565
(==) NVIDIA(0): Default visual is TrueColor
(==) NVIDIA(0): Using gamma correction (1.0, 1.0, 1.0)
(**) NVIDIA(0): Option "NoLogo" "True"
(**) NVIDIA(0): Option "TwinView" "0"
(**) NVIDIA(0): Option "MetaModes" "1280x720 +0+0; nvidia-auto-select +0+0"
(**) NVIDIA(0): Option "CustomEDID" "DFP-0:/etc/X11/edid.bin"
(**) NVIDIA(0): Option "TVOverScan" "3.0"
(**) Jan 25 14:52:02 NVIDIA(0): Enabling RENDER acceleration
(II) Jan 25 14:52:02 NVIDIA(0): Support for GLX with the Damage and
Composite X extensions is
(II) Jan 25 14:52:02 NVIDIA(0):     enabled.
(II) Jan 25 14:52:03 NVIDIA(GPU-0): Display (SAMSUNG DLP (DFP-0)) does
not support NVIDIA 3D
(II) Jan 25 14:52:03 NVIDIA(GPU-0):     Vision stereo.
(II) Jan 25 14:52:03 NVIDIA(0): NVIDIA GPU GeForce 8500 GT (G86) at
PCI:1:0:0 (GPU-0)
(--) Jan 25 14:52:03 NVIDIA(0): Memory: 524288 kBytes
(--) Jan 25 14:52:03 NVIDIA(0): VideoBIOS: 60.86.34.00.75
(II) Jan 25 14:52:03 NVIDIA(0): Detected PCI Express Link width: 16X
(--) Jan 25 14:52:03 NVIDIA(0): Interlaced video modes are supported on this GPU
(--) Jan 25 14:52:03 NVIDIA(0): Connected display device(s) on GeForce
8500 GT at PCI:1:0:0
(--) Jan 25 14:52:03 NVIDIA(0):     SAMSUNG DLP (DFP-0)
(--) Jan 25 14:52:03 NVIDIA(0): SAMSUNG DLP (DFP-0): 330.0 MHz maximum
pixel clock
(--) Jan 25 14:52:03 NVIDIA(0): SAMSUNG DLP (DFP-0): Internal Dual Link TMDS
(II) Jan 25 14:52:04 NVIDIA(0): Assigned Display Device: DFP-0
(II) Jan 25 14:52:04 NVIDIA(0): Validated modes:
(II) Jan 25 14:52:04 NVIDIA(0):     "1280x720+0+0"
(II) Jan 25 14:52:04 NVIDIA(0):     "nvidia-auto-select+0+0"
(II) Jan 25 14:52:04 NVIDIA(0): Virtual screen size determined to be 1280 x 720
(--) Jan 25 14:52:04 NVIDIA(0): DPI set to (29, 29); computed from
"UseEdidDpi" X config
(--) Jan 25 14:52:04 NVIDIA(0):     option
(==) Jan 25 14:52:04 NVIDIA(0): Disabling 32-bit ARGB GLX visuals.
(II) Jan 25 14:52:04 NVIDIA: Using 768.00 MB of virtual memory for
indirect memory access.
(II) Jan 25 14:52:04 NVIDIA(0): Initialized GPU GART.
(II) Jan 25 14:52:04 NVIDIA(0): Setting mode "1280x720+0+0"
(II) Loading extension NV-GLX
(II) Jan 25 14:52:04 NVIDIA(0): Initialized OpenGL Acceleration
(==) NVIDIA(0): Disabling shared memory pixmaps
(II) Jan 25 14:52:04 NVIDIA(0): Initialized X Rendering Acceleration
(==) NVIDIA(0): Backing store disabled
(==) NVIDIA(0): Silken mouse enabled
(**) NVIDIA(0): DPMS enabled
(II) Loading extension NV-CONTROL
(II) Loading extension XINERAMA
(WW) NVIDIA(0): Option "UseDisp;ayDevice" is not used
(==) RandR enabled
(II) Initializing built-in extension Generic Event Extension
(II) Initializing built-in extension SHAPE
(II) Initializing built-in extension MIT-SHM
(II) Initializing built-in extension XInputExtension
(II) Initializing built-in extension XTEST
(II) Initializing built-in extension BIG-REQUESTS
(II) Initializing built-in extension SYNC
(II) Initializing built-in extension XKEYBOARD
(II) Initializing built-in extension XC-MISC
(II) Initializing built-in extension SECURITY
(II) Initializing built-in extension XINERAMA
(II) Initializing built-in extension XFIXES
(II) Initializing built-in extension RENDER
(II) Initializing built-in extension RANDR
(II) Initializing built-in extension COMPOSITE
(II) Initializing built-in extension DAMAGE
(II) Initializing extension GLX


So with all of this info I did notice a whole bunch of items that I am
not sure about, I guess what I am asking for is maybe a health check
of some of the errors? or events that are getting logged.

Thanks Again

Rob


More information about the mythtv-users mailing list