2010-06-24 22:45:23.425 mythfrontend version: trunk [25169] www.mythtv.org
2010-06-24 22:45:23.426 Using runtime prefix = /opt/mythtv/
2010-06-24 22:45:23.426 Using configuration directory = /home/myth/.mythtv
2010-06-24 22:45:23.991 Using localhost value of mythfe2
2010-06-24 22:45:23.992 Testing network connectivity to '192.168.1.200'
2010-06-24 22:45:24.004 New DB connection, total: 1
2010-06-24 22:45:24.010 Connected to database 'mythconverg' at host: 192.168.1.200
2010-06-24 22:45:24.011 Closing DB connection named 'DBManager0'
2010-06-24 22:45:24.011 Current locale en_US
2010-06-24 22:45:24.011 No locale defaults file for en_US, skipping
2010-06-24 22:45:24.023 ScreenSaverX11Private: Gnome screen saver support enabled
2010-06-24 22:45:24.030 DPMS is disabled.
2010-06-24 22:45:24.033 Connected to database 'mythconverg' at host: 192.168.1.200
2010-06-24 22:45:24.061 Desktop video mode: 1920x1080 60.0024 Hz
2010-06-24 22:45:24.095 max_width: 1920 max_height: 1080
2010-06-24 22:45:24.097 user: 493 effective user: 493 before privileged thread
2010-06-24 22:45:24.098 user: 493 effective user: 493 after privileged thread
2010-06-24 22:45:24.098 user: 493 effective user: 493 run_priv_thread
2010-06-24 22:45:24.098 Enabled verbose msgs:  important general audio playback
2010-06-24 22:45:24.138 LIRC: Successfully initialized '/var/run/lirc/lircd' using '/home/myth/.mythtv/lircrc' config
2010-06-24 22:45:24.139 JoystickMenuThread: Joystick disabled - Failed to read /home/myth/.mythtv/joystickmenurc
2010-06-24 22:45:24.221 Using Frameless Window
2010-06-24 22:45:24.486 Using the OpenGL painter
2010-06-24 22:45:24.572 OpenGL: OpenGL vendor  : NVIDIA Corporation
2010-06-24 22:45:24.572 OpenGL: OpenGL renderer: GeForce GT 220/PCI/SSE2/3DNOW!
2010-06-24 22:45:24.572 OpenGL: OpenGL version : 3.2.0 NVIDIA 195.36.24
2010-06-24 22:45:24.572 OpenGL: Max texture size: 8192 x 8192
2010-06-24 22:45:24.572 OpenGL: Max texture units: 4
2010-06-24 22:45:24.572 OpenGL: Direct rendering: Yes
2010-06-24 22:45:24.572 Initialised MythRenderOpenGL
2010-06-24 22:45:24.747 Current MythTV Schema Version (DBSchemaVer): 1259
2010-06-24 22:45:24.747 VDP: decoder<->render support: ffmpeg      null xlib xshm xv-blit opengl vdpau
2010-06-24 22:45:24.747 VDP: decoder<->render support: libmpeg2    null xlib xshm xv-blit opengl vdpau
2010-06-24 22:45:24.747 VDP: decoder<->render support: xvmc        xvmc-blit
2010-06-24 22:45:24.747 VDP: decoder<->render support: xvmc-vld    xvmc-blit
2010-06-24 22:45:24.747 VDP: decoder<->render support: vdpau       vdpau
2010-06-24 22:45:24.753 VDP: Ignoring profile item 188 (OSD Renderer opengl is not supported w/renderer xvmc-blit (supported: chromakey,ia44blend))
2010-06-24 22:45:24.756 VDP: Ignoring profile item 186 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
2010-06-24 22:45:24.762 VDP: Ignoring profile item 198 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
2010-06-24 22:45:24.762 VDP: Ignoring profile item 199 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
2010-06-24 22:45:24.764 VDP: Ignoring profile item 202 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
2010-06-24 22:45:24.764 VDP: Ignoring profile item 203 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
2010-06-24 22:45:24.766 VDP: Ignoring profile item 206 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
2010-06-24 22:45:24.766 VDP: Ignoring profile item 207 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
2010-06-24 22:45:25.246 AO: Sample rate 22050 is supported
2010-06-24 22:45:25.246 AO: Sample rate 44100 is supported
2010-06-24 22:45:25.246 AO: Sample rate 48000 is supported
2010-06-24 22:45:25.246 AO: Sample rate 88200 is supported
2010-06-24 22:45:25.246 AO: Sample rate 96000 is supported
2010-06-24 22:45:25.246 AO: Sample rate 176400 is supported
2010-06-24 22:45:25.246 AO: Sample rate 192000 is supported
2010-06-24 22:45:25.251 AO: Killing AudioOutputDSP
2010-06-24 22:45:25.251 ALSA: Setting IEC958 status: audio
2010-06-24 22:45:25.252 Found ALSA:hdmi:CARD=NVidia (ALSA:hdmi:CARD=NVidia
Device supports up to 7.1 (AC3,DTS,multi-channels LPCM))
2010-06-24 22:45:25.540 Registering Internal as a media playback plugin.
2010-06-24 22:45:25.598 Registering WebBrowser as a media playback plugin.
2010-06-24 22:45:25.674 MonitorRegisterExtensions(0x100, gif,jpg,png)
2010-06-24 22:45:25.700 Current MythMusic Schema Version (MusicDBSchemaVer): 1017
2010-06-24 22:45:25.784 MonitorRegisterExtensions(0x40, mp3,mp2,ogg,oga,flac,wma,wav,ac3,oma,omg,atp,ra,dts,aac,m4a,aa3,tta,mka,aiff,swa,wv)
2010-06-24 22:45:25.820 Current MythVideo Schema Version (mythvideo.DBSchemaVer): 1036
2010-06-24 22:45:25.892 Starting update of NDFD-18_Hour
2010-06-24 22:45:25.894 NDFD-18_Hour recently updated, skipping.
2010-06-24 22:45:25.894 Starting update of NWS-XML
2010-06-24 22:45:25.901 Starting update of NDFD-6_day
2010-06-24 22:45:25.902 NDFD-6_day recently updated, skipping.
2010-06-24 22:45:25.999 Loading menu theme from /home/myth/.mythtv/mainmenu.xml
2010-06-24 22:45:26.007 Found mainmenu.xml for theme 'MythCenter-wide'
2010-06-24 22:45:26.155 MythCoreContext: Connecting to backend server: 192.168.1.200:6543 (try 1 of 1)
2010-06-24 22:45:26.156 Using protocol version 57
2010-06-24 22:45:26.161 SendReceiveStringList(QUERY_TIME_ZONE) called from UI thread
2010-06-24 22:45:26.370 'nice /opt/mythtv/share/mythtv/mythweather/scripts/us_nws/nwsxml.pl -u ENG -d /home/myth/.mythtv/MythWeather/NWS-XML KARR' has exited
2010-06-24 22:45:28.208 Loading menu theme from /opt/mythtv//share/mythtv/themes/defaultmenu//library.xml
2010-06-24 22:45:29.746 MythVideo::ScanVideoDirectory Scanning Group (myth://Videos@pluribus/mediaexport/MOVIES/)
2010-06-24 22:45:29.748 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.765 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.767 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.768 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.769 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.771 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.772 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.774 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.776 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.779 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.780 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.782 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.783 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.787 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.789 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.791 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.797 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.804 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.806 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.808 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.809 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.810 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.812 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.813 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.814 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.816 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.817 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread
2010-06-24 22:45:29.860 New DB connection, total: 2
2010-06-24 22:45:29.862 Connected to database 'mythconverg' at host: 192.168.1.200
2010-06-24 22:45:30.029 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image
2010-06-24 22:45:30.741 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image
2010-06-24 22:45:31.118 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image
2010-06-24 22:45:31.336 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image
2010-06-24 22:45:31.532 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image
2010-06-24 22:45:31.745 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image
2010-06-24 22:45:31.939 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image
2010-06-24 22:45:33.506 TV: StartTV() -- begin
2010-06-24 22:45:33.506 TV: ctor -- begin
2010-06-24 22:45:33.514 TV: ctor -- end
2010-06-24 22:45:33.514 TV: Init -- begin
2010-06-24 22:45:33.515 TV: Init -- end channel groups
2010-06-24 22:45:33.522 TV: DrawUnusedRects() -- begin
2010-06-24 22:45:33.522 TV: DrawUnusedRects() -- end
2010-06-24 22:45:33.523 TV: Init -- end
2010-06-24 22:45:33.523 SendReceiveStringList(MESSAGE,SYSTEM_EVENT PLAY_STARTED HOSTNAME mythfe2 CHANID 0 STARTTIME 2010-06-24T21:10:33 SENDER mythfe2) called from UI thread
2010-06-24 22:45:33.524 TV: tv->Playback() -- begin
2010-06-24 22:45:33.530 TV: tv->Playback() -- end
2010-06-24 22:45:33.530 TV: StartTV -- process events begin
2010-06-24 22:45:33.584 TV: HandleStateChange(0) -- begin
2010-06-24 22:45:33.584 TV: Attempting to change from None to Unknown(5)
2010-06-24 22:45:33.584 RingBuf(myth://Videos@192.168.1.200:6543/1201.mp4): OpenFile(myth://Videos@192.168.1.200:6543/1201.mp4, 12)
2010-06-24 22:45:33.597 RingBuf(myth://Videos@192.168.1.200:6543/1201.mp4): CalcReadAheadThresh(0 KB)
			 -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2010-06-24 22:45:33.657 TV: StartPlayer(0, Unknown(5), main) -- begin
2010-06-24 22:45:33.657 TV: Elapsed time since TV constructor was called: 151 ms
2010-06-24 22:45:33.690 AudioPlayer: Disabling Audio, params(0,2,44100)
2010-06-24 22:45:33.828 AO: Sample rate 22050 is supported
2010-06-24 22:45:33.828 AO: Sample rate 44100 is supported
2010-06-24 22:45:33.828 AO: Sample rate 48000 is supported
2010-06-24 22:45:33.828 AO: Sample rate 88200 is supported
2010-06-24 22:45:33.828 AO: Sample rate 96000 is supported
2010-06-24 22:45:33.828 AO: Sample rate 176400 is supported
2010-06-24 22:45:33.828 AO: Sample rate 192000 is supported
2010-06-24 22:45:33.832 AO: Killing AudioOutputDSP
2010-06-24 22:45:33.833 AO: Original codec was NONE, unknown, 44 kHz, 2 channels
2010-06-24 22:45:33.834 AO: Audio processing enabled
2010-06-24 22:45:33.834 AO: Opening audio device 'hdmi:CARD=NVidia' ch 2(2) sr 44100 sf signed 32 bit reenc 0
2010-06-24 22:45:33.834 ALSA: Setting IEC958 status: non-audio
2010-06-24 22:45:33.834 Opening ALSA audio device 'hdmi:CARD=NVidia'.
2010-06-24 22:45:33.835 ALSA: SetParameters(format=10, channels=2, rate=44100, buffer_time=100000, period_time=50000)
2010-06-24 22:45:33.835 ALSA: Buffer time = 100136 us
2010-06-24 22:45:33.835 ALSA: Period time = 50068 us
2010-06-24 22:45:33.858 ALSA: Buffer size = 4416 | Period size = 2208
2010-06-24 22:45:33.882 AO: Software volume enabled
2010-06-24 22:45:33.891 AO: Audio fragment size: 8832
2010-06-24 22:45:33.891 AO: Audio Stretch Factor: 1
2010-06-24 22:45:33.891 AO: Ending Reconfigure()
2010-06-24 22:45:33.891 AudioPlayer: Enabling Audio
2010-06-24 22:45:33.891 AO: Reconfigure(): No change -> exiting
2010-06-24 22:45:33.891 AO: kickoffOutputAudioLoop: pid = 15389
2010-06-24 22:45:33.891 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:34.227 AFD: Stream #0, has id 0x1 codec id H264, type Video, bitrate 2383034 at 0xb579f90
2010-06-24 22:45:34.247 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2010-06-24 22:45:34.247 VDP: LoadBestPreferences(2048x2048, 0)
2010-06-24 22:45:34.247 VDP: LoadBestPreferences(2048x2048, 60)
2010-06-24 22:45:34.247 VDP: LoadBestPreferences(720x464, 60)
2010-06-24 22:45:34.264 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2010-06-24 22:45:34.264 VDP: LoadBestPreferences(2048x2048, 0)
2010-06-24 22:45:34.264 VDP: LoadBestPreferences(2048x2048, 60)
2010-06-24 22:45:34.264 VDP: LoadBestPreferences(720x464, 60)
2010-06-24 22:45:34.264 AFD: Using 1 CPUs for decoding
2010-06-24 22:45:34.264 AFD: InitVideoCodec() 0xb57a170 id(H264) type (Video).
2010-06-24 22:45:34.264 NVP(0): detectInterlace(Detect Scan, Interlaced Scan, 23.976, 464) ->Interlaced Scan
2010-06-24 22:45:34.264 AFD Warning: ScanATSCCaptionStreams() called with no PMT
2010-06-24 22:45:34.264 AFD: Using vdpau for video decoding
2010-06-24 22:45:34.264 AFD: Looking for decoder for H264
2010-06-24 22:45:34.264 AFD: Opened codec 0xb57a170, id(H264) type(Video)
2010-06-24 22:45:34.264 AFD: Stream #1, has id 0x2 codec id AAC, type Audio, bitrate 216202 at 0xb57a7c0
2010-06-24 22:45:34.264 AFD: codec AAC has 6 channels
2010-06-24 22:45:34.264 AFD: Looking for decoder for AAC
2010-06-24 22:45:34.264 AFD: Opened codec 0xb579240, id(AAC) type(Audio)
2010-06-24 22:45:34.265 AFD: Audio Track #1 is A/V stream #1 and has 6 channels in the English language(6647399).
2010-06-24 22:45:34.272 RingBuf(myth://Videos@192.168.1.200:6543/1201.mp4): CalcReadAheadThresh(0 KB)
			 -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2010-06-24 22:45:34.272 AFD: Selected track 1: English LIBFAAD 5.1ch (A/V Stream #1)
2010-06-24 22:45:34.273 AFD: Initializing audio parms from audio track #1
2010-06-24 22:45:34.273 AFD: Audio format changed 
			from id(NONE)     -1Hz -1ch -1bps     to id( AAC)  48000Hz  6ch 16bps    
2010-06-24 22:45:34.273 AO: SetEffDsp: 4800000
2010-06-24 22:45:34.273 AO: Needs downmix from 6 -> 2 channels
2010-06-24 22:45:34.273 AO: Killing AudioOutputDSP
2010-06-24 22:45:34.274 AO: OutputAudioLoop: Stop Event
2010-06-24 22:45:34.274 AO: kickoffOutputAudioLoop exiting
2010-06-24 22:45:34.274 AO: Original codec was AAC, signed 16 bit, 48 kHz, 6 channels
2010-06-24 22:45:34.274 AO: Audio processing enabled
2010-06-24 22:45:34.274 AO: Opening audio device 'hdmi:CARD=NVidia' ch 2(6) sr 48000 sf signed 32 bit reenc 0
2010-06-24 22:45:34.274 ALSA: Setting IEC958 status: audio
2010-06-24 22:45:34.275 Opening ALSA audio device 'hdmi:CARD=NVidia'.
2010-06-24 22:45:34.275 ALSA: SetParameters(format=10, channels=2, rate=48000, buffer_time=100000, period_time=50000)
2010-06-24 22:45:34.275 ALSA: Buffer time = 100000 us
2010-06-24 22:45:34.275 ALSA: Period time = 50000 us
2010-06-24 22:45:34.299 ALSA: Buffer size = 4800 | Period size = 2400
2010-06-24 22:45:34.323 AO: Software volume enabled
2010-06-24 22:45:34.345 AO: Audio fragment size: 9600
2010-06-24 22:45:34.345 AO: Audio Stretch Factor: 1
2010-06-24 22:45:34.345 AO: Ending Reconfigure()
2010-06-24 22:45:34.345 AO: kickoffOutputAudioLoop: pid = 15389
2010-06-24 22:45:34.345 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2010-06-24 22:45:34.345 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:34.361 Dec: SyncPositionMap prerecorded, from DB: 0 entries
2010-06-24 22:45:34.361 AFD: Recording has no position -- using libavformat seeking.
2010-06-24 22:45:34.361 AFD: Successfully opened decoder for file: "myth://Videos@192.168.1.200:6543/1201.mp4". novideo(0)
2010-06-24 22:45:34.371 VideoOutput: Allowed renderers: vdpau
2010-06-24 22:45:34.371 VideoOutput: Allowed renderers (filt: vdpau): vdpau
2010-06-24 22:45:34.395 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2010-06-24 22:45:34.395 VDP: LoadBestPreferences(2048x2048, 0)
2010-06-24 22:45:34.395 VDP: LoadBestPreferences(2048x2048, 60)
2010-06-24 22:45:34.395 VDP: LoadBestPreferences(720x464, 60)
2010-06-24 22:45:34.395 VideoOutput: Preferred renderer: vdpau
2010-06-24 22:45:34.395 VideoOutput: Trying video renderer: 'vdpau'
2010-06-24 22:45:34.505 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2010-06-24 22:45:34.505 VDP: LoadBestPreferences(2048x2048, 0)
2010-06-24 22:45:34.505 VDP: LoadBestPreferences(2048x2048, 60)
2010-06-24 22:45:34.513 VideoOutWindow::SetPIPState. pip_state: 0]
2010-06-24 22:45:34.513 Display Rect  left: 0, top: 148, width: 1805, height: 723, aspect: 1.33333
2010-06-24 22:45:34.513 Video Rect    left: 0, top: 0, width: 720, height: 464, aspect: 1.88088
2010-06-24 22:45:34.513 VDP: LoadBestPreferences(720x464, 60)
2010-06-24 22:45:34.513 Display Rect  left: 0, top: 148, width: 1805, height: 723, aspect: 1.33333
2010-06-24 22:45:34.513 Video Rect    left: 0, top: 0, width: 720, height: 464, aspect: 1.88088
2010-06-24 22:45:34.513 VDP: SetVideoRenderer(vdpau)
2010-06-24 22:45:34.513 VDP: SetVideoRender(vdpau) == GetVideoRenderer()
2010-06-24 22:45:34.514 VideoOutput: Pixel dimensions: Screen 1920x1080, window 1805x1020
2010-06-24 22:45:34.514 VideoOutput: Actual display dimensions: 488x274 mm  Aspect: 1.78102
2010-06-24 22:45:34.514 VideoOutput: Estimated window dimensions: 458x258 mm  Aspect: 1.77519
2010-06-24 22:45:34.542 VDPAU: Created 2 output surfaces.
2010-06-24 22:45:34.542 VDPAU: Set colorkey to 0x20202
2010-06-24 22:45:34.542 VDPAU: Version 1
2010-06-24 22:45:34.542 VDPAU: Information NVIDIA VDPAU Driver Shared Library  195.36.24  Thu Apr 22 10:39:56 PDT 2010
2010-06-24 22:45:34.542 VDPAU: HQ scaling level 1 of 9 available.
2010-06-24 22:45:34.542 VDPAU: MPEG4 hardware acceleration supported.
2010-06-24 22:45:34.542 VDPAU: Created VDPAU render device 1805x1020
2010-06-24 22:45:34.542 VidOutVDPAU: Created VDPAU osd (1805x1020)
2010-06-24 22:45:34.555 VidOutVDPAU: PictureAttributes: Brightness, Contrast, Colour, Hue, 
2010-06-24 22:45:34.564 VidOutVDPAU: Using ITU BT.601 colorspace
2010-06-24 22:45:34.564 Display Rect  left: 0, top: 28, width: 1805, height: 964, aspect: 1.77778
2010-06-24 22:45:34.564 Video Rect    left: 0, top: 0, width: 720, height: 464, aspect: 1.88088
2010-06-24 22:45:34.564 VidOutVDPAU: Created VDPAU context (GPU decode)
2010-06-24 22:45:34.570 Over/underscan. V: 0, H: 0
2010-06-24 22:45:34.570 Display Rect  left: 0, top: 28, width: 1805, height: 964, aspect: 1.77778
2010-06-24 22:45:34.570 Video Rect    left: 0, top: 0, width: 720, height: 464, aspect: 1.88088
2010-06-24 22:45:34.570 VDP: LoadBestPreferences(720x464, 23.976)
2010-06-24 22:45:34.570 NVP(0): Forcing decode extra audio option on (Video method requires it).
2010-06-24 22:45:34.570 FilterManager: GetFilterInfo(convert) returning: 0x0
2010-06-24 22:45:34.570 NVP(0): LoadFilters('vdpaucolorspace=auto'..) -> 0x0
2010-06-24 22:45:34.572 OSD: Base theme size: 1280x720
2010-06-24 22:45:34.572 OSD: Scaling factors: 1.40937x1.41667
2010-06-24 22:45:34.572 NVP(0): Decoder thread starting.
2010-06-24 22:45:34.580 VidOutVDPAU: Created VDPAU decoder (2 ref frames)
2010-06-24 22:45:34.580 Detect Letterbox: The source is not a supported frame format (was 11)
2010-06-24 22:45:34.583 OSD: Loaded window osd_message
2010-06-24 22:45:34.586 OSD: Loaded window osd_input
2010-06-24 22:45:34.603 OSD: Loaded window program_info
2010-06-24 22:45:34.607 OSD: Loaded window browse_info
2010-06-24 22:45:34.611 OSD: Loaded window osd_status
2010-06-24 22:45:34.614 OSD: Loaded window osd_program_editor
2010-06-24 22:45:34.614 OSD: Loaded OSD: size 1804x1020 offset 0+0
2010-06-24 22:45:34.614 OSD: Base theme size: 1280x720
2010-06-24 22:45:34.614 OSD: Scaling factors: 1.40937x1.41667
2010-06-24 22:45:34.616 OSD: Base theme size: 1280x720
2010-06-24 22:45:34.616 OSD: Scaling factors: 1.40937x1.41667
2010-06-24 22:45:34.618 NVP(0): ClearAfterSeek(1)
2010-06-24 22:45:34.618 VidOutVDPAU: ClearAfterSeek()
2010-06-24 22:45:34.618 VidOutVDPAU: DiscardFrames(0)
2010-06-24 22:45:34.618 VideoBuffers::DiscardFrames(0): AUUUUUUUUUUUUUuuL
2010-06-24 22:45:34.618 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAaaL -- done
2010-06-24 22:45:34.618 VidOutVDPAU: DiscardFrames() 3: LAAAAAAAAAAAAAAaL -- done()
2010-06-24 22:45:34.618 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
2010-06-24 22:45:34.621 VidOutVDPAU: Enabled deinterlacing.
2010-06-24 22:45:34.622 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2010-06-24 22:45:34.622 VSYNC: RTCVideoSync: Could not open /dev/rtc, Permission denied.
2010-06-24 22:45:34.622 VSYNC: Set video sync frame interval to 41708
2010-06-24 22:45:34.623 NVP(0): Video timing method: USleep with busy wait
2010-06-24 22:45:34.623 NVP(0): Refresh rate: 16666, frame interval: 41708
2010-06-24 22:45:34.624 playCtx: StartPlaying(): took 0 ms to start player.
2010-06-24 22:45:34.624 TV: StartPlayer(0, Unknown(5), main) -- end ok
2010-06-24 22:45:34.624 TV: Changing from None to Unknown(5)
2010-06-24 22:45:34.627 TV: HandleStateChange(0) -- end
2010-06-24 22:45:34.627 OSD: Created window OSD_INTERACTIVE
2010-06-24 22:45:34.627 NVP(0): progressive frame seen after 2 interlaced  frames
2010-06-24 22:45:34.631 VDPAU: Added 2 output surfaces (total 4, max 4)
2010-06-24 22:45:34.648 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:34.665 ScreenSaverX11Private: ResetTimer -- begin
2010-06-24 22:45:34.665 ScreenSaverX11Private: StopTimer
2010-06-24 22:45:34.666 ScreenSaverX11Private: StartTimer
2010-06-24 22:45:34.666 ScreenSaverX11Private: ResetTimer -- end
2010-06-24 22:45:34.667 TV: DrawUnusedRects() -- begin
2010-06-24 22:45:34.667 TV: DrawUnusedRects() -- end
2010-06-24 22:45:34.667 TV: DrawUnusedRects() -- begin
2010-06-24 22:45:34.667 TV: DrawUnusedRects() -- end
2010-06-24 22:45:34.667 NVP(0): Video is 3.34468 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.667 VSYNC: Set video sync frame interval to 41708
2010-06-24 22:45:34.668 NVP(0): Disabled deinterlacing
2010-06-24 22:45:34.668 NVP(0): Video is 5.73931 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.668 NVP(0): Video is 7.29551 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.668 NVP(0): Video is 8.21089 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.688 NVP(0): Video is 8.6457 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.688 NVP(0): Video is 8.84593 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.688 NVP(0): Video is 8.74434 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.688 NVP(0): Video is 8.4164 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.688 NVP(0): Video is 7.9187 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.709 NVP(0): Video is 7.29965 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.709 NVP(0): Video is 6.7095 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.709 NVP(0): Video is 6.01515 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.709 NVP(0): Video is 5.24863 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.709 NVP(0): Video is 4.42198 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.709 NVP(0): Video is 3.55025 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:34.882 AFD: HandleGopStart: gopset not set, syncing positionMap
2010-06-24 22:45:34.882 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2010-06-24 22:45:34.882 AFD: HandleGopStart: Initial key frame distance: 15.
'video_output' mean = '35668.53', std. dev. = '14644.73', fps = '28.04'
2010-06-24 22:45:38.754 TV: DoNVPSeek() -- begin
2010-06-24 22:45:38.754 AO: Pause 1
2010-06-24 22:45:38.754 TV: DoNVPSeek() -- ff
2010-06-24 22:45:38.754 TV: DoNVPSeek() -- end
2010-06-24 22:45:38.754 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:38.764 AFD: DoFastForward(14513 (144), do discard frames)
2010-06-24 22:45:38.764 No DTS Seeking Hack!
2010-06-24 22:45:38.764 AFD: SeekReset(51, 0, do flush, do discard)
2010-06-24 22:45:38.764 AFD: SeekReset() flushing
2010-06-24 22:45:38.764 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:38.764 VideoBuffers::DiscardFrames(1): UUUUUUUAUAUUUUUUU
2010-06-24 22:45:38.764 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:38.764 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:38.764 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:38.765 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:38.765 NVP(0): Waiting for video buffers...
2010-06-24 22:45:38.797 AO: OutputAudioLoop: audio paused
2010-06-24 22:45:38.814 AO: Pause 0
2010-06-24 22:45:38.838 NVP(0): Video is 3.91534 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.847 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:38.858 NVP(0): Video is 5.17826 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.858 NVP(0): Video is 5.9936 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.858 NVP(0): Video is 6.35334 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.858 NVP(0): Video is 6.37739 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.858 NVP(0): Video is 6.14369 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.879 NVP(0): Video is 5.71665 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.879 NVP(0): Video is 5.26451 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.879 NVP(0): Video is 4.67965 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.879 NVP(0): Video is 3.98926 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:38.879 NVP(0): Video is 3.21972 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.698 TV: DoNVPSeek() -- begin
2010-06-24 22:45:39.698 AO: Pause 1
2010-06-24 22:45:39.699 TV: DoNVPSeek() -- ff
2010-06-24 22:45:39.699 TV: DoNVPSeek() -- end
2010-06-24 22:45:39.699 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:39.709 AFD: DoFastForward(28931 (14562), do discard frames)
2010-06-24 22:45:39.709 No DTS Seeking Hack!
2010-06-24 22:45:39.709 AFD: SeekReset(14512, 0, do flush, do discard)
2010-06-24 22:45:39.709 AFD: SeekReset() flushing
2010-06-24 22:45:39.709 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:39.709 VideoBuffers::DiscardFrames(1): UUUUUUAUUUAUUUUUU
2010-06-24 22:45:39.709 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.709 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:39.709 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.709 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:39.709 NVP(0): Waiting for video buffers...
2010-06-24 22:45:39.720 TV: DoNVPSeek() -- begin
2010-06-24 22:45:39.720 TV: DoNVPSeek() -- ff
2010-06-24 22:45:39.720 TV: DoNVPSeek() -- end
2010-06-24 22:45:39.720 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:39.747 AO: OutputAudioLoop: audio paused
2010-06-24 22:45:39.753 AFD: DoFastForward(43316 (28932), do discard frames)
2010-06-24 22:45:39.754 No DTS Seeking Hack!
2010-06-24 22:45:39.754 AFD: SeekReset(28930, 0, do flush, do discard)
2010-06-24 22:45:39.754 AFD: SeekReset() flushing
2010-06-24 22:45:39.754 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:39.754 VideoBuffers::DiscardFrames(1): AAAAAAAAAAUAAAAAA
2010-06-24 22:45:39.754 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.754 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:39.754 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.756 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:39.796 AO: Pause 0
2010-06-24 22:45:39.797 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:39.798 AO: Pause 0
2010-06-24 22:45:39.843 NVP(0): Video is 4.08325 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.843 TV: DoNVPSeek() -- begin
2010-06-24 22:45:39.843 AO: Pause 1
2010-06-24 22:45:39.843 TV: DoNVPSeek() -- ff
2010-06-24 22:45:39.843 TV: DoNVPSeek() -- end
2010-06-24 22:45:39.843 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:39.845 AFD: DoFastForward(57702 (43332), do discard frames)
2010-06-24 22:45:39.845 No DTS Seeking Hack!
2010-06-24 22:45:39.845 AFD: SeekReset(43315, 0, do flush, do discard)
2010-06-24 22:45:39.845 AFD: SeekReset() flushing
2010-06-24 22:45:39.845 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:39.845 VideoBuffers::DiscardFrames(1): UUUUUUAAUAUAUUUUU
2010-06-24 22:45:39.845 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.845 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:39.845 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.846 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:39.846 NVP(0): Waiting for video buffers...
2010-06-24 22:45:39.847 AO: OutputAudioLoop: audio paused
2010-06-24 22:45:39.898 NVP(0): Video is 5.66385 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.898 NVP(0): Waiting for video buffers...
2010-06-24 22:45:39.899 AO: Pause 0
2010-06-24 22:45:39.929 AO: Pause 0
2010-06-24 22:45:39.929 NVP(0): Video is 6.77139 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.929 NVP(0): Video is 7.53608 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.929 NVP(0): Video is 7.85787 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.929 NVP(0): Video is 7.84746 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.929 NVP(0): Video is 7.59389 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.929 NVP(0): Video is 7.15196 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.947 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:39.949 NVP(0): Video is 6.56876 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:39.949 TV: DoNVPSeek() -- begin
2010-06-24 22:45:39.949 AO: Pause 1
2010-06-24 22:45:39.949 TV: DoNVPSeek() -- ff
2010-06-24 22:45:39.949 TV: DoNVPSeek() -- end
2010-06-24 22:45:39.949 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:39.951 AO: Pause 0
2010-06-24 22:45:39.953 AFD: DoFastForward(72087 (57722), do discard frames)
2010-06-24 22:45:39.953 No DTS Seeking Hack!
2010-06-24 22:45:39.953 AFD: SeekReset(57701, 0, do flush, do discard)
2010-06-24 22:45:39.953 AFD: SeekReset() flushing
2010-06-24 22:45:39.953 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:39.953 VideoBuffers::DiscardFrames(1): UUUUUUAUUUUAAAUUA
2010-06-24 22:45:39.953 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.953 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:39.953 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:39.954 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:39.954 NVP(0): Waiting for video buffers...
2010-06-24 22:45:39.954 AO: Pause 1
2010-06-24 22:45:39.997 AO: OutputAudioLoop: audio paused
2010-06-24 22:45:40.002 AO: Pause 0
2010-06-24 22:45:40.002 NVP(0): Video is 6.00549 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.002 NVP(0): Waiting for video buffers...
2010-06-24 22:45:40.002 AO: Pause 1
2010-06-24 22:45:40.007 AO: Pause 0
2010-06-24 22:45:40.008 NVP(0): Video is 7.00362 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.028 NVP(0): Video is 7.53644 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.028 NVP(0): Video is 7.80419 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.028 NVP(0): Video is 7.75324 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.028 NVP(0): Video is 7.46329 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.028 NVP(0): Video is 7.00007 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.028 NVP(0): Video is 6.40091 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.035 AFD: HandleGopStart: gopset not set, syncing positionMap
2010-06-24 22:45:40.035 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2010-06-24 22:45:40.035 AFD: HandleGopStart: Initial key frame distance: 52.
2010-06-24 22:45:40.047 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:40.048 NVP(0): Video is 5.69977 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.048 NVP(0): Video is 5.05404 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.048 NVP(0): Video is 4.318 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.048 NVP(0): Video is 3.51422 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.447 TV: DoNVPSeek() -- begin
2010-06-24 22:45:40.447 AO: Pause 1
2010-06-24 22:45:40.447 TV: DoNVPSeek() -- ff
2010-06-24 22:45:40.447 TV: DoNVPSeek() -- end
2010-06-24 22:45:40.447 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:40.457 AFD: DoFastForward(86494 (72125), do discard frames)
2010-06-24 22:45:40.458 No DTS Seeking Hack!
2010-06-24 22:45:40.459 AFD: SeekReset(72100, 0, do flush, do discard)
2010-06-24 22:45:40.459 AFD: SeekReset() flushing
2010-06-24 22:45:40.459 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:40.459 VideoBuffers::DiscardFrames(1): UUUUAUUUUUUAUUUUU
2010-06-24 22:45:40.459 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.459 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:40.459 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.459 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:40.459 NVP(0): Waiting for video buffers...
2010-06-24 22:45:40.470 TV: DoNVPSeek() -- begin
2010-06-24 22:45:40.470 TV: DoNVPSeek() -- ff
2010-06-24 22:45:40.470 TV: DoNVPSeek() -- end
2010-06-24 22:45:40.470 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:40.497 AO: OutputAudioLoop: audio paused
2010-06-24 22:45:40.500 AFD: DoFastForward(100879 (86495), do discard frames)
2010-06-24 22:45:40.500 No DTS Seeking Hack!
2010-06-24 22:45:40.500 AFD: SeekReset(86493, 0, do flush, do discard)
2010-06-24 22:45:40.500 AFD: SeekReset() flushing
2010-06-24 22:45:40.500 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:40.500 VideoBuffers::DiscardFrames(1): AAAAUAAAAAAAAAAAA
2010-06-24 22:45:40.500 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.500 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:40.500 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.500 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:40.540 TV: DoNVPSeek() -- begin
2010-06-24 22:45:40.540 AO: Pause 0
2010-06-24 22:45:40.540 AO: Pause 1
2010-06-24 22:45:40.541 TV: DoNVPSeek() -- ff
2010-06-24 22:45:40.541 TV: DoNVPSeek() -- end
2010-06-24 22:45:40.541 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:40.542 AO: Pause 0
2010-06-24 22:45:40.544 AFD: DoFastForward(115264 (100883), do discard frames)
2010-06-24 22:45:40.544 No DTS Seeking Hack!
2010-06-24 22:45:40.544 AFD: SeekReset(100878, 0, do flush, do discard)
2010-06-24 22:45:40.544 AFD: SeekReset() flushing
2010-06-24 22:45:40.544 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:40.544 VideoBuffers::DiscardFrames(1): UUAAAAAAAAUAAAAAA
2010-06-24 22:45:40.544 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.544 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:40.544 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.545 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:40.545 NVP(0): Waiting for video buffers...
2010-06-24 22:45:40.545 AO: Pause 1
2010-06-24 22:45:40.547 AO: OutputAudioLoop: audio paused
2010-06-24 22:45:40.582 AO: Pause 0
2010-06-24 22:45:40.596 AFD: HandleGopStart: gopset not set, syncing positionMap
2010-06-24 22:45:40.596 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2010-06-24 22:45:40.596 AFD: HandleGopStart: Initial key frame distance: 14.
2010-06-24 22:45:40.597 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:40.632 NVP(0): Video is 3.21281 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.632 NVP(0): Video is 5.37667 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.632 NVP(0): Video is 6.74779 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.652 NVP(0): Video is 7.52438 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.652 NVP(0): Video is 7.98096 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.652 NVP(0): Video is 8.07763 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.652 NVP(0): Video is 7.89839 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.653 NVP(0): Video is 7.5122 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.673 NVP(0): Video is 6.97682 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.673 NVP(0): Video is 6.44339 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.673 NVP(0): Video is 5.79157 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.673 NVP(0): Video is 5.05697 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.673 NVP(0): Video is 4.25427 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.673 NVP(0): Video is 3.40047 frames behind audio (too slow), dropping frame to catch up.
'video_output' mean = '24853.77', std. dev. = '23284.28', fps = '40.24'
2010-06-24 22:45:40.697 TV: DoNVPSeek() -- begin
2010-06-24 22:45:40.697 AO: Pause 1
2010-06-24 22:45:40.697 TV: DoNVPSeek() -- ff
2010-06-24 22:45:40.697 TV: DoNVPSeek() -- end
2010-06-24 22:45:40.697 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:40.697 AO: OutputAudioLoop: audio paused
2010-06-24 22:45:40.707 AFD: DoFastForward(129666 (115297), do discard frames)
2010-06-24 22:45:40.708 No DTS Seeking Hack!
2010-06-24 22:45:40.708 AFD: SeekReset(115268, 0, do flush, do discard)
2010-06-24 22:45:40.708 AFD: SeekReset() flushing
2010-06-24 22:45:40.708 VidOutVDPAU: DiscardFrames(1)
2010-06-24 22:45:40.708 VideoBuffers::DiscardFrames(1): AUUUUUUUUUUAUUUUU
2010-06-24 22:45:40.708 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.708 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done
2010-06-24 22:45:40.708 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done()
2010-06-24 22:45:40.708 NVP(0): ClearAfterSeek(0)
2010-06-24 22:45:40.708 NVP(0): Waiting for video buffers...
2010-06-24 22:45:40.780 AO: Pause 0
2010-06-24 22:45:40.797 AO: OutputAudioLoop: Play Event
2010-06-24 22:45:40.799 NVP(0): Video is 4.64774 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.799 NVP(0): Video is 6.69862 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.799 NVP(0): Video is 7.99101 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.799 NVP(0): Video is 8.70854 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.820 NVP(0): Video is 8.99496 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.820 NVP(0): Video is 9.08389 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.820 NVP(0): Video is 8.89884 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.820 NVP(0): Video is 8.5083 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.820 NVP(0): Video is 7.96365 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.820 NVP(0): Video is 7.30941 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.840 NVP(0): Video is 6.56697 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.840 NVP(0): Video is 5.88427 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.840 NVP(0): Video is 5.12647 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.840 NVP(0): Video is 4.30639 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.840 NVP(0): Video is 3.43958 frames behind audio (too slow), dropping frame to catch up.
2010-06-24 22:45:40.936 AFD: HandleGopStart: gopset not set, syncing positionMap
2010-06-24 22:45:40.937 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2010-06-24 22:45:40.937 AFD: HandleGopStart: Initial key frame distance: 5.
2010-06-24 22:45:41.199 TV: DoNVPSeek() -- begin
2010-06-24 22:45:41.199 AO: Pause 1
2010-06-24 22:45:41.199 TV: DoNVPSeek() -- ff
2010-06-24 22:45:41.199 TV: DoNVPSeek() -- end
2010-06-24 22:45:41.199 UpdateOSDSeekMessage(Jump Ahead, 1)
2010-06-24 22:45:41.200 AO: Pause 0
2010-06-24 22:45:41.203 AFD: DoFastForward(135633 (129707), do discard frames)
2010-06-24 22:45:41.247 AO: OutputAudioLoop: Play Event