2008-04-03 22:45:50.308 user: 101 effective user: 101 before privileged thread
2008-04-03 22:45:50.311 user: 101 effective user: 101 run_priv_thread
2008-04-03 22:45:50.312 user: 101 effective user: 101 after privileged thread
2008-04-03 22:45:50.313 New DB connection, total: 2
2008-04-03 22:45:50.314 Connected to database 'mythconverg' at host: localhost
2008-04-03 22:45:50.316 mythfrontend version: 0.21.20080304-1 www.mythtv.org
2008-04-03 22:45:50.316 Enabled verbose msgs:  important general playback
2008-04-03 22:45:50.903 max_width: 1024 max_height: 576
2008-04-03 22:45:51.073 Primary screen 0.
2008-04-03 22:45:51.074 Using screen 0, 1024x576 at 0,0
2008-04-03 22:45:51.076 Switching to square mode (Iulius)
2008-04-03 22:45:51.180 Using the OpenGL painter
2008-04-03 22:45:51.192 JoystickMenuClient Error: Joystick disabled - Failed to read /home/mythtv/.mythtv/joystickmenurc
2008-04-03 22:45:51.197 lirc init success using configuration file: /home/mythtv/.mythtv/lircrc
2008-04-03 22:45:52.355 Loading from: /usr/share/mythtv/themes/Iulius/base.xml
2008-04-03 22:45:52.392 Loading from: /usr/share/mythtv/themes/default/base.xml
2008-04-03 22:45:52.484 Registering Internal as a media playback plugin.
2008-04-03 22:45:52.723 Using NV NPOT texture extension
2008-04-03 22:45:59.321 Connecting to backend server: 127.0.0.1:6543 (try 1 of 5)
2008-04-03 22:45:59.321 Using protocol version 40
2008-04-03 22:45:59.477 TV: Attempting to change from None to WatchingLiveTV
2008-04-03 22:45:59.478 Using protocol version 40
2008-04-03 22:46:00.726 LiveTVChain(live-meedio-2008-04-03T22:45:59): ReloadAll(): Added new recording
2008-04-03 22:46:00.794 RingBuf(/var/lib/mythtv/7_20080403224559.mpg): OpenFile(/var/lib/mythtv/7_20080403224559.mpg, 12)
2008-04-03 22:46:01.556 RingBuf(/var/lib/mythtv/7_20080403224559.mpg): CalcReadAheadThresh(1124090576 KB)
			 -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2008-04-03 22:46:01.557 TV: StartRecorder(): took 1 ms to start recorder.
2008-04-03 22:46:01.969 New DB connection, total: 3
2008-04-03 22:46:01.969 Connected to database 'mythconverg' at host: localhost
2008-04-03 22:46:02.485 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 8022800 at 0x0x163d4c0
2008-04-03 22:46:02.489 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) cpus(0) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,greedyhdeint) filt()
2008-04-03 22:46:02.489 VDP: LoadBestPreferences(2048x2048, 0)
2008-04-03 22:46:02.489 VDP: LoadBestPreferences(2048x2048, 60)
2008-04-03 22:46:02.490 VDP: LoadBestPreferences(720x576, 60)
2008-04-03 22:46:02.490 Using 0 CPUs for decoding
2008-04-03 22:46:02.519 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) cpus(0) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,greedyhdeint) filt()
2008-04-03 22:46:02.519 VDP: LoadBestPreferences(2048x2048, 0)
2008-04-03 22:46:02.519 VDP: LoadBestPreferences(2048x2048, 60)
2008-04-03 22:46:02.519 VDP: LoadBestPreferences(720x576, 60)
2008-04-03 22:46:02.528 AFD: Using libmpeg2 for video decoding
2008-04-03 22:46:02.528 AFD: InitVideoCodec() 0x163d7b0 id(MPEG2VIDEO) type (Video).
2008-04-03 22:46:02.528 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2008-04-03 22:46:02.528 AFD: Using libmpeg2 for video decoding
2008-04-03 22:46:02.528 AFD: Looking for decoder for MPEG2VIDEO
2008-04-03 22:46:02.528 AFD: Opened codec 0x163d7b0, id(MPEG2VIDEO) type(Video)
2008-04-03 22:46:02.529 AFD: Stream #1, has id 0x448 codec id MP2, type Audio, bitrate 384000 at 0x0x1640790
2008-04-03 22:46:02.529 AFD: codec MP2 has 2 channels
2008-04-03 22:46:02.529 AFD: Looking for decoder for MP2
2008-04-03 22:46:02.529 AFD: Opened codec 0x163dcd0, id(MP2) type(Audio)
2008-04-03 22:46:02.605 RingBuf(/var/lib/mythtv/7_20080403224559.mpg): CalcReadAheadThresh(1 KB)
			 -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2008-04-03 22:46:02.649 Opening audio device 'default'. ch 6(2) sr 48000
2008-04-03 22:46:02.649 Opening ALSA audio device 'default'.
2008-04-03 22:46:02.837 Dec: Trying to select track (w/lang)
2008-04-03 22:46:02.837 Dec: Selecting first track
2008-04-03 22:46:02.837 Dec: Selected track #1 in the Unknown language(0)
2008-04-03 22:46:02.838 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
2008-04-03 22:46:02.839 Position map filled from DB to: 1
2008-04-03 22:46:02.840 SyncPositionMap watchingrecording, from DB: 1 entries
2008-04-03 22:46:02.840 Filling position map from 2 to 2
2008-04-03 22:46:02.840 Position map filled from Encoder to: 2
2008-04-03 22:46:02.841 SyncPositionMap watchingrecording total: 2 entries
2008-04-03 22:46:02.841 SyncPositionMap, new totframes: 24, new length: 0, posMap size: 2
2008-04-03 22:46:02.841 AFD: Partial position map found
2008-04-03 22:46:02.841 AFD: Successfully opened decoder for file: "/var/lib/mythtv/7_20080403224559.mpg". novideo(0)
2008-04-03 22:46:02.862 VideoOutput: Allowed renderers: ivtv,opengl,xv-blit,xshm,xlib
2008-04-03 22:46:02.862 VideoOutput: Allowed renderers (filt: libmpeg2): xlib,xshm,xv-blit,opengl
2008-04-03 22:46:02.865 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) cpus(0) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,greedyhdeint) filt()
2008-04-03 22:46:02.865 VDP: LoadBestPreferences(2048x2048, 0)
2008-04-03 22:46:02.865 VDP: LoadBestPreferences(2048x2048, 60)
2008-04-03 22:46:02.865 VDP: LoadBestPreferences(720x576, 60)
2008-04-03 22:46:02.865 VideoOutput: Preferred renderer: xv-blit
2008-04-03 22:46:02.865 VideoOutput: Trying video renderer: xv-blit
2008-04-03 22:46:02.867 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) cpus(0) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,greedyhdeint) filt()
2008-04-03 22:46:02.868 VDP: LoadBestPreferences(2048x2048, 0)
2008-04-03 22:46:02.868 VDP: LoadBestPreferences(2048x2048, 60)
2008-04-03 22:46:02.881 VideoOutputXv: ctor
2008-04-03 22:46:02.912 XOff: 0, YOff: 0
2008-04-03 22:46:02.912 VDP: LoadBestPreferences(720x576, 60)
2008-04-03 22:46:02.912 Snapping height to avoid scaling: height: 576, top: 0
2008-04-03 22:46:02.913 Display Rect  left: 0, top: 0, width: 1024, height: 576, aspect: 1.33333
2008-04-03 22:46:02.913 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2008-04-03 22:46:02.913 VideoOutputXv: Pixel dimensions: Screen 1024x576, window 1024x576
2008-04-03 22:46:02.914 VideoOutputXv: Estimated display dimensions: 200x151 mm  Aspect: 1.3245
2008-04-03 22:46:02.914 VideoOutputXv: Estimated window dimensions: 200x151 mm  Aspect: 1.3245
2008-04-03 22:46:02.914 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: opengl,xv-blit,xshm,xlib
2008-04-03 22:46:02.917 VDP: Accepting: cmp(> 0 0) dec(libmpeg2) cpus(0) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,greedyhdeint) filt()
2008-04-03 22:46:02.917 VDP: LoadBestPreferences(2048x2048, 0)
2008-04-03 22:46:02.918 VDP: LoadBestPreferences(2048x2048, 60)
2008-04-03 22:46:02.918 VDP: LoadBestPreferences(720x576, 60)
2008-04-03 22:46:02.918 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  10
2008-04-03 22:46:02.918 VideoOutputXv: Adaptor#0: ATI Radeon Video Overlay has flag[s]: XvInputMask XvImageMask 
2008-04-03 22:46:02.918 VideoOutputXv: Has XVideo flags...
2008-04-03 22:46:02.919 VideoOutputXv: Has XV_BRIGHTNESS...
2008-04-03 22:46:02.919 VideoOutputXv: Here...
2008-04-03 22:46:02.919 VideoOutputXv: Grabbed xv port 73
2008-04-03 22:46:02.919 VideoOutputXv: XVideo surface found on port 73
2008-04-03 22:46:02.919 VideoOutputXv: XVideo Adaptor Name: 'ATI Radeon Video Overlay'
2008-04-03 22:46:02.919 VideoOutputXv: XVideo Format #0 is 'RGBA'
2008-04-03 22:46:02.920 VideoOutputXv: XVideo Format #1 is '
2008-04-03 22:46:02.920 VideoOutputXv: XVideo Format #2 is 'RGBT'
2008-04-03 22:46:02.920 VideoOutputXv: XVideo Format #3 is 'RGB2'
2008-04-03 22:46:02.920 VideoOutputXv: XVideo Format #4 is 'YUY2'
2008-04-03 22:46:02.920 VideoOutputXv: XVideo Format #5 is 'UYVY'
2008-04-03 22:46:02.920 VideoOutputXv: XVideo Format #6 is 'YV12'
2008-04-03 22:46:02.920 VideoOutputXv: XVideo Format #7 is 'I420'
2008-04-03 22:46:02.920 VideoOutputXv: Using XVideo Format 'YV12'
2008-04-03 22:46:02.920 VideoOutputXv: CreateShmImages(32): video_dim: 720x576
2008-04-03 22:46:02.956 VDP: SetVideoRenderer(xv-blit)
2008-04-03 22:46:02.957 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2008-04-03 22:46:02.957 Snapping height to avoid scaling: height: 576, top: 0
2008-04-03 22:46:02.957 Display Rect  left: 0, top: 0, width: 1024, height: 576, aspect: 1.33333
2008-04-03 22:46:02.958 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2008-04-03 22:46:02.959 Over/underscan. V: 0, H: 0
2008-04-03 22:46:02.959 Snapping height to avoid scaling: height: 576, top: 0
2008-04-03 22:46:02.960 Display Rect  left: 0, top: 0, width: 1024, height: 576, aspect: 1.33333
2008-04-03 22:46:02.960 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2008-04-03 22:46:02.960 VDP: LoadBestPreferences(720x576, 25)
2008-04-03 22:46:02.961 NVP: LoadFilters(''..) -> 0
2008-04-03 22:46:02.978 OSD Theme Dimensions W: 640 H: 480
2008-04-03 22:46:03.452 NVP: ClearAfterSeek(1)
2008-04-03 22:46:03.452 TV: StartPlayer(): took 1455 ms to start player.
2008-04-03 22:46:03.452 VideoOutputXv: ClearAfterSeek()
2008-04-03 22:46:03.452 VideoOutputXv: DiscardFrames(0)
2008-04-03 22:46:03.452 TV: Changing from None to WatchingLiveTV
2008-04-03 22:46:03.452 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2008-04-03 22:46:03.453 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2008-04-03 22:46:03.453 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2008-04-03 22:46:03.460 New DB connection, total: 4
2008-04-03 22:46:03.460 Using realtime priority.
2008-04-03 22:46:03.461 VDP: GetFilteredDeint() : xv-blit -> 'bobdeint'
2008-04-03 22:46:03.461 Connected to database 'mythconverg' at host: localhost
2008-04-03 22:46:03.463 Using deinterlace method bobdeint
2008-04-03 22:46:03.464 nVidiaVideoSync: Could not open device /dev/nvidia0, No such file or directory
2008-04-03 22:46:03.482 Set video sync frame interval to 40000
2008-04-03 22:46:03.482 Video sync method can't support double framerate (refresh rate too low for bob deint)
2008-04-03 22:46:03.482 Set video sync frame interval to 40000
2008-04-03 22:46:03.482 VDP: GetFilteredDeint(greedyhdeint) : xv-blit -> 'greedyhdeint'
greedyhdeint: size changed from 0 x 0 -> 720 x 576
2008-04-03 22:46:03.486 Using deinterlace method greedyhdeint
2008-04-03 22:46:03.502 Using audio as timebase
2008-04-03 22:46:03.502 Video timing method: DRM
2008-04-03 22:46:03.502 Refresh rate: 40000, frame interval: 40000
2008-04-03 22:46:03.521 NVP: Waiting for prebuffer.. 0 AAUUUuUULULLAAAAAAAAAAAAAAAAAAA
2008-04-03 22:46:03.537 AFD: HandleGopStart: gopset not set, syncing positionMap
2008-04-03 22:46:03.537 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
2008-04-03 22:46:03.538 Position map filled from DB to: 1
2008-04-03 22:46:03.538 SyncPositionMap watchingrecording, from DB: 1 entries
2008-04-03 22:46:03.538 Filling position map from 2 to 4
2008-04-03 22:46:03.539 Position map filled from Encoder to: 4
2008-04-03 22:46:03.539 SyncPositionMap watchingrecording total: 4 entries
2008-04-03 22:46:03.539 SyncPositionMap, new totframes: 48, new length: 1, posMap size: 4
2008-04-03 22:46:03.539 AFD: HandleGopStart: Initial key frame distance: 12.
'video_output' mean = '41596.87', std. dev. = '15373.86', fps = '24.04'
2008-04-03 22:46:09.448 TV: Attempting to change from WatchingLiveTV to None
2008-04-03 22:46:09.449 TV: StopStuff() -- begin
2008-04-03 22:46:09.449 TV: StopStuff(): stopping ring buffer[s]
2008-04-03 22:46:09.506 TV: StopStuff(): stopping player[s] (1/2)
2008-04-03 22:46:09.506 TV: StopStuff(): stopping recorder[s]
2008-04-03 22:46:09.512 NVP: Exited decoder loop.
2008-04-03 22:46:09.535 VideoOutputXv: dtor
2008-04-03 22:46:09.535 VideoOutputXv: DiscardFrames(1)
2008-04-03 22:46:09.535 VideoBuffers::DiscardFrames(1): UUUUUUUUuUULUUUUUUUUUUUUUUULAUU
2008-04-03 22:46:09.535 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2008-04-03 22:46:09.535 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2008-04-03 22:46:09.536 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2008-04-03 22:46:09.536 VideoOutputXv: DiscardFrames(1)
2008-04-03 22:46:09.536 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2008-04-03 22:46:09.536 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2008-04-03 22:46:09.536 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2008-04-03 22:46:09.536 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2008-04-03 22:46:09.538 VideoOutputXv: Closing XVideo port 73
2008-04-03 22:46:09.814 TV: StopStuff(): stopping player[s] (2/2)
2008-04-03 22:46:09.838 TV: StopStuff() -- end
2008-04-03 22:46:09.838 TV: Changing from WatchingLiveTV to None