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