2007-06-10 13:57:28.118 Received a remote 'Clear Cache' request 2007-06-10 13:57:36.276 TV: Attempting to change from None to WatchingLiveTV 2007-06-10 13:57:36.279 Using protocol version 31 2007-06-10 13:57:36.843 LiveTVChain(live-Myth-2007-06-10T13:57:36): ReloadAll(): Added new recording 2007-06-10 13:57:36.846 RingBuf(/mnt/500/recordings/1071_20070610135736.mpg): OpenFile(/mnt/500/recordings/1071_20070610135736.mpg, 12) 2007-06-10 13:57:37.851 RingBuf(/mnt/500/recordings/1071_20070610135736.mpg): CalcReadAheadThresh(4000 KB) -> threshhold(146 KB) min read(32 KB) blk size(64 KB) 2007-06-10 13:57:37.852 TV: StartRecorder(): took 1 ms to start recorder. 2007-06-10 13:57:37.861 DPMS Deactivated 2007-06-10 13:57:38.017 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 6500000 at 0x0x8e0bb30 2007-06-10 13:57:38.037 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2007-06-10 13:57:38.037 AFD: Looking for decoder for MPEG2VIDEO 2007-06-10 13:57:38.037 AFD: Opened codec 0x8dd8fb0, id(MPEG2VIDEO) type(Video) 2007-06-10 13:57:38.037 AFD: Stream #1, has id 0x448 codec id MP2, type Audio, bitrate 224000 at 0x0x8dbceb0 2007-06-10 13:57:38.037 AFD: Looking for decoder for MP2 2007-06-10 13:57:38.037 AFD: Opened codec 0x8c840a0, id(MP2) type(Audio) 2007-06-10 13:57:38.140 RingBuf(/mnt/500/recordings/1071_20070610135736.mpg): CalcReadAheadThresh(6724 KB) -> threshhold(246 KB) min read(32 KB) blk size(128 KB) 2007-06-10 13:57:38.143 Opening ALSA audio device 'default'. 2007-06-10 13:57:38.149 Dec: Trying to select track (w/lang) 2007-06-10 13:57:38.150 Dec: Selecting first track 2007-06-10 13:57:38.150 Dec: Selected track #1 in the Unknown language(0) 2007-06-10 13:57:38.150 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0) 2007-06-10 13:57:38.151 Position map filled from DB to: 1 2007-06-10 13:57:38.152 SyncPositionMap watchingrecording, from DB: 1 entries 2007-06-10 13:57:38.152 PosMapFromEnc: Warning, tried to fetch PositionMap from Encoder but encoder returned framesWritten == 0 2007-06-10 13:57:38.152 SyncPositionMap watchingrecording no entries from encoder, try DB 2007-06-10 13:57:38.153 Position map filled from DB to: 1 2007-06-10 13:57:38.153 SyncPositionMap watchingrecording total: 1 entries 2007-06-10 13:57:38.153 SyncPositionMap, new totframes: 15, new length: 0, posMap size: 1 2007-06-10 13:57:38.153 AFD: Partial position map found 2007-06-10 13:57:38.153 AFD: Successfully opened decoder for file: "/mnt/500/recordings/1071_20070610135736.mpg". novideo(0) 2007-06-10 13:57:38.169 VideoOutputXv: ctor 2007-06-10 13:57:38.170 Over/underscan. V: 0, H: 0, XOff: 0, YOff: 0 2007-06-10 13:57:38.170 Display Rect left: 0, top: 0, width: 800, height: 600, aspect: 1.33333 2007-06-10 13:57:38.170 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333 2007-06-10 13:57:38.170 VideoOutputXv: Pixel dimensions: Screen 800x600, window 800x600 2007-06-10 13:57:38.170 VideoOutputXv: Estimated display dimensions: 271x203 mm Aspect: 1.33498 2007-06-10 13:57:38.171 VideoOutputXv: Estimated window dimensions: 271x203 mm Aspect: 1.33498 2007-06-10 13:57:38.172 VideoOutputXv: XvMCTex: Init failed 2007-06-10 13:57:38.172 VideoOutputXv: @ j=3 Looking for flag[s]: XvInputMask XvImageMask 2007-06-10 13:57:38.172 VideoOutputXv: Adaptor#0: NV17 Video Overlay has flag[s]: XvInputMask XvImageMask 2007-06-10 13:57:38.172 VideoOutputXv: Grabbed xv port 109 2007-06-10 13:57:38.172 VideoOutputXv: XVideo surface found on port 109 2007-06-10 13:57:38.172 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Overlay' 2007-06-10 13:57:38.172 VideoOutputXv: XVideo Format #0 is 'YUY2' 2007-06-10 13:57:38.172 VideoOutputXv: XVideo Format #1 is 'YV12' 2007-06-10 13:57:38.172 VideoOutputXv: XVideo Format #2 is 'UYVY' 2007-06-10 13:57:38.173 VideoOutputXv: XVideo Format #3 is 'I420' 2007-06-10 13:57:38.173 VideoOutputXv: Using XVideo Format 'I420' 2007-06-10 13:57:38.173 VideoOutputXv: CreateShmImages(32): video_dim: 720x480 2007-06-10 13:57:38.235 Display Rect left: 0, top: 0, width: 800, height: 600, aspect: 1.33333 2007-06-10 13:57:38.236 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333 2007-06-10 13:57:38.599 NVP: ClearAfterSeek(1) 2007-06-10 13:57:38.599 VideoOutputXv: ClearAfterSeek() 2007-06-10 13:57:38.599 VideoOutputXv: DiscardFrames(0) 2007-06-10 13:57:38.599 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2007-06-10 13:57:38.599 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2007-06-10 13:57:38.599 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2007-06-10 13:57:38.600 TV: StartPlayer(): took 716 ms to start player. 2007-06-10 13:57:38.600 TV: Changing from None to WatchingLiveTV 2007-06-10 13:57:38.601 Using realtime priority. 2007-06-10 13:57:38.703 nVidiaVideoSync: VBlank ioctl did not work, unimplemented in this driver? 2007-06-10 13:57:38.703 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory 2007-06-10 13:57:38.704 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_get_proc_address 2007-06-10 13:57:38.704 OpenGLVideoSync: x,y -> 398, 277 2007-06-10 13:57:38.724 Using OpenGLVideoSync 2007-06-10 13:57:38.740 Using audio as timebase 2007-06-10 13:57:38.740 Video timing method: SGI OpenGL 2007-06-10 13:57:38.740 Refresh rate: 16579, frame interval: 33366 2007-06-10 13:57:38.757 NVP: Waiting for prebuffer.. 0 LAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2007-06-10 13:57:38.907 NVP: Waiting for prebuffer.. 1 UuUULUuAAAAAAAAAAAAAAAAAAAAAAAA 2007-06-10 13:57:39.057 NVP: Waiting for prebuffer.. 2 UuUULUuAAAAAAAAAAAAAAAAAAAAAAAA 2007-06-10 13:57:39.206 AFD: HandleGopStart: gopset not set, syncing positionMap 2007-06-10 13:57:39.206 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1) 2007-06-10 13:57:39.208 Position map filled from DB to: 1 2007-06-10 13:57:39.208 SyncPositionMap watchingrecording, from DB: 1 entries 2007-06-10 13:57:39.209 Filling position map from 2 to 2 2007-06-10 13:57:39.209 Position map filled from Encoder to: 2 2007-06-10 13:57:39.209 SyncPositionMap watchingrecording total: 2 entries 2007-06-10 13:57:39.209 SyncPositionMap, new totframes: 30, new length: 1, posMap size: 2 2007-06-10 13:57:39.209 AFD: HandleGopStart: Initial key frame distance: 15. 2007-06-10 13:57:39.308 NVP: Video is 3.76131 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.375 NVP: Video is 4.91144 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.442 NVP: Video is 5.50429 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.508 NVP: Video is 5.70917 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.575 NVP: Video is 5.62306 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.642 NVP: Video is 5.28124 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.709 NVP: Video is 4.77762 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.775 NVP: Video is 4.16013 frames ahead of audio, doubling video frame interval to slow down. 2007-06-10 13:57:39.842 NVP: Video is 3.46475 frames ahead of audio, doubling video frame interval to slow down. 'video_output' mean = '36684.31', std. dev. = '9756.64', fps = '27.26' 'video_output' mean = '33363.40', std. dev. = '67.54', fps = '29.97' 'video_output' mean = '33364.31', std. dev. = '99.52', fps = '29.97' 2007-06-10 13:57:52.771 NVP: 400 interlaced frames seen. 'video_output' mean = '33366.24', std. dev. = '53.33', fps = '29.97' 'video_output' mean = '33360.81', std. dev. = '132.80', fps = '29.98' 'video_output' mean = '33364.16', std. dev. = '160.40', fps = '29.97' 'video_output' mean = '33366.29', std. dev. = '76.06', fps = '29.97' 2007-06-10 13:58:06.118 NVP: 800 interlaced frames seen.