Anonymous

Mythfrontend:

2006-02-25 22:24:27.699 Using runtime prefix = /usr/local
2006-02-25 22:24:27.813 New DB connection, total: 1
2006-02-25 22:24:27.816 Connected to database 'mythconverg' at host: localhost
2006-02-25 22:24:27.819 Total desktop dim: 1024x768, with 2 screen[s].
2006-02-25 22:24:27.824 Using screen 0, 1024x768 at 0,0
2006-02-25 22:24:27.830 Current Schema Version: 1123
2006-02-25 22:24:27.831 mythfrontend version: 0.19.20060121-2 www.mythtv.org
2006-02-25 22:24:27.831 Enabled verbose msgs:  important general
2006-02-25 22:24:28.250 lang0: nor
2006-02-25 22:24:28.250 lang: nor
2006-02-25 22:24:28.259 lang1: eng
2006-02-25 22:24:28.259 lang: eng
2006-02-25 22:24:28.349 Total desktop dim: 1024x768, with 2 screen[s].
2006-02-25 22:24:28.353 Using screen 0, 1024x768 at 0,0
2006-02-25 22:24:28.355 Switching to square mode (G.A.N.T.)
2006-02-25 22:24:28.860 Joystick disabled.
2006-02-25 22:24:28.950 Registering Internal as a media playback plugin.
2006-02-25 22:24:28.972 Registering MythDVD DVD Media Handler as a media handler
2006-02-25 22:24:28.973 Registering MythDVD VCD Media Handler as a media handler
2006-02-25 22:24:29.311 Registering MythMusic Media Handler as a media handler
2006-02-25 22:24:29.797 Mediamonitor: Adding /dev/cdrom
2006-02-25 22:24:29.799 Mediamonitor: Adding /dev/fd0
2006-02-25 22:24:29.800 Starting media monitor.
2006-02-25 22:24:35.563 New DB connection, total: 2
2006-02-25 22:24:35.564 Connected to database 'mythconverg' at host: localhost
2006-02-25 22:24:35.615 Connecting to backend server: localhost:6543 (try 1 of 5)
2006-02-25 22:24:35.629 Using protocol version 26
2006-02-25 22:24:35.669 TV: Attempting to change from None to WatchingLiveTV
2006-02-25 22:24:35.689 Using protocol version 26
2006-02-25 22:24:38.552 RingBuf(/mnt/store//1010_20060225222435.mpg): Timing out wait dueto impending livetv switch.
0: start_time: -9223372036854.775 duration: -9223372036854.775
stream: start_time: -9223372036854.775 duration: -9223372036854.775 bitrate=0 kb/s
2006-02-25 22:24:38.563 AFD: Opened codec 0x8271150, id(MPEG1VIDEO) type(Video)
2006-02-25 22:24:38.563 NVP: Disabling Audio, params(-1,-1,-1)
2006-02-25 22:24:38.563 NVP: Disabling Audio, params(0,-1,-1)
X Error: BadMatch (invalid parameter attributes) 8
  Major opcode:  142
  Minor opcode:  14
  Resource id:  0x1c3
2006-02-25 22:24:38.919 VideoOutputXv Error: Couldn't get the color key color,
                        probably due to a driver bug or limitation.
                        You might not get any video, but we'll try anyway.
2006-02-25 22:24:40.673 TV: Changing from None to WatchingLiveTV
2006-02-25 22:24:40.683 New DB connection, total: 3
2006-02-25 22:24:40.735 New DB connection, total: 4
2006-02-25 22:24:40.735 The realtime priority setting is not enabled.
2006-02-25 22:24:40.913 Video timing method: USleep with busy wait
2006-02-25 22:24:41.936 NVP: Prebuffer wait timed out 10 times.
2006-02-25 22:24:42.701 Connected to database 'mythconverg' at host: localhost
2006-02-25 22:24:42.706 Connected to database 'mythconverg' at host: localhost
2006-02-25 22:24:42.719 LiveTV forcing JumpTo 1
2006-02-25 22:24:42.776 NVP: Prebuffer wait timed out 10 times.
0: start_time: 1028.490 duration: 0.400
1: start_time: 1028.454 duration: 0.369
stream: start_time: 11427.270 duration: 4.832 bitrate=3728 kb/s
2006-02-25 22:24:43.708 AFD: Opened codec 0x82ab260, id(MPEG2VIDEO) type(Video)
2006-02-25 22:24:43.737 AFD: Opened codec 0x84a3580, id(MP3) type(Audio)
2006-02-25 22:24:43.740 Opening audio device '/dev/sound/dsp'.
2006-02-25 22:24:43.740 Opening OSS audio device '/dev/sound/dsp'.
2006-02-25 22:24:43.751 NVP: Enabling Audio
2006-02-25 22:25:12.158 TV: Attempting to change from WatchingLiveTV to None
2006-02-25 22:25:12.647 TV: Changing from WatchingLiveTV to None

Mythtv:
2006-02-25 22:27:13.419 Using runtime prefix = /usr/local
2006-02-25 22:27:13.546 New DB connection, total: 1
2006-02-25 22:27:13.549 Connected to database 'mythconverg' at host: localhost
2006-02-25 22:27:13.552 Total desktop dim: 1024x768, with 2 screen[s].
2006-02-25 22:27:13.557 Using screen 0, 1024x768 at 0,0
2006-02-25 22:27:13.618 Total desktop dim: 1024x768, with 2 screen[s].
2006-02-25 22:27:13.622 Using screen 0, 1024x768 at 0,0
2006-02-25 22:27:13.624 Switching to square mode (G.A.N.T.)
2006-02-25 22:27:14.660 New DB connection, total: 2
2006-02-25 22:27:14.662 Joystick disabled.
2006-02-25 22:27:14.663 Connected to database 'mythconverg' at host: localhost
2006-02-25 22:27:14.721 Connecting to backend server: localhost:6543 (try 1 of 5)
2006-02-25 22:27:14.740 Using protocol version 26
2006-02-25 22:27:14.778 TV: Attempting to change from None to WatchingLiveTV
2006-02-25 22:27:14.803 Using protocol version 26
2006-02-25 22:27:15.761 LiveTVChain(live-kenneth-2006-02-25T22:27:14): ReloadAll(): Addednew recording
2006-02-25 22:27:15.765 RingBuf(myth://localhost:6543/1010_20060225222714.mpg): OpenFile(myth://localhost:6543/1010_20060225222714.mpg, 12)
2006-02-25 22:27:15.792 TV: StartRecorder(): took 24 ms to start recorder.
2006-02-25 22:27:15.801 TV: GetLockTimeout(1): Set lock timeout to 6000 ms
mpegts_add_stream: at pid 0x21 with type 2
mpegts_add_stream: stream #0, has id 0x21 and codec MPEG2VIDEO, type Video at 0x80edc60
2006-02-25 22:27:16.631 LiveTVChain(live-kenneth-2006-02-25T22:27:14): ReloadAll(): Addednew recording
2006-02-25 22:27:16.631 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
2006-02-25 22:27:16.669 Position map filled from DB to: 11
2006-02-25 22:27:16.669 SyncPositionMap watchingrecording, from DB: 2 entries
2006-02-25 22:27:16.669 SyncPositionMap watchingrecording no entries from encoder, try DB
2006-02-25 22:27:16.749 Position map filled from DB to: 11
2006-02-25 22:27:16.756 SyncPositionMap watchingrecording total: 2 entries
2006-02-25 22:27:16.757 SyncPositionMap, new totframes: 11, new length: 0, posMap size: 2
2006-02-25 22:27:17.117 LiveTVChain(live-kenneth-2006-02-25T22:27:14): SwitchTo(1)
2006-02-25 22:27:17.117 LiveTVChain(live-kenneth-2006-02-25T22:27:14): Entry@1: '1010_20060225222716'
2006-02-25 22:27:17.374 RingBuf(/mnt/store//1010_20060225222714.mpg): Timing out wait dueto impending livetv switch.
0: start_time: -9223372036854.775 duration: -9223372036854.775
stream: start_time: -9223372036854.775 duration: -9223372036854.775 bitrate=0 kb/s
2006-02-25 22:27:17.383 AFD: Stream #0, has id 0x33 codec id MPEG1VIDEO, type Video at 0x0x80edc60
2006-02-25 22:27:17.407 detectInterlace(Detect Scan, Detect Scan, 50, 576) ->Progressive Scan
2006-02-25 22:27:17.407 Interlaced: Progressive Scan  video_height: 576  fps: 50
2006-02-25 22:27:17.408 AFD: Looking for decoder for MPEG1VIDEO
2006-02-25 22:27:17.408 AFD: Opened codec 0x80f14f0, id(MPEG1VIDEO) type(Video)
2006-02-25 22:27:17.409 RingBuf(/mnt/store//1010_20060225222714.mpg): CalcReadAheadThresh(1152 KB)
                         -> threshhold(128 KB) min read(32 KB) blk size(128 KB)
2006-02-25 22:27:17.409 NVP: Disabling Audio, params(-1,-1,-1)
2006-02-25 22:27:17.409 NVP: Disabling Audio, params(0,-1,-1)
Input #0, mpegts, from '/mnt/store//1010_20060225222714.mpg':
  Duration: N/A, bitrate: N/A
  Stream #0.0[0x21], 1/90000, 50.00 fps(r): Video: mpeg1video, yuv420p, 768x576, 1/50, 1152 kb/s
2006-02-25 22:27:17.409 AFD: Partial position map found
2006-02-25 22:27:17.410 AFD: Successfully opened decoder for file: "/mnt/store//1010_20060225222714.mpg". novideo(0)
2006-02-25 22:27:17.412 VideoOutputXv: ctor
2006-02-25 22:27:17.583 Over/underscan. V: 0, H: 0, XOff: 0, YOff: 0
2006-02-25 22:27:17.589 Image size. dispxoff 0, dispyoff: 0, dispwoff: 1024, disphoff: 768
2006-02-25 22:27:17.589 Image size. imgx 0, imgy: 0, imgw: 768, imgh: 576
2006-02-25 22:27:17.589 VideoOutputXv: Pixel dimensions: Screen 1024x768, window 1024x768
2006-02-25 22:27:17.632 VideoOutputXv: Estimated display dimensions: 321x241 mm Aspect: 1.33195
2006-02-25 22:27:17.633 VideoOutputXv: Estimated window dimensions: 321x241 mm Aspect: 1.33195
2006-02-25 22:27:17.792 VideoOutputXv: @ j=3 Looking for flag[s]: XvInputMask XvImageMask
2006-02-25 22:27:17.792 VideoOutputXv: Adaptor: 0 has flag[s]: XvInputMask XvVideoMask
2006-02-25 22:27:17.792 VideoOutputXv: Adaptor: 1 has flag[s]: XvInputMask XvImageMask
2006-02-25 22:27:17.792 VideoOutputXv: Grabbed xv port 178
2006-02-25 22:27:17.792 VideoOutputXv: XVideo surface found on port 178
2006-02-25 22:27:17.802 VideoOutputXv: XVideo Format #0 is 'YUY2'
2006-02-25 22:27:17.802 VideoOutputXv: XVideo Format #1 is 'YV12'
2006-02-25 22:27:17.802 VideoOutputXv: XVideo Format #2 is 'UYVY'
2006-02-25 22:27:17.802 VideoOutputXv: XVideo Format #3 is 'I420'
2006-02-25 22:27:17.803 VideoOutputXv: Using XVideo Format 'I420'
2006-02-25 22:27:17.822 VideoOutputXv: CreateShmImages(32): XJ: (768,576)
X Error: BadMatch (invalid parameter attributes) 8
  Major opcode:  142
  Minor opcode:  14
  Resource id:  0x1c3
2006-02-25 22:27:18.068 VideoOutputXv Error: Couldn't get the color key color,
                        probably due to a driver bug or limitation.
                        You might not get any video, but we'll try anyway.
2006-02-25 22:27:18.068 Image size. dispxoff 0, dispyoff: 0, dispwoff: 1024, disphoff: 768
2006-02-25 22:27:18.069 Image size. imgx 0, imgy: 0, imgw: 768, imgh: 576
2006-02-25 22:27:19.879 NVP: ClearAfterSeek()
2006-02-25 22:27:19.879 VideoOutputXv: ClearAfterSeek()
2006-02-25 22:27:19.904 TV: StartPlayer(): took 3902 ms to start player.
2006-02-25 22:27:19.904 TV: Changing from None to WatchingLiveTV
2006-02-25 22:27:19.879 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:19.907 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-02-25 22:27:19.931 Realtime priority would require SUID as root.
2006-02-25 22:27:19.982 LiveTV forcing JumpTo 1
2006-02-25 22:27:19.990 LiveTVChain(live-kenneth-2006-02-25T22:27:14): SwitchTo(1)
2006-02-25 22:27:19.990 LiveTVChain(live-kenneth-2006-02-25T22:27:14): Entry@1: '1010_20060225222716'
2006-02-25 22:27:19.990 JumpToProgram(void)
2006-02-25 22:27:20.013 New DB connection, total: 3
2006-02-25 22:27:20.418 nVidiaVideoSync: VBlank ioctl did not work, unimplemented in thisdriver?
2006-02-25 22:27:20.418 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2006-02-25 22:27:20.426 RTCVideoSync: Could not open /dev/rtc, No such device.
2006-02-25 22:27:20.429 Using video as timebase
2006-02-25 22:27:20.430 Video timing method: USleep with busy wait
2006-02-25 22:27:20.430 Refresh rate: 16665, frame interval: 20000
2006-02-25 22:27:20.431 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:20.518 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:20.602 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:20.686 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:20.770 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:20.854 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:20.938 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.022 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.106 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.190 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.274 NVP: Prebuffer wait timed out 10 times.
2006-02-25 22:27:21.274 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.358 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.442 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.796 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.882 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:21.966 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.050 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.134 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.218 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.302 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.386 NVP: Prebuffer wait timed out 10 times.
2006-02-25 22:27:22.386 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.470 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.506 Connected to database 'mythconverg' at host: localhost
2006-02-25 22:27:22.531 RingBuf(/mnt/store//1010_20060225222714.mpg): OpenFile(myth://localhost:6543/1010_20060225222716.mpg, 12)
Closing PAT Filter: pid=0x0
Closing PMT Filter: pid=0x20
2006-02-25 22:27:22.554 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
mpegts_add_stream: at pid 0x1f91 with type 2
mpegts_add_stream: stream #0, has id 0x1f91 and codec MPEG2VIDEO, type Video at 0x82ee3e0
mpegts_add_stream: at pid 0x1f93 with type 3
mpegts_add_stream: stream #1, has id 0x1f93 and codec MP3, type Audio at 0x8331430
2006-02-25 22:27:22.638 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
0: start_time: 1042.771 duration: 0.461
1: start_time: 1042.743 duration: 0.428
stream: start_time: 11586.030 duration: 5.432 bitrate=3735 kb/s
2006-02-25 22:27:22.707 AFD: Stream #0, has id 0x8081 codec id MPEG2VIDEO, type Video at 0x0x82ee3e0
2006-02-25 22:27:22.708 VideoOutputXv: InputChanged(544,576,1.33333)
2006-02-25 22:27:22.708 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.708 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA --done()
2006-02-25 22:27:22.708 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-02-25 22:27:22.709 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.709 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA --done()
2006-02-25 22:27:22.709 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-02-25 22:27:22.714 VideoOutputXv: CreateShmImages(32): XJ: (544,576)
2006-02-25 22:27:22.722 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:22.788 Image size. dispxoff 0, dispyoff: 0, dispwoff: 1024, disphoff: 768
2006-02-25 22:27:22.788 Image size. imgx 0, imgy: 0, imgw: 544, imgh: 576
2006-02-25 22:27:23.113 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:23.278 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:23.442 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:23.606 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:23.628 NVP: ClearAfterSeek()
2006-02-25 22:27:23.628 VideoOutputXv: ClearAfterSeek()
2006-02-25 22:27:23.628 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:23.629 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-02-25 22:27:23.630 detectInterlace(Detect Scan, Progressive Scan, 25, 576) ->Interlaced Scan
2006-02-25 22:27:23.631 Interlaced: Interlaced Scan  video_height: 576  fps: 25
2006-02-25 22:27:23.636 Using deinterlace method linearblend
2006-02-25 22:27:23.636 AFD: Looking for decoder for MPEG2VIDEO
2006-02-25 22:27:23.636 AFD: Opened codec 0x82ecf60, id(MPEG2VIDEO) type(Video)
2006-02-25 22:27:23.637 AFD: Stream #1, has id 0x8083 codec id MP3, type Audio at 0x0x8331430
2006-02-25 22:27:23.637 AFD: Looking for decoder for MP3
2006-02-25 22:27:23.667 AFD: Opened codec 0x82ed2a0, id(MP3) type(Audio)
2006-02-25 22:27:23.668 RingBuf(/mnt/store//1010_20060225222716.mpg): CalcReadAheadThresh(15064 KB)
                         -> threshhold(551 KB) min read(32 KB) blk size(256 KB)
2006-02-25 22:27:23.670 Opening audio device '/dev/sound/dsp'.
2006-02-25 22:27:23.671 Opening OSS audio device '/dev/sound/dsp'.
2006-02-25 22:27:23.678 NVP: Enabling Audio
2006-02-25 22:27:23.679 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
2006-02-25 22:27:23.681 Position map filled from DB to: 125
2006-02-25 22:27:23.681 SyncPositionMap watchingrecording, from DB: 11 entries
2006-02-25 22:27:23.697 Filling position map from 126 to 168
2006-02-25 22:27:23.707 Position map filled from Encoder to: 161
2006-02-25 22:27:23.707 SyncPositionMap watchingrecording total: 14 entries
2006-02-25 22:27:23.707 SyncPositionMap, new totframes: 161, new length: 6, posMap size: 14
Input #0, mpegts, from '/mnt/store//1010_20060225222716.mpg':
  Duration: 00:00:05.4, start: 11586.030078, bitrate: 3735 kb/s
  Stream #0.0[0x1f91], 1/90000, 25.00 fps(r): Video: mpeg2video, yuv420p, 544x576, 1/25, 15000 kb/s
  Stream #0.1[0x1f93](nor), 1/90000: Audio: mp2, 48000 Hz, mono, 64 kb/s
2006-02-25 22:27:23.708 AFD: Partial position map found
2006-02-25 22:27:23.708 AFD: Successfully opened decoder for file: "/mnt/store//1010_20060225222716.mpg". novideo(0)
2006-02-25 22:27:23.712 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
2006-02-25 22:27:23.720 Position map filled from DB to: 125
2006-02-25 22:27:23.720 SyncPositionMap watchingrecording, from DB: 11 entries
2006-02-25 22:27:23.731 Filling position map from 126 to 169
2006-02-25 22:27:23.744 Position map filled from Encoder to: 161
2006-02-25 22:27:23.745 SyncPositionMap watchingrecording total: 14 entries
2006-02-25 22:27:23.778 NVP: Waiting for prebuffer.. 9 ULUULAAAAAAAAAAAAAAAAAAAAAAAAAA
2006-02-25 22:27:28.787 NVP: Audio is 5.5635 frames ahead of video
                        doubling video frame interval.
'video_output' mean = '49291.45', std. dev. = '65652.68', fps = '20.29'
2006-02-25 22:27:28.801 NVP: Audio is 5.35388 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:28.817 NVP: Audio is 5.30915 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:28.909 NVP: Audio is 5.4256 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:28.922 NVP: Audio is 5.18795 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:28.996 NVP: Audio is 5.1222 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:29.044 NVP: Audio is 4.87915 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:29.095 NVP: Audio is 4.64685 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:29.130 TV: Attempting to change from WatchingLiveTV to None
2006-02-25 22:27:29.131 TV: StopStuff() -- begin
2006-02-25 22:27:29.131 TV: StopStuff(): stopping ring buffer[s]
2006-02-25 22:27:29.134 TV: StopStuff(): stopping player[s] (1/2)
2006-02-25 22:27:29.134 TV: StopStuff(): stopping recorder[s]
2006-02-25 22:27:29.144 NVP: Audio is 4.39762 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:29.150 NVP: Exited decoder loop.
2006-02-25 22:27:29.191 NVP: Audio is 4.1607 frames ahead of video,
                        doubling video frame interval.
2006-02-25 22:27:29.191 VideoOutputXv: dtor
2006-02-25 22:27:29.192 VideoBuffers::DiscardFrames(1): UuUULUUAUUUUUUUUUUuUUUUUUUUUUUU
2006-02-25 22:27:29.192 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA --done()
2006-02-25 22:27:29.192 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2006-02-25 22:27:29.195 VideoOutputXv: Closing XVideo port 178
2006-02-25 22:27:29.658 TV: StopStuff(): stopping player[s] (2/2)
Closing PAT Filter: pid=0x0
Closing PMT Filter: pid=0x1700
2006-02-25 22:27:29.692 TV: StopStuff() -- end