2009-08-31 20:15:44.700 mythfrontend version: trunk [21606:21607M] www.mythtv.org
2009-08-31 20:15:44.721 Using runtime prefix = /usr/local
2009-08-31 20:15:45.294 Empty LocalHostName.
2009-08-31 20:15:45.295 Using localhost value of living.kristjansson.com
2009-08-31 20:15:45.300 New DB connection, total: 1
2009-08-31 20:15:45.305 Connected to database 'mythconverg' at host: localhost
2009-08-31 20:15:45.305 Closing DB connection named 'DBManager0'
2009-08-31 20:15:45.330 DPMS is active.
2009-08-31 20:15:45.332 Primary screen: 0.
2009-08-31 20:15:45.333 Connected to database 'mythconverg' at host: localhost
2009-08-31 20:15:45.334 Using screen 0, 1920x1080 at 0,0
2009-08-31 20:15:45.359 MythUI Image Cache size set to 20971520 bytes
2009-08-31 20:15:45.359 user: 502 effective user: 502 before privileged thread
2009-08-31 20:15:45.359 user: 502 effective user: 502 after privileged thread
2009-08-31 20:15:45.359 user: 502 effective user: 502 run_priv_thread
2009-08-31 20:15:45.360 Enabled verbose msgs:  important general playback
2009-08-31 20:15:45.448 The theme (defaultmenu) is missing a themeinfo.xml file
2009-08-31 20:15:46.558 The theme (defaultmenu) is missing a themeinfo.xml file
2009-08-31 20:15:46.570 Desktop video mode: 1920x1080 60.0024 Hz
2009-08-31 20:15:46.586 max_width: 1920 max_height: 1080
2009-08-31 20:15:46.702 Primary screen: 0.
2009-08-31 20:15:46.703 Using screen 0, 1920x1080 at 0,0
2009-08-31 20:15:46.704 Using theme base resolution of 800x600
2009-08-31 20:15:46.714 LIRC, Error: Failed to read config file '/home/danielk/.lircrc'
2009-08-31 20:15:46.714 JoystickMenuThread Error: Joystick disabled - Failed to read /home/danielk/.mythtv/joystickmenurc
2009-08-31 20:15:46.890 Using the Qt painter
2009-08-31 20:15:47.138 Loading base theme from /usr/local/share/mythtv/themes/G.A.N.T/base.xml
2009-08-31 20:15:47.949 Loading base theme from /usr/local/share/mythtv/themes/default/base.xml
2009-08-31 20:15:47.997 Current Schema Version: 1243
2009-08-31 20:15:48.078 Registering Internal as a media playback plugin.
2009-08-31 20:15:48.082 Plugin mytharchive (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.082 Test Popup Version Failed 
2009-08-31 20:15:48.082 Unable to initialize plugin 'mytharchive'.
2009-08-31 20:15:48.084 Plugin mythbrowser (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.084 Unable to initialize plugin 'mythbrowser'.
2009-08-31 20:15:48.097 Plugin mythflix (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.097 Unable to initialize plugin 'mythflix'.
2009-08-31 20:15:48.100 Plugin mythgallery (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.100 Unable to initialize plugin 'mythgallery'.
2009-08-31 20:15:48.102 Plugin mythgame (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.102 libmythgame.so/main.o: binary version mismatch
2009-08-31 20:15:48.102 Unable to initialize plugin 'mythgame'.
2009-08-31 20:15:48.103 Plugin mythmovies (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.104 libmythmovies.so/main.o: binary version mismatch
2009-08-31 20:15:48.104 Unable to initialize plugin 'mythmovies'.
2009-08-31 20:15:48.114 Plugin mythmusic (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.114 Unable to initialize plugin 'mythmusic'.
2009-08-31 20:15:48.115 Plugin mythnews (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.115 Unable to initialize plugin 'mythnews'.
2009-08-31 20:15:48.118 Plugin mythvideo (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.118 Unable to initialize plugin 'mythvideo'.
2009-08-31 20:15:48.120 Plugin mythweather (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.120 Unable to initialize plugin 'mythweather'.
2009-08-31 20:15:48.122 Plugin mythzoneminder (0.22.20090824-1) binary version does not match libraries (0.22.20090829-1)
2009-08-31 20:15:48.122 Unable to initialize plugin 'mythzoneminder'.
2009-08-31 20:15:48.156 NetworkControl: Listening for remote connections on port 6546
2009-08-31 20:15:51.056 Loading window theme from /usr/local/share/mythtv/themes/G.A.N.T/menu-ui.xml
2009-08-31 20:15:51.304 Detected MediaType MEDIATYPE_DVD
2009-08-31 20:15:52.201 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//mainmenu.xml
2009-08-31 20:15:52.203 Found mainmenu.xml for theme 'G.A.N.T'
2009-08-31 20:15:52.213 MythContext: Connecting to backend server: 192.168.1.160:6543 (try 1 of 1)
2009-08-31 20:15:52.264 Using protocol version 48
2009-08-31 20:15:55.120 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//library.xml
2009-08-31 20:16:07.351 New DB connection, total: 2
2009-08-31 20:16:07.351 Connected to database 'mythconverg' at host: localhost
2009-08-31 20:16:07.484 Loading window theme from /usr/local/share/mythtv/themes/default/recordings-ui.xml
2009-08-31 20:16:11.865 TV: StartTV() -- begin
2009-08-31 20:16:11.865 TV: ctor
2009-08-31 20:16:11.981 TV: tv->Playback() -- begin
2009-08-31 20:16:12.047 TV: tv->Playback() -- end
2009-08-31 20:16:12.047 TV: StartTV -- process events begin
2009-08-31 20:16:12.068 TV: HandleStateChange(0) -- begin
2009-08-31 20:16:12.068 TV: Attempting to change from None to Watching WatchingPreRecorded
2009-08-31 20:16:12.071 RingBuf(/jessdell-video/1138_20090831150000.mpg): OpenFile(/jessdell-video/1138_20090831150000.mpg, 12)
2009-08-31 20:16:12.094 RingBuf(/jessdell-video/1138_20090831150000.mpg): CalcReadAheadThresh(0 KB)
			 -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2009-08-31 20:16:12.094 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- begin
2009-08-31 20:16:12.277 AFD: Stream #0, has id 0x1011 codec id H264, type Video, bitrate 0 at 0xa6e88d0
2009-08-31 20:16:12.280 VDP: Accepting: cmp(>= 0 0) dec(vdpau) cpus(1) rend(vdpau) osd(vdpau) osdfade(disabled) deint(vdpaubasicdoublerate,vdpaubasic) filt()
2009-08-31 20:16:12.280 VDP: Accepting: cmp(>= 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
2009-08-31 20:16:12.280 VDP: LoadBestPreferences(2048x2048, 0)
2009-08-31 20:16:12.280 VDP: LoadBestPreferences(2048x2048, 60)
2009-08-31 20:16:12.280 VDP: LoadBestPreferences(1920x1080, 60)
2009-08-31 20:16:12.282 VDP: Accepting: cmp(>= 0 0) dec(vdpau) cpus(1) rend(vdpau) osd(vdpau) osdfade(disabled) deint(vdpaubasicdoublerate,vdpaubasic) filt()
2009-08-31 20:16:12.282 VDP: Accepting: cmp(>= 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
2009-08-31 20:16:12.282 VDP: LoadBestPreferences(2048x2048, 0)
2009-08-31 20:16:12.282 VDP: LoadBestPreferences(2048x2048, 60)
2009-08-31 20:16:12.282 VDP: LoadBestPreferences(1920x1080, 60)
2009-08-31 20:16:12.282 Using 1 CPUs for decoding
2009-08-31 20:16:12.282 AFD: InitVideoCodec() 0xa6e8aa0 id(H264) type (Video).
2009-08-31 20:16:12.283 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan
2009-08-31 20:16:12.283 AFD: Using ffmpeg for video decoding
2009-08-31 20:16:12.283 AFD: Looking for decoder for H264
2009-08-31 20:16:12.283 AFD: Opened codec 0xa6e8aa0, id(H264) type(Video)
2009-08-31 20:16:12.283 AFD: Stream #1, has id 0x1100 codec id AAC, type Audio, bitrate 127500 at 0xa6e9040
2009-08-31 20:16:12.283 AFD: codec AAC has 2 channels
2009-08-31 20:16:12.283 AFD: Looking for decoder for AAC
2009-08-31 20:16:12.285 AFD: Opened codec 0xa6e9210, id(AAC) type(Audio)
2009-08-31 20:16:12.285 RingBuf(/jessdell-video/1138_20090831150000.mpg): CalcReadAheadThresh(0 KB)
			 -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2009-08-31 20:16:12.289 Opening audio device 'default'. ch 6(2) sr 48000
2009-08-31 20:16:12.289 Opening ALSA audio device 'default'.
2009-08-31 20:16:12.340 Mixer unable to find control PCM 2
2009-08-31 20:16:12.340 Mixer unable to find control PCM 3
2009-08-31 20:16:12.340 Mixer unable to find control PCM 4
2009-08-31 20:16:12.340 Mixer unable to find control PCM 5
2009-08-31 20:16:12.340 mixer unable to find control Master 1
2009-08-31 20:16:12.349 Dec: Trying to select track (w/lang)
2009-08-31 20:16:12.349 Dec: Selecting first track
2009-08-31 20:16:12.349 Dec: Selected track #1 in the Unknown language(0)
2009-08-31 20:16:12.349 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2009-08-31 20:16:12.355 Position map filled from DB to: 108541
2009-08-31 20:16:12.355 Dec: SyncPositionMap prerecorded, from DB: 849 entries
2009-08-31 20:16:12.355 Dec: SyncPositionMap, new totframes: 108541, new length: 3621, posMap size: 849
2009-08-31 20:16:12.355 AFD: Position map found
2009-08-31 20:16:12.355 AFD: Successfully opened decoder for file: "/jessdell-video/1138_20090831150000.mpg". novideo(0)
2009-08-31 20:16:12.359 VideoOutput: Allowed renderers: xv-blit,xshm,xlib,opengl,vdpau
2009-08-31 20:16:12.359 VideoOutput: Allowed renderers (filt: ffmpeg): xlib,xshm,xv-blit,opengl,vdpau
2009-08-31 20:16:12.361 VDP: Accepting: cmp(>= 0 0) dec(vdpau) cpus(1) rend(vdpau) osd(vdpau) osdfade(disabled) deint(vdpaubasicdoublerate,vdpaubasic) filt()
2009-08-31 20:16:12.361 VDP: Accepting: cmp(>= 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
2009-08-31 20:16:12.361 VDP: LoadBestPreferences(2048x2048, 0)
2009-08-31 20:16:12.361 VDP: LoadBestPreferences(2048x2048, 60)
2009-08-31 20:16:12.361 VDP: LoadBestPreferences(1920x1080, 60)
2009-08-31 20:16:12.362 VideoOutput: Trying video renderer: 'vdpau'
2009-08-31 20:16:12.369 VDP: Accepting: cmp(>= 0 0) dec(vdpau) cpus(1) rend(vdpau) osd(vdpau) osdfade(disabled) deint(vdpaubasicdoublerate,vdpaubasic) filt()
2009-08-31 20:16:12.369 VDP: Accepting: cmp(>= 0 0) dec(ffmpeg) cpus(2) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
2009-08-31 20:16:12.369 VDP: LoadBestPreferences(2048x2048, 0)
2009-08-31 20:16:12.369 VDP: LoadBestPreferences(2048x2048, 60)
2009-08-31 20:16:12.373 VideoOutWindow::SetPIPState. pip_state: 0]
2009-08-31 20:16:12.373 Snapping width to avoid scaling: width: 1920, left: 0
2009-08-31 20:16:12.373 Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
2009-08-31 20:16:12.373 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2009-08-31 20:16:12.373 VDP: LoadBestPreferences(1920x1088, 60)
2009-08-31 20:16:12.373 Snapping width to avoid scaling: width: 1920, left: 0
2009-08-31 20:16:12.374 Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
2009-08-31 20:16:12.374 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2009-08-31 20:16:12.374 VDP: SetVideoRenderer(vdpau)
2009-08-31 20:16:12.374 VDP: SetVideoRender(vdpau) == GetVideoRenderer()
2009-08-31 20:16:12.374 VidOutVDPAU: VDPAU Colorkey: 0x20202 (depth 24)
2009-08-31 20:16:12.376 VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
2009-08-31 20:16:12.376 VideoOutput: Actual display dimensions: 938x528 mm  Aspect: 1.77652
2009-08-31 20:16:12.376 VideoOutput: Estimated window dimensions: 938x528 mm  Aspect: 1.77652
2009-08-31 20:16:12.575 VDPAU: Version 0
2009-08-31 20:16:12.575 VDPAU: Information Unknown
2009-08-31 20:16:12.659 Snapping height to avoid scaling: height: 1080, top: 0
2009-08-31 20:16:12.659 Snapping width to avoid scaling: width: 1920, left: 0
2009-08-31 20:16:12.659 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2009-08-31 20:16:12.659 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2009-08-31 20:16:12.659 VidOutVDPAU: Created VDPAU context (software decode)
2009-08-31 20:16:12.660 VDPAU: Created OSD (1920x1080)
2009-08-31 20:16:12.662 Over/underscan. V: 0, H: 0
2009-08-31 20:16:12.662 Snapping height to avoid scaling: height: 1080, top: 0
2009-08-31 20:16:12.662 Snapping width to avoid scaling: width: 1920, left: 0
2009-08-31 20:16:12.662 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2009-08-31 20:16:12.662 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2009-08-31 20:16:12.662 VDP: LoadBestPreferences(1920x1088, 29.97)
2009-08-31 20:16:12.663 NVP(0): LoadFilters(''..) -> 0x0
2009-08-31 20:16:12.664 OSD Theme Dimensions W: 640 H: 480
2009-08-31 20:16:12.979 NVP(0): ClearAfterSeek(1)
2009-08-31 20:16:12.979 playCtx: StartDecoderThread(): took 622 ms to start player.
2009-08-31 20:16:12.979 VidOutVDPAU: ClearAfterSeek()
2009-08-31 20:16:12.979 VidOutVDPAU: DiscardFrames(0)
2009-08-31 20:16:12.979 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- end ok
2009-08-31 20:16:12.979 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAA
2009-08-31 20:16:12.979 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAA -- done
2009-08-31 20:16:12.979 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2009-08-31 20:16:12.982 VDP: GetFilteredDeint() : vdpau -> 'vdpaubasicdoublerate'
2009-08-31 20:16:12.983 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2009-08-31 20:16:12.984 RTCVideoSync: Could not open /dev/rtc, Permission denied.
2009-08-31 20:16:12.984 Set video sync frame interval to 33366
2009-08-31 20:16:12.985 Using audio as timebase
2009-08-31 20:16:12.985 Video timing method: USleep with busy wait
2009-08-31 20:16:12.985 Refresh rate: 16666, frame interval: 33366
2009-08-31 20:16:12.985 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAA
2009-08-31 20:16:12.986 Realtime priority would require SUID as root.
2009-08-31 20:16:13.036 TV: Changing from None to Watching WatchingPreRecorded
2009-08-31 20:16:13.039 TV: HandleStateChange(0) -- end
2009-08-31 20:16:13.060 ScreenSaverX11Private: DPMS Deactivated 1
2009-08-31 20:16:13.118 NVP(0): Waiting for prebuffer..  1 uLULAAAAAAAAAAAAA
2009-08-31 20:16:13.373 VDPAU: Using 4 output surfaces (max 4)
2009-08-31 20:16:13.585 NVP(0): Video is 3.16139 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:13.599 NVP(0): Video is 3.50992 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:13.599 NVP(0): Video is 3.63646 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:13.600 NVP(0): Video is 3.48409 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:13.600 NVP(0): Video is 3.11506 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:14.081 NVP(0): Video is 3.17506 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:14.081 NVP(0): Video is 3.49769 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:14.081 NVP(0): Video is 3.49242 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:14.081 NVP(0): Video is 3.23371 frames behind audio (too slow), dropping frame to catch up.
2009-08-31 20:16:15.803 TV: DoNVPSeek() -- begin
2009-08-31 20:16:15.803 TV: DoNVPSeek() -- ff
2009-08-31 20:16:15.803 TV: DoNVPSeek() -- end
2009-08-31 20:16:15.803 UpdateOSDSeekMessage(Skip Ahead, 2)
2009-08-31 20:16:15.871 VidOutVDPAU: UpdatePauseFrame() UUUUUuUUUuUUULAUU
2009-08-31 20:16:15.874 AFD: DoFastForward(976 (93), do discard frames)
2009-08-31 20:16:15.874 Dec: DoFastForward(976 (93), do discard frames)
2009-08-31 20:16:15.875 Dec: FindPosition(976, search not adjusted) --> [7(25770100),8(31306888)]
2009-08-31 20:16:15.875 AFD: SeekReset(1021, 0, do flush, do discard)
2009-08-31 20:16:15.875 AFD: SeekReset() flushing
2009-08-31 20:16:15.875 VidOutVDPAU: DiscardFrames(1)
2009-08-31 20:16:15.875 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUAAUU
2009-08-31 20:16:15.875 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2009-08-31 20:16:15.875 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2009-08-31 20:16:15.875 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2009-08-31 20:16:15.875 NVP(0): ClearAfterSeek(0)
2009-08-31 20:16:15.890 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAA
2009-08-31 20:16:16.023 NVP(0): Waiting for prebuffer..  1 AAAAAAAAAAAAAULLA
2009-08-31 20:16:16.157 NVP(0): Waiting for prebuffer..  2 LAAAAAAAAAAAAULUU
2009-08-31 20:16:16.559 NVP(0): prebuffering pause
2009-08-31 20:16:16.559 NVP(0): Waiting for prebuffer..  0 auAAALAAAAAAAAAAA
2009-08-31 20:16:16.692 NVP(0): Waiting for prebuffer..  1 AuAAALAAAAUULAAAA
'video_output' mean = '38911.47', std. dev. = '35666.06', fps = '25.70'
2009-08-31 20:16:17.930 NVP(0): Video is 3.02823 frames behind audio (too slow), dropping frame to catch up.
'video_output' mean = '33833.79', std. dev. = '3931.24', fps = '29.56'
2009-08-31 20:16:20.539 TV: DoNVPSeek() -- begin
2009-08-31 20:16:20.539 TV: DoNVPSeek() -- ff
2009-08-31 20:16:20.539 TV: DoNVPSeek() -- end
2009-08-31 20:16:20.539 UpdateOSDSeekMessage(Skip Ahead, 2)
2009-08-31 20:16:20.582 VidOutVDPAU: UpdatePauseFrame() UUUUUuUUUuAUUULUU
2009-08-31 20:16:20.586 AFD: DoFastForward(2044 (1161), do discard frames)
2009-08-31 20:16:20.586 Dec: DoFastForward(2044 (1161), do discard frames)
2009-08-31 20:16:20.586 Dec: FindPosition(2044, search not adjusted) --> [15(58946272),16(64941780)]
2009-08-31 20:16:20.586 AFD: SeekReset(2045, 0, do flush, do discard)
2009-08-31 20:16:20.586 AFD: SeekReset() flushing
2009-08-31 20:16:20.586 VidOutVDPAU: DiscardFrames(1)
2009-08-31 20:16:20.586 VideoBuffers::DiscardFrames(1): UUUUUUUUUUAUUUAUU
2009-08-31 20:16:20.586 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2009-08-31 20:16:20.586 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2009-08-31 20:16:20.586 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2009-08-31 20:16:20.586 NVP(0): ClearAfterSeek(0)
2009-08-31 20:16:20.601 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAA
2009-08-31 20:16:20.734 NVP(0): Waiting for prebuffer..  1 AAAAAAAAAALLAAUAA
2009-08-31 20:16:21.219 NVP(0): prebuffering pause
2009-08-31 20:16:21.219 NVP(0): Waiting for prebuffer..  0 aLAAALAAAAAAAAAAA
2009-08-31 20:16:21.353 NVP(0): Waiting for prebuffer..  1 AuAAALUULAAAAAAAA
2009-08-31 20:16:21.619 NVP(0): prebuffering pause
2009-08-31 20:16:21.619 NVP(0): Waiting for prebuffer..  0 AAAAAaAAALLAAAAAA
2009-08-31 20:16:21.753 NVP(0): Waiting for prebuffer..  1 AAAAAAAAAuLAAUAUL
2009-08-31 20:16:22.113 NVP(0): prebuffering pause
2009-08-31 20:16:22.113 NVP(0): Waiting for prebuffer..  0 aLAAAAALAAAAAAAAA
2009-08-31 20:16:22.246 NVP(0): Waiting for prebuffer..  1 AuAAALAUUAAAAALAA
2009-08-31 20:16:22.603 NVP(0): prebuffering pause
2009-08-31 20:16:22.603 NVP(0): Waiting for prebuffer..  0 AAAAAaAAALLAAAAAA
2009-08-31 20:16:22.736 NVP(0): Waiting for prebuffer..  1 AAUULAAAAuLAAAAAA
2009-08-31 20:16:23.038 NVP(0): prebuffering pause
2009-08-31 20:16:23.039 NVP(0): Waiting for prebuffer..  0 aLAAAAAAAAAAAALAA
2009-08-31 20:16:23.172 NVP(0): Waiting for prebuffer..  1 aLAAALAAAAAUUAUAA
2009-08-31 20:16:23.513 NVP(0): prebuffering pause
2009-08-31 20:16:23.513 NVP(0): Waiting for prebuffer..  0 AAAALaAAALAAAAAAA
2009-08-31 20:16:23.646 NVP(0): Waiting for prebuffer..  1 AAAAUAULAuLAAAAAA
2009-08-31 20:16:23.723 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2009-08-31 20:16:23.723 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2009-08-31 20:16:23.763 TV: HandleStateChange(0) -- begin
2009-08-31 20:16:23.763 TV: Attempting to change from Watching WatchingPreRecorded to None
2009-08-31 20:16:23.763 TV: StopStuff() for player ctx 0 -- begin
2009-08-31 20:16:23.763 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2009-08-31 20:16:23.763 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2009-08-31 20:16:23.763 TV: StopStuff(): stopping ring buffer
2009-08-31 20:16:23.800 NVP(0): Exited decoder loop.
2009-08-31 20:16:23.811 TV: StopStuff(): stopping player
2009-08-31 20:16:23.812 TV: StopStuff() -- end
2009-08-31 20:16:23.812 TV: Changing from Watching WatchingPreRecorded to None
2009-08-31 20:16:23.812 TV: HandleStateChange(0) -- end
2009-08-31 20:16:23.812 TV: StartTV -- process events end
2009-08-31 20:16:23.812 TV: StartTV -- process events 2 begin
2009-08-31 20:16:23.812 ScreenSaverX11Private: DPMS Reactivated 1
2009-08-31 20:16:23.812 TV: StartTV -- process events 2 end
2009-08-31 20:16:23.813 TV::~TV() -- begin
2009-08-31 20:16:23.815 TV::~TV() -- lock
2009-08-31 20:16:23.815 VidOutVDPAU: DiscardFrames(1)
2009-08-31 20:16:23.815 VideoBuffers::DiscardFrames(1): LAAAAAAAAAuAAAuAA
2009-08-31 20:16:23.815 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2009-08-31 20:16:23.815 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2009-08-31 20:16:23.815 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2009-08-31 20:16:23.945 TV::~TV() -- end
2009-08-31 20:16:23.945 TV: StartTV -- end