2010-06-24 22:43:13.356 mythfrontend version: trunk [25169] www.mythtv.org 2010-06-24 22:43:13.356 Using runtime prefix = /opt/mythtv/ 2010-06-24 22:43:13.356 Using configuration directory = /home/myth/.mythtv 2010-06-24 22:43:13.995 Using localhost value of mythfe2 2010-06-24 22:43:13.995 Testing network connectivity to '192.168.1.200' 2010-06-24 22:43:14.006 New DB connection, total: 1 2010-06-24 22:43:14.016 Connected to database 'mythconverg' at host: 192.168.1.200 2010-06-24 22:43:14.016 Closing DB connection named 'DBManager0' 2010-06-24 22:43:14.016 Current locale en_US 2010-06-24 22:43:14.016 No locale defaults file for en_US, skipping 2010-06-24 22:43:14.025 ScreenSaverX11Private: Gnome screen saver support enabled 2010-06-24 22:43:14.034 DPMS is disabled. 2010-06-24 22:43:14.036 Connected to database 'mythconverg' at host: 192.168.1.200 2010-06-24 22:43:14.063 Desktop video mode: 1920x1080 60.0024 Hz 2010-06-24 22:43:14.096 max_width: 1920 max_height: 1080 2010-06-24 22:43:14.099 user: 493 effective user: 493 before privileged thread 2010-06-24 22:43:14.099 user: 493 effective user: 493 after privileged thread 2010-06-24 22:43:14.099 Enabled verbose msgs: important general audio playback 2010-06-24 22:43:14.099 user: 493 effective user: 493 run_priv_thread 2010-06-24 22:43:14.126 LIRC: Successfully initialized '/var/run/lirc/lircd' using '/home/myth/.mythtv/lircrc' config 2010-06-24 22:43:14.126 JoystickMenuThread: Joystick disabled - Failed to read /home/myth/.mythtv/joystickmenurc 2010-06-24 22:43:14.204 Using Frameless Window 2010-06-24 22:43:14.467 Using the OpenGL painter 2010-06-24 22:43:14.565 OpenGL: OpenGL vendor : NVIDIA Corporation 2010-06-24 22:43:14.565 OpenGL: OpenGL renderer: GeForce GT 220/PCI/SSE2/3DNOW! 2010-06-24 22:43:14.565 OpenGL: OpenGL version : 3.2.0 NVIDIA 195.36.24 2010-06-24 22:43:14.565 OpenGL: Max texture size: 8192 x 8192 2010-06-24 22:43:14.565 OpenGL: Max texture units: 4 2010-06-24 22:43:14.565 OpenGL: Direct rendering: Yes 2010-06-24 22:43:14.566 Initialised MythRenderOpenGL 2010-06-24 22:43:14.733 Current MythTV Schema Version (DBSchemaVer): 1259 2010-06-24 22:43:14.733 VDP: decoder<->render support: ffmpeg null xlib xshm xv-blit opengl vdpau 2010-06-24 22:43:14.733 VDP: decoder<->render support: libmpeg2 null xlib xshm xv-blit opengl vdpau 2010-06-24 22:43:14.733 VDP: decoder<->render support: xvmc xvmc-blit 2010-06-24 22:43:14.733 VDP: decoder<->render support: xvmc-vld xvmc-blit 2010-06-24 22:43:14.733 VDP: decoder<->render support: vdpau vdpau 2010-06-24 22:43:14.739 VDP: Ignoring profile item 188 (OSD Renderer opengl is not supported w/renderer xvmc-blit (supported: chromakey,ia44blend)) 2010-06-24 22:43:14.742 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:43:14.747 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:43:14.747 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:43:14.749 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:43:14.749 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:43:14.751 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:43:14.751 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:43:15.234 AO: Sample rate 22050 is supported 2010-06-24 22:43:15.234 AO: Sample rate 44100 is supported 2010-06-24 22:43:15.234 AO: Sample rate 48000 is supported 2010-06-24 22:43:15.234 AO: Sample rate 88200 is supported 2010-06-24 22:43:15.234 AO: Sample rate 96000 is supported 2010-06-24 22:43:15.234 AO: Sample rate 176400 is supported 2010-06-24 22:43:15.234 AO: Sample rate 192000 is supported 2010-06-24 22:43:15.239 AO: Killing AudioOutputDSP 2010-06-24 22:43:15.239 ALSA: Setting IEC958 status: audio 2010-06-24 22:43:15.240 Found ALSA:hdmi:CARD=NVidia (ALSA:hdmi:CARD=NVidia Device supports up to 7.1 (AC3,DTS,multi-channels LPCM)) 2010-06-24 22:43:15.526 Registering Internal as a media playback plugin. 2010-06-24 22:43:15.585 Registering WebBrowser as a media playback plugin. 2010-06-24 22:43:15.658 MonitorRegisterExtensions(0x100, gif,jpg,png) 2010-06-24 22:43:15.683 Current MythMusic Schema Version (MusicDBSchemaVer): 1017 2010-06-24 22:43:15.766 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:43:15.803 Current MythVideo Schema Version (mythvideo.DBSchemaVer): 1036 2010-06-24 22:43:15.877 Starting update of NDFD-18_Hour 2010-06-24 22:43:15.878 NDFD-18_Hour recently updated, skipping. 2010-06-24 22:43:15.878 Starting update of NWS-XML 2010-06-24 22:43:15.879 NWS-XML recently updated, skipping. 2010-06-24 22:43:15.879 Starting update of NDFD-6_day 2010-06-24 22:43:15.880 NDFD-6_day recently updated, skipping. 2010-06-24 22:43:15.954 Loading menu theme from /home/myth/.mythtv/mainmenu.xml 2010-06-24 22:43:15.959 Found mainmenu.xml for theme 'MythCenter-wide' 2010-06-24 22:43:16.115 MythCoreContext: Connecting to backend server: 192.168.1.200:6543 (try 1 of 1) 2010-06-24 22:43:16.116 Using protocol version 57 2010-06-24 22:43:16.122 SendReceiveStringList(QUERY_TIME_ZONE) called from UI thread 2010-06-24 22:43:18.781 Loading menu theme from /opt/mythtv//share/mythtv/themes/defaultmenu//library.xml 2010-06-24 22:43:20.743 MythVideo::ScanVideoDirectory Scanning Group (myth://Videos@pluribus/mediaexport/MOVIES/) 2010-06-24 22:43:20.744 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.761 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.763 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.764 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.766 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.769 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.771 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.773 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.775 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.777 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.779 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.780 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.782 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.786 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.788 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.789 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.795 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.803 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.805 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.807 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.808 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.809 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.811 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.812 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.814 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.815 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.817 SendReceiveStringList(QUERY_SG_GETFILELIST,pluribus...) called from UI thread 2010-06-24 22:43:20.861 New DB connection, total: 2 2010-06-24 22:43:20.863 Connected to database 'mythconverg' at host: 192.168.1.200 2010-06-24 22:43:21.029 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image 2010-06-24 22:43:22.048 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image 2010-06-24 22:43:22.766 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image 2010-06-24 22:43:22.982 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image 2010-06-24 22:43:23.206 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image 2010-06-24 22:43:23.416 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image 2010-06-24 22:43:23.658 MythUIHelper, Error: LoadScaleImage(myth://Coverart@192.168.1.200:6543/No Cover) failed to load image 2010-06-24 22:43:26.949 TV: StartTV() -- begin 2010-06-24 22:43:26.949 TV: ctor -- begin 2010-06-24 22:43:26.957 TV: ctor -- end 2010-06-24 22:43:26.957 TV: Init -- begin 2010-06-24 22:43:26.957 TV: Init -- end channel groups 2010-06-24 22:43:26.965 TV: DrawUnusedRects() -- begin 2010-06-24 22:43:26.965 TV: DrawUnusedRects() -- end 2010-06-24 22:43:26.965 TV: Init -- end 2010-06-24 22:43:26.966 SendReceiveStringList(MESSAGE,SYSTEM_EVENT PLAY_STARTED HOSTNAME mythfe2 CHANID 0 STARTTIME 2010-06-24T21:08:26 SENDER mythfe2) called from UI thread 2010-06-24 22:43:26.966 TV: tv->Playback() -- begin 2010-06-24 22:43:26.973 TV: tv->Playback() -- end 2010-06-24 22:43:26.973 TV: StartTV -- process events begin 2010-06-24 22:43:27.028 TV: HandleStateChange(0) -- begin 2010-06-24 22:43:27.029 TV: Attempting to change from None to Unknown(5) 2010-06-24 22:43:27.029 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:43:27.042 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:43:27.095 TV: StartPlayer(0, Unknown(5), main) -- begin 2010-06-24 22:43:27.095 TV: Elapsed time since TV constructor was called: 146 ms 2010-06-24 22:43:27.128 AudioPlayer: Disabling Audio, params(0,2,44100) 2010-06-24 22:43:27.266 AO: Sample rate 22050 is supported 2010-06-24 22:43:27.266 AO: Sample rate 44100 is supported 2010-06-24 22:43:27.266 AO: Sample rate 48000 is supported 2010-06-24 22:43:27.266 AO: Sample rate 88200 is supported 2010-06-24 22:43:27.266 AO: Sample rate 96000 is supported 2010-06-24 22:43:27.266 AO: Sample rate 176400 is supported 2010-06-24 22:43:27.266 AO: Sample rate 192000 is supported 2010-06-24 22:43:27.270 AO: Killing AudioOutputDSP 2010-06-24 22:43:27.270 AO: Original codec was NONE, unknown, 44 kHz, 2 channels 2010-06-24 22:43:27.271 AO: Audio processing enabled 2010-06-24 22:43:27.271 AO: Opening audio device 'hdmi:CARD=NVidia' ch 2(2) sr 44100 sf signed 32 bit reenc 0 2010-06-24 22:43:27.271 ALSA: Setting IEC958 status: non-audio 2010-06-24 22:43:27.272 Opening ALSA audio device 'hdmi:CARD=NVidia'. 2010-06-24 22:43:27.272 ALSA: SetParameters(format=10, channels=2, rate=44100, buffer_time=100000, period_time=50000) 2010-06-24 22:43:27.272 ALSA: Buffer time = 100136 us 2010-06-24 22:43:27.272 ALSA: Period time = 50068 us 2010-06-24 22:43:27.296 ALSA: Buffer size = 4416 | Period size = 2208 2010-06-24 22:43:27.320 AO: Software volume enabled 2010-06-24 22:43:27.328 AO: Audio fragment size: 8832 2010-06-24 22:43:27.328 AO: Audio Stretch Factor: 1 2010-06-24 22:43:27.328 AO: Ending Reconfigure() 2010-06-24 22:43:27.328 AudioPlayer: Enabling Audio 2010-06-24 22:43:27.328 AO: Reconfigure(): No change -> exiting 2010-06-24 22:43:27.329 AO: kickoffOutputAudioLoop: pid = 15172 2010-06-24 22:43:27.329 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:27.661 AFD: Stream #0, has id 0x1 codec id H264, type Video, bitrate 2383034 at 0xbc35660 2010-06-24 22:43:27.696 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:43:27.696 VDP: LoadBestPreferences(2048x2048, 0) 2010-06-24 22:43:27.696 VDP: LoadBestPreferences(2048x2048, 60) 2010-06-24 22:43:27.696 VDP: LoadBestPreferences(720x464, 60) 2010-06-24 22:43:27.724 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:43:27.725 VDP: LoadBestPreferences(2048x2048, 0) 2010-06-24 22:43:27.725 VDP: LoadBestPreferences(2048x2048, 60) 2010-06-24 22:43:27.725 VDP: LoadBestPreferences(720x464, 60) 2010-06-24 22:43:27.725 AFD: Using 1 CPUs for decoding 2010-06-24 22:43:27.725 AFD: InitVideoCodec() 0xbc35840 id(H264) type (Video). 2010-06-24 22:43:27.725 NVP(0): detectInterlace(Detect Scan, Interlaced Scan, 23.976, 464) ->Interlaced Scan 2010-06-24 22:43:27.725 AFD Warning: ScanATSCCaptionStreams() called with no PMT 2010-06-24 22:43:27.725 AFD: Using vdpau for video decoding 2010-06-24 22:43:27.725 AFD: Looking for decoder for H264 2010-06-24 22:43:27.725 AFD: Opened codec 0xbc35840, id(H264) type(Video) 2010-06-24 22:43:27.725 AFD: Stream #1, has id 0x2 codec id AAC, type Audio, bitrate 216202 at 0xbc35cd0 2010-06-24 22:43:27.725 AFD: codec AAC has 6 channels 2010-06-24 22:43:27.725 AFD: Looking for decoder for AAC 2010-06-24 22:43:27.725 AFD: Opened codec 0xbc35ea0, id(AAC) type(Audio) 2010-06-24 22:43:27.725 AFD: Audio Track #1 is A/V stream #1 and has 6 channels in the English language(6647399). 2010-06-24 22:43:27.737 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:43:27.737 AFD: Selected track 1: English LIBFAAD 5.1ch (A/V Stream #1) 2010-06-24 22:43:27.737 AFD: Initializing audio parms from audio track #1 2010-06-24 22:43:27.737 AFD: Audio format changed from id(NONE) -1Hz -1ch -1bps to id( AAC) 48000Hz 6ch 16bps 2010-06-24 22:43:27.737 AO: SetEffDsp: 4800000 2010-06-24 22:43:27.737 AO: Needs downmix from 6 -> 2 channels 2010-06-24 22:43:27.737 AO: Killing AudioOutputDSP 2010-06-24 22:43:27.741 AO: OutputAudioLoop: Stop Event 2010-06-24 22:43:27.741 AO: kickoffOutputAudioLoop exiting 2010-06-24 22:43:27.742 AO: Original codec was AAC, signed 16 bit, 48 kHz, 6 channels 2010-06-24 22:43:27.742 AO: Audio processing enabled 2010-06-24 22:43:27.742 AO: Opening audio device 'hdmi:CARD=NVidia' ch 2(6) sr 48000 sf signed 32 bit reenc 0 2010-06-24 22:43:27.742 ALSA: Setting IEC958 status: audio 2010-06-24 22:43:27.742 Opening ALSA audio device 'hdmi:CARD=NVidia'. 2010-06-24 22:43:27.742 ALSA: SetParameters(format=10, channels=2, rate=48000, buffer_time=100000, period_time=50000) 2010-06-24 22:43:27.742 ALSA: Buffer time = 100000 us 2010-06-24 22:43:27.743 ALSA: Period time = 50000 us 2010-06-24 22:43:27.766 ALSA: Buffer size = 4800 | Period size = 2400 2010-06-24 22:43:27.790 AO: Software volume enabled 2010-06-24 22:43:27.810 AO: Audio fragment size: 9600 2010-06-24 22:43:27.810 AO: Audio Stretch Factor: 1 2010-06-24 22:43:27.810 AO: Ending Reconfigure() 2010-06-24 22:43:27.810 AO: kickoffOutputAudioLoop: pid = 15172 2010-06-24 22:43:27.810 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2010-06-24 22:43:27.810 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:27.838 Dec: SyncPositionMap prerecorded, from DB: 0 entries 2010-06-24 22:43:27.838 AFD: Recording has no position -- using libavformat seeking. 2010-06-24 22:43:27.838 AFD: Successfully opened decoder for file: "myth://Videos@192.168.1.200:6543/1201.mp4". novideo(0) 2010-06-24 22:43:27.850 VideoOutput: Allowed renderers: vdpau 2010-06-24 22:43:27.850 VideoOutput: Allowed renderers (filt: vdpau): vdpau 2010-06-24 22:43:27.877 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:43:27.877 VDP: LoadBestPreferences(2048x2048, 0) 2010-06-24 22:43:27.877 VDP: LoadBestPreferences(2048x2048, 60) 2010-06-24 22:43:27.877 VDP: LoadBestPreferences(720x464, 60) 2010-06-24 22:43:27.877 VideoOutput: Preferred renderer: vdpau 2010-06-24 22:43:27.877 VideoOutput: Trying video renderer: 'vdpau' 2010-06-24 22:43:27.962 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:43:27.962 VDP: LoadBestPreferences(2048x2048, 0) 2010-06-24 22:43:27.962 VDP: LoadBestPreferences(2048x2048, 60) 2010-06-24 22:43:27.971 VideoOutWindow::SetPIPState. pip_state: 0] 2010-06-24 22:43:27.971 Display Rect left: 0, top: 148, width: 1805, height: 723, aspect: 1.33333 2010-06-24 22:43:27.971 Video Rect left: 0, top: 0, width: 720, height: 464, aspect: 1.88088 2010-06-24 22:43:27.971 VDP: LoadBestPreferences(720x464, 60) 2010-06-24 22:43:27.971 Display Rect left: 0, top: 148, width: 1805, height: 723, aspect: 1.33333 2010-06-24 22:43:27.971 Video Rect left: 0, top: 0, width: 720, height: 464, aspect: 1.88088 2010-06-24 22:43:27.971 VDP: SetVideoRenderer(vdpau) 2010-06-24 22:43:27.971 VDP: SetVideoRender(vdpau) == GetVideoRenderer() 2010-06-24 22:43:27.971 VideoOutput: Pixel dimensions: Screen 1920x1080, window 1805x1020 2010-06-24 22:43:27.971 VideoOutput: Actual display dimensions: 488x274 mm Aspect: 1.78102 2010-06-24 22:43:27.971 VideoOutput: Estimated window dimensions: 458x258 mm Aspect: 1.77519 2010-06-24 22:43:28.000 VDPAU: Created 2 output surfaces. 2010-06-24 22:43:28.000 VDPAU: Set colorkey to 0x20202 2010-06-24 22:43:28.000 VDPAU: Version 1 2010-06-24 22:43:28.000 VDPAU: Information NVIDIA VDPAU Driver Shared Library 195.36.24 Thu Apr 22 10:39:56 PDT 2010 2010-06-24 22:43:28.000 VDPAU: HQ scaling level 1 of 9 available. 2010-06-24 22:43:28.000 VDPAU: MPEG4 hardware acceleration supported. 2010-06-24 22:43:28.000 VDPAU: Created VDPAU render device 1805x1020 2010-06-24 22:43:28.001 VidOutVDPAU: Created VDPAU osd (1805x1020) 2010-06-24 22:43:28.014 VidOutVDPAU: PictureAttributes: Brightness, Contrast, Colour, Hue, 2010-06-24 22:43:28.023 VidOutVDPAU: Using ITU BT.601 colorspace 2010-06-24 22:43:28.023 Display Rect left: 0, top: 28, width: 1805, height: 964, aspect: 1.77778 2010-06-24 22:43:28.023 Video Rect left: 0, top: 0, width: 720, height: 464, aspect: 1.88088 2010-06-24 22:43:28.023 VidOutVDPAU: Created VDPAU context (GPU decode) 2010-06-24 22:43:28.028 Over/underscan. V: 0, H: 0 2010-06-24 22:43:28.028 Display Rect left: 0, top: 28, width: 1805, height: 964, aspect: 1.77778 2010-06-24 22:43:28.028 Video Rect left: 0, top: 0, width: 720, height: 464, aspect: 1.88088 2010-06-24 22:43:28.028 VDP: LoadBestPreferences(720x464, 23.976) 2010-06-24 22:43:28.028 NVP(0): Forcing decode extra audio option on (Video method requires it). 2010-06-24 22:43:28.028 FilterManager: GetFilterInfo(convert) returning: 0x0 2010-06-24 22:43:28.028 NVP(0): LoadFilters('vdpaucolorspace=auto'..) -> 0x0 2010-06-24 22:43:28.031 OSD: Base theme size: 1280x720 2010-06-24 22:43:28.031 OSD: Scaling factors: 1.40937x1.41667 2010-06-24 22:43:28.031 NVP(0): Decoder thread starting. 2010-06-24 22:43:28.039 VidOutVDPAU: Created VDPAU decoder (2 ref frames) 2010-06-24 22:43:28.039 Detect Letterbox: The source is not a supported frame format (was 11) 2010-06-24 22:43:28.044 OSD: Loaded window osd_message 2010-06-24 22:43:28.047 OSD: Loaded window osd_input 2010-06-24 22:43:28.064 OSD: Loaded window program_info 2010-06-24 22:43:28.068 OSD: Loaded window browse_info 2010-06-24 22:43:28.071 OSD: Loaded window osd_status 2010-06-24 22:43:28.075 OSD: Loaded window osd_program_editor 2010-06-24 22:43:28.075 OSD: Loaded OSD: size 1804x1020 offset 0+0 2010-06-24 22:43:28.075 OSD: Base theme size: 1280x720 2010-06-24 22:43:28.075 OSD: Scaling factors: 1.40937x1.41667 2010-06-24 22:43:28.076 OSD: Base theme size: 1280x720 2010-06-24 22:43:28.077 OSD: Scaling factors: 1.40937x1.41667 2010-06-24 22:43:28.078 NVP(0): ClearAfterSeek(1) 2010-06-24 22:43:28.078 VidOutVDPAU: ClearAfterSeek() 2010-06-24 22:43:28.078 VidOutVDPAU: DiscardFrames(0) 2010-06-24 22:43:28.078 VideoBuffers::DiscardFrames(0): AUUUUUUUUUUUUUuuL 2010-06-24 22:43:28.078 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAaaL -- done 2010-06-24 22:43:28.078 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAaaL -- done() 2010-06-24 22:43:28.081 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate' 2010-06-24 22:43:28.081 VidOutVDPAU: Enabled deinterlacing. 2010-06-24 22:43:28.083 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory 2010-06-24 22:43:28.083 VSYNC: RTCVideoSync: Could not open /dev/rtc, Permission denied. 2010-06-24 22:43:28.083 VSYNC: Set video sync frame interval to 41708 2010-06-24 22:43:28.083 NVP(0): Video timing method: USleep with busy wait 2010-06-24 22:43:28.083 NVP(0): Refresh rate: 16666, frame interval: 41708 2010-06-24 22:43:28.083 playCtx: StartPlaying(): took 0 ms to start player. 2010-06-24 22:43:28.084 TV: StartPlayer(0, Unknown(5), main) -- end ok 2010-06-24 22:43:28.084 TV: Changing from None to Unknown(5) 2010-06-24 22:43:28.086 TV: HandleStateChange(0) -- end 2010-06-24 22:43:28.087 OSD: Created window OSD_INTERACTIVE 2010-06-24 22:43:28.087 NVP(0): progressive frame seen after 2 interlaced frames 2010-06-24 22:43:28.090 VDPAU: Added 2 output surfaces (total 4, max 4) 2010-06-24 22:43:28.102 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:28.125 ScreenSaverX11Private: ResetTimer -- begin 2010-06-24 22:43:28.125 ScreenSaverX11Private: StopTimer 2010-06-24 22:43:28.126 ScreenSaverX11Private: StartTimer 2010-06-24 22:43:28.126 ScreenSaverX11Private: ResetTimer -- end 2010-06-24 22:43:28.127 TV: DrawUnusedRects() -- begin 2010-06-24 22:43:28.127 TV: DrawUnusedRects() -- end 2010-06-24 22:43:28.127 TV: DrawUnusedRects() -- begin 2010-06-24 22:43:28.127 TV: DrawUnusedRects() -- end 2010-06-24 22:43:28.127 NVP(0): Video is 3.38065 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.127 VSYNC: Set video sync frame interval to 41708 2010-06-24 22:43:28.128 NVP(0): Disabled deinterlacing 2010-06-24 22:43:28.128 NVP(0): Video is 5.79625 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.128 NVP(0): Video is 7.50005 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.128 NVP(0): Video is 8.52616 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.148 NVP(0): Video is 9.04397 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.148 NVP(0): Video is 9.18658 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.148 NVP(0): Video is 9.04179 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.148 NVP(0): Video is 8.68145 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.148 NVP(0): Video is 8.15944 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.169 NVP(0): Video is 7.52218 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.169 NVP(0): Video is 6.90637 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.169 NVP(0): Video is 6.19277 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.169 NVP(0): Video is 5.41182 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.169 NVP(0): Video is 4.57435 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.169 NVP(0): Video is 3.69449 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:28.342 AFD: HandleGopStart: gopset not set, syncing positionMap 2010-06-24 22:43:28.342 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2010-06-24 22:43:28.342 AFD: HandleGopStart: Initial key frame distance: 15. 'video_output' mean = '35502.03', std. dev. = '14476.68', fps = '28.17' 'video_output' mean = '41707.03', std. dev. = '165.23', fps = '23.98' 'video_output' mean = '41707.13', std. dev. = '59.70', fps = '23.98' 2010-06-24 22:43:40.872 AFD: HandleGopStart: Key frame distance changed from 52 to 300. 2010-06-24 22:43:42.138 AFD: HandleGopStart: Key frame distance changed from 300 to 30. 2010-06-24 22:43:42.304 AFD: HandleGopStart: Key frame distance changed from 30 to 4. 2010-06-24 22:43:42.719 AFD: HandleGopStart: Key frame distance changed from 4 to 10. 2010-06-24 22:43:42.847 AFD: HandleGopStart: Key frame distance changed from 10 to 3. 2010-06-24 22:43:44.082 NVP(0): 400 progressive frames seen. 'video_output' mean = '41694.65', std. dev. = '138.91', fps = '23.98' 2010-06-24 22:43:45.460 AFD: HandleGopStart: Key frame distance changed from 3 to 63. 2010-06-24 22:43:45.710 AFD: HandleGopStart: Key frame distance changed from 63 to 6. 2010-06-24 22:43:45.835 AFD: HandleGopStart: Key frame distance changed from 6 to 3. 'video_output' mean = '41707.19', std. dev. = '363.65', fps = '23.98' 2010-06-24 22:43:50.047 TV: DoNVPSeek() -- begin 2010-06-24 22:43:50.047 AO: Pause 1 2010-06-24 22:43:50.047 TV: DoNVPSeek() -- ff 2010-06-24 22:43:50.047 TV: DoNVPSeek() -- end 2010-06-24 22:43:50.047 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:50.048 AO: Pause 0 2010-06-24 22:43:50.051 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:50.051 AFD: DoFastForward(14941 (572), do discard frames) 2010-06-24 22:43:50.051 No DTS Seeking Hack! 2010-06-24 22:43:50.051 AFD: SeekReset(470, 0, do flush, do discard) 2010-06-24 22:43:50.051 AFD: SeekReset() flushing 2010-06-24 22:43:50.051 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:50.051 VideoBuffers::DiscardFrames(1): UUUUAUUUUUUUUUUUA 2010-06-24 22:43:50.051 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:50.051 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:50.051 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:50.052 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:50.052 NVP(0): Waiting for video buffers... 2010-06-24 22:43:50.052 AO: Pause 1 2010-06-24 22:43:50.101 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:50.141 AO: Pause 0 2010-06-24 22:43:50.151 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:50.166 NVP(0): Video is 4.02016 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.166 NVP(0): Video is 5.40074 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.166 NVP(0): Video is 6.18442 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.187 NVP(0): Video is 6.52045 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.187 NVP(0): Video is 6.65258 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.187 NVP(0): Video is 6.49993 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.187 NVP(0): Video is 6.13369 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.187 NVP(0): Video is 5.60727 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.187 NVP(0): Video is 4.9667 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.207 NVP(0): Video is 4.23451 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:50.207 NVP(0): Video is 3.55349 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.007 TV: DoNVPSeek() -- begin 2010-06-24 22:43:51.007 AO: Pause 1 2010-06-24 22:43:51.007 TV: DoNVPSeek() -- ff 2010-06-24 22:43:51.007 TV: DoNVPSeek() -- end 2010-06-24 22:43:51.007 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:51.008 AFD: DoFastForward(29359 (14990), do discard frames) 2010-06-24 22:43:51.008 No DTS Seeking Hack! 2010-06-24 22:43:51.008 AFD: SeekReset(14940, 0, do flush, do discard) 2010-06-24 22:43:51.008 AFD: SeekReset() flushing 2010-06-24 22:43:51.008 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:51.008 VideoBuffers::DiscardFrames(1): UUUAUUUUUUUUUUUAU 2010-06-24 22:43:51.008 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:51.008 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:51.008 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:51.009 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:51.009 NVP(0): Waiting for video buffers... 2010-06-24 22:43:51.051 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:51.093 AO: Pause 0 2010-06-24 22:43:51.101 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:51.114 NVP(0): Video is 3.77625 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.114 NVP(0): Video is 6.36269 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.114 NVP(0): Video is 8.05076 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.114 NVP(0): Video is 9.06505 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.134 NVP(0): Video is 9.57401 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.134 NVP(0): Video is 9.82986 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.135 NVP(0): Video is 9.77002 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.135 NVP(0): Video is 9.47339 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.135 NVP(0): Video is 9.00515 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.155 NVP(0): Video is 8.40222 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.155 NVP(0): Video is 7.82416 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.155 NVP(0): Video is 7.14484 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.155 NVP(0): Video is 6.3836 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.155 NVP(0): Video is 5.56092 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.155 NVP(0): Video is 4.69217 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.175 NVP(0): Video is 3.79484 frames behind audio (too slow), dropping frame to catch up. 'video_output' mean = '30524.91', std. dev. = '20559.36', fps = '32.76' 2010-06-24 22:43:51.848 TV: DoNVPSeek() -- begin 2010-06-24 22:43:51.848 AO: Pause 1 2010-06-24 22:43:51.848 TV: DoNVPSeek() -- ff 2010-06-24 22:43:51.848 TV: DoNVPSeek() -- end 2010-06-24 22:43:51.848 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:51.849 AFD: DoFastForward(43779 (29410), do discard frames) 2010-06-24 22:43:51.849 No DTS Seeking Hack! 2010-06-24 22:43:51.849 AFD: SeekReset(29358, 0, do flush, do discard) 2010-06-24 22:43:51.849 AFD: SeekReset() flushing 2010-06-24 22:43:51.849 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:51.849 VideoBuffers::DiscardFrames(1): AUUUUUUUUAUUUUUUU 2010-06-24 22:43:51.849 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:51.849 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:51.849 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:51.850 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:51.850 NVP(0): Waiting for video buffers... 2010-06-24 22:43:51.851 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:51.908 AO: Pause 0 2010-06-24 22:43:51.913 NVP(0): Video is 3.51252 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.913 NVP(0): Video is 5.89515 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.913 NVP(0): Video is 7.43037 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.913 NVP(0): Video is 8.33003 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.934 NVP(0): Video is 8.75902 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.934 NVP(0): Video is 8.95488 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.934 NVP(0): Video is 8.85003 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.934 NVP(0): Video is 8.52563 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.934 NVP(0): Video is 8.03059 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.951 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:51.954 NVP(0): Video is 7.40757 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.954 NVP(0): Video is 6.81442 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.954 NVP(0): Video is 6.11782 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.954 NVP(0): Video is 5.3436 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.954 NVP(0): Video is 4.5112 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:51.954 NVP(0): Video is 3.64112 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.273 TV: DoNVPSeek() -- begin 2010-06-24 22:43:52.273 AO: Pause 1 2010-06-24 22:43:52.273 TV: DoNVPSeek() -- ff 2010-06-24 22:43:52.273 TV: DoNVPSeek() -- end 2010-06-24 22:43:52.273 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:52.283 AFD: DoFastForward(58189 (43820), do discard frames) 2010-06-24 22:43:52.284 No DTS Seeking Hack! 2010-06-24 22:43:52.284 AFD: SeekReset(43778, 0, do flush, do discard) 2010-06-24 22:43:52.284 AFD: SeekReset() flushing 2010-06-24 22:43:52.284 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:52.284 VideoBuffers::DiscardFrames(1): UUUAUUUUUUAUUUUUU 2010-06-24 22:43:52.284 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:52.284 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:52.284 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:52.284 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:52.285 NVP(0): Waiting for video buffers... 2010-06-24 22:43:52.301 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:52.363 AO: Pause 0 2010-06-24 22:43:52.373 AO: Pause 0 2010-06-24 22:43:52.386 NVP(0): Video is 4.46037 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.386 NVP(0): Video is 5.87475 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.386 NVP(0): Video is 6.6838 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.386 NVP(0): Video is 7.04484 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.401 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:52.406 NVP(0): Video is 7.06385 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.406 NVP(0): Video is 6.94625 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.406 NVP(0): Video is 6.61228 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.406 NVP(0): Video is 6.11005 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.406 NVP(0): Video is 5.48163 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.426 NVP(0): Video is 4.75858 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.426 NVP(0): Video is 4.09041 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.426 NVP(0): Video is 3.33754 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:52.862 TV: DoNVPSeek() -- begin 2010-06-24 22:43:52.862 AO: Pause 1 2010-06-24 22:43:52.862 TV: DoNVPSeek() -- ff 2010-06-24 22:43:52.862 TV: DoNVPSeek() -- end 2010-06-24 22:43:52.862 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:52.863 AFD: DoFastForward(72599 (58230), do discard frames) 2010-06-24 22:43:52.863 No DTS Seeking Hack! 2010-06-24 22:43:52.863 AFD: SeekReset(58188, 0, do flush, do discard) 2010-06-24 22:43:52.863 AFD: SeekReset() flushing 2010-06-24 22:43:52.863 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:52.863 VideoBuffers::DiscardFrames(1): UUUUAUUUUUUUAUUUU 2010-06-24 22:43:52.863 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:52.863 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:52.863 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:52.863 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:52.863 NVP(0): Waiting for video buffers... 2010-06-24 22:43:52.874 TV: DoNVPSeek() -- begin 2010-06-24 22:43:52.874 TV: DoNVPSeek() -- ff 2010-06-24 22:43:52.874 TV: DoNVPSeek() -- end 2010-06-24 22:43:52.874 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:52.901 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:52.946 AFD: DoFastForward(86984 (72600), do discard frames) 2010-06-24 22:43:52.946 No DTS Seeking Hack! 2010-06-24 22:43:52.946 AFD: SeekReset(72598, 0, do flush, do discard) 2010-06-24 22:43:52.946 AFD: SeekReset() flushing 2010-06-24 22:43:52.946 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:52.946 VideoBuffers::DiscardFrames(1): AAAAUAAAAAAAAAAAA 2010-06-24 22:43:52.946 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:52.946 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:52.946 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:52.947 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:52.988 NVP(0): Waited 100ms for video buffers AAAAAAAAAAAAAAAAA 2010-06-24 22:43:53.005 AO: Pause 0 2010-06-24 22:43:53.036 NVP(0): Video is 3.20082 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.037 NVP(0): Video is 5.35569 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.037 NVP(0): Video is 6.72008 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.037 NVP(0): Video is 7.4976 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.037 NVP(0): Video is 7.829 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.051 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:53.058 NVP(0): Video is 7.82581 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.058 NVP(0): Video is 7.69155 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.058 NVP(0): Video is 7.35108 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.058 NVP(0): Video is 6.84399 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.058 NVP(0): Video is 6.2119 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.078 NVP(0): Video is 5.49209 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.078 NVP(0): Video is 4.82037 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.078 NVP(0): Video is 4.06483 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.078 NVP(0): Video is 3.24643 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.478 TV: DoNVPSeek() -- begin 2010-06-24 22:43:53.478 AO: Pause 1 2010-06-24 22:43:53.478 TV: DoNVPSeek() -- ff 2010-06-24 22:43:53.478 TV: DoNVPSeek() -- end 2010-06-24 22:43:53.478 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:53.480 AO: Pause 0 2010-06-24 22:43:53.484 AFD: DoFastForward(101395 (87026), do discard frames) 2010-06-24 22:43:53.484 No DTS Seeking Hack! 2010-06-24 22:43:53.485 AFD: SeekReset(86983, 0, do flush, do discard) 2010-06-24 22:43:53.485 AFD: SeekReset() flushing 2010-06-24 22:43:53.485 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:53.485 VideoBuffers::DiscardFrames(1): UUUUUAUUUAUUUUUUU 2010-06-24 22:43:53.485 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:53.485 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:53.485 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:53.485 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:53.485 NVP(0): Waiting for video buffers... 2010-06-24 22:43:53.485 AO: Pause 1 2010-06-24 22:43:53.501 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:53.573 AO: Pause 0 2010-06-24 22:43:53.585 NVP(0): Video is 4.04683 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.585 NVP(0): Video is 5.46269 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.585 NVP(0): Video is 6.27285 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.601 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:53.605 NVP(0): Video is 6.63472 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.606 TV: DoNVPSeek() -- begin 2010-06-24 22:43:53.606 AO: Pause 1 2010-06-24 22:43:53.606 TV: DoNVPSeek() -- ff 2010-06-24 22:43:53.606 TV: DoNVPSeek() -- end 2010-06-24 22:43:53.606 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:53.606 AFD: DoFastForward(115781 (101411), do discard frames) 2010-06-24 22:43:53.607 No DTS Seeking Hack! 2010-06-24 22:43:53.607 AFD: SeekReset(101394, 0, do flush, do discard) 2010-06-24 22:43:53.607 AFD: SeekReset() flushing 2010-06-24 22:43:53.607 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:53.607 VideoBuffers::DiscardFrames(1): UUAAUAUUUAAUUAUAU 2010-06-24 22:43:53.607 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:53.607 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:53.607 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:53.608 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:53.608 NVP(0): Waiting for video buffers... 2010-06-24 22:43:53.651 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:53.659 AO: Pause 0 2010-06-24 22:43:53.660 AO: Pause 0 2010-06-24 22:43:53.660 NVP(0): Video is 6.77424 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.660 NVP(0): Video is 7.86192 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.660 NVP(0): Waiting for video buffers... 2010-06-24 22:43:53.660 AO: Pause 1 2010-06-24 22:43:53.666 AO: Pause 0 2010-06-24 22:43:53.666 NVP(0): Video is 8.42591 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.686 NVP(0): Video is 8.62715 frames behind audio (too slow), dropping frame to catch up. 'video_output' mean = '22965.90', std. dev. = '25572.48', fps = '43.54' 2010-06-24 22:43:53.686 NVP(0): Video is 8.64618 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.686 NVP(0): Video is 8.41472 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.686 NVP(0): Video is 7.98935 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.686 NVP(0): Video is 7.4186 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.701 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:53.706 NVP(0): Video is 6.74477 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.706 NVP(0): Video is 6.10753 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.706 NVP(0): Video is 5.37784 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.706 NVP(0): Video is 4.57883 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.706 NVP(0): Video is 3.73382 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:53.706 NVP(0): Waiting for video buffers... 2010-06-24 22:43:53.707 AO: Pause 1 2010-06-24 22:43:53.732 AO: Pause 0 2010-06-24 22:43:53.751 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:54.238 TV: DoNVPSeek() -- begin 2010-06-24 22:43:54.238 AO: Pause 1 2010-06-24 22:43:54.238 TV: DoNVPSeek() -- ff 2010-06-24 22:43:54.238 TV: DoNVPSeek() -- end 2010-06-24 22:43:54.238 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:54.239 AFD: DoFastForward(130192 (115823), do discard frames) 2010-06-24 22:43:54.239 No DTS Seeking Hack! 2010-06-24 22:43:54.239 AFD: SeekReset(115780, 0, do flush, do discard) 2010-06-24 22:43:54.239 AFD: SeekReset() flushing 2010-06-24 22:43:54.239 VidOutVDPAU: DiscardFrames(1) 2010-06-24 22:43:54.239 VideoBuffers::DiscardFrames(1): UUUUUUUUUUAUUUAUU 2010-06-24 22:43:54.239 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:54.239 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAA -- done 2010-06-24 22:43:54.239 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAAAA -- done() 2010-06-24 22:43:54.240 NVP(0): ClearAfterSeek(0) 2010-06-24 22:43:54.240 NVP(0): Waiting for video buffers... 2010-06-24 22:43:54.251 AO: OutputAudioLoop: audio paused 2010-06-24 22:43:54.340 AO: Pause 0 2010-06-24 22:43:54.351 AO: OutputAudioLoop: Play Event 2010-06-24 22:43:54.352 NVP(0): Video is 3.48255 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.352 NVP(0): Video is 5.84869 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.352 NVP(0): Video is 7.37154 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.372 NVP(0): Video is 8.26194 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.372 NVP(0): Video is 8.79786 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.372 NVP(0): Video is 8.95404 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.372 NVP(0): Video is 8.81944 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.372 NVP(0): Video is 8.46672 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.392 NVP(0): Video is 7.95644 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.392 NVP(0): Video is 7.44785 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.393 NVP(0): Video is 6.81466 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.393 NVP(0): Video is 6.08802 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.393 NVP(0): Video is 5.29728 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.393 NVP(0): Video is 4.45248 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.413 NVP(0): Video is 3.56713 frames behind audio (too slow), dropping frame to catch up. 2010-06-24 22:43:54.709 TV: DoNVPSeek() -- begin 2010-06-24 22:43:54.709 AO: Pause 1 2010-06-24 22:43:54.709 TV: DoNVPSeek() -- ff 2010-06-24 22:43:54.709 TV: DoNVPSeek() -- end 2010-06-24 22:43:54.709 UpdateOSDSeekMessage(Jump Ahead, 1) 2010-06-24 22:43:54.710 AFD: DoFastForward(135633 (130233), do discard frames) 2010-06-24 22:43:54.751 AO: OutputAudioLoop: audio paused 2010-06-24 22:44:30.820 AFD Error: av_seek_frame(ic, -1, 5657026221, 0) -- error 2010-06-24 22:44:30.821 NVP(0): ClearAfterSeek(0)