rendered paste bodydanielk@cherry:~$ mythfrontend -v playback
2010-03-05 12:50:32.060 mythfrontend version: trunk [23667M] www.mythtv.org
2010-03-05 12:50:32.061 Using runtime prefix = /usr/local
2010-03-05 12:50:32.061 Using configuration directory = /home/danielk/.mythtv
2010-03-05 12:50:32.916 Empty LocalHostName.
2010-03-05 12:50:32.916 Using localhost value of cherry.kristjansson.com
2010-03-05 12:50:32.932 New DB connection, total: 1
2010-03-05 12:50:32.944 Connected to database 'mythconverg' at host: localhost
2010-03-05 12:50:32.946 Closing DB connection named 'DBManager0'
2010-03-05 12:50:33.001 ScreenSaverX11Private: Gnome screen saver support enabled
2010-03-05 12:50:33.003 DPMS is disabled.
2010-03-05 12:50:33.007 Primary screen: 0.
2010-03-05 12:50:33.008 Connected to database 'mythconverg' at host: localhost
2010-03-05 12:50:33.011 Running in a window
2010-03-05 12:50:33.012 Using screen 0, 1280x1024 at 0,0
2010-03-05 12:50:33.055 Desktop video mode: 3200x1200 60.0204 Hz
2010-03-05 12:50:33.082 max_width: 3200 max_height: 1200
2010-03-05 12:50:33.085 MythUI Image Cache size set to 20971520 bytes
2010-03-05 12:50:33.120 user: 502 effective user: 502 before privileged thread
2010-03-05 12:50:33.120 user: 502 effective user: 502 run_priv_thread
2010-03-05 12:50:33.121 user: 502 effective user: 502 after privileged thread
2010-03-05 12:50:33.122 Enabled verbose msgs: important general playback
2010-03-05 12:50:33.132 Primary screen: 0.
2010-03-05 12:50:33.134 Running in a window
2010-03-05 12:50:33.134 Using screen 0, 1280x1024 at 0,0
2010-03-05 12:50:33.136 Using theme base resolution of 1280x720
2010-03-05 12:50:33.147 LIRC, Error: Failed to read config file '/home/danielk/.lircrc'
2010-03-05 12:50:33.147 JoystickMenuThread Error: Joystick disabled - Failed to read /home/danielk/.mythtv/joystickmenurc
2010-03-05 12:50:33.434 Using the OpenGL painter
2010-03-05 12:50:34.051 XMLParseBase: Loaded base theme from '/usr/local/share/mythtv/themes/MythCenter-wide/base.xml'
2010-03-05 12:50:34.067 XMLParseBase: Loaded base theme from '/usr/local/share/mythtv/themes/default-wide/base.xml'
2010-03-05 12:50:34.087 XMLParseBase: Loaded base theme from '/usr/local/share/mythtv/themes/default/base.xml'
2010-03-05 12:50:34.093 Current MythTV Schema Version (DBSchemaVer): 1254
2010-03-05 12:50:34.095 VDP: decoder<->render support: ffmpeg null directfb xlib xshm xv-blit opengl
2010-03-05 12:50:34.095 VDP: decoder<->render support: libmpeg2 null directfb xlib xshm xv-blit opengl
2010-03-05 12:50:34.095 VDP: decoder<->render support: xvmc xvmc-blit
2010-03-05 12:50:34.096 VDP: decoder<->render support: xvmc-vld xvmc-blit
2010-03-05 12:50:34.101 VDP: Ignoring profile item 4 (OSD Renderer opengl is not supported w/renderer xvmc-blit (supported: chromakey,ia44blend))
2010-03-05 12:50:34.104 VDP: Ignoring profile item 2 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:34.106 VDP: Ignoring profile item 8 (decoder ivtv is not supported (supported: ffmpeg,libmpeg2,xvmc,xvmc-vld))
2010-03-05 12:50:34.108 VDP: Ignoring profile item 15 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:34.109 VDP: Ignoring profile item 16 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:34.111 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:34.111 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:34.115 VDP: Ignoring profile item 23 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:34.115 VDP: Ignoring profile item 24 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:34.117 VDP: Ignoring profile item 25 (decoder vdpau is not supported (supported: ffmpeg,libmpeg2,xvmc,xvmc-vld))
2010-03-05 12:50:34.118 VDP: Ignoring profile item 75 (decoder vdpau is not supported (supported: ffmpeg,libmpeg2,xvmc,xvmc-vld))
2010-03-05 12:50:34.120 VDP: Ignoring profile item 76 (decoder vdpau is not supported (supported: ffmpeg,libmpeg2,xvmc,xvmc-vld))
2010-03-05 12:50:34.120 VDP: Ignoring profile item 77 (decoder vdpau is not supported (supported: ffmpeg,libmpeg2,xvmc,xvmc-vld))
2010-03-05 12:50:34.121 VDP: Ignoring profile item 78 (decoder vdpau is not supported (supported: ffmpeg,libmpeg2,xvmc,xvmc-vld))
2010-03-05 12:50:34.759 Registering Internal as a media playback plugin.
2010-03-05 12:50:34.761 No libraries in plugins directory /usr/local/lib/mythtv/plugins
2010-03-05 12:50:34.797 MMUnix::AddDevice() Error: failed to stat /dev/bdi,
eno: No such file or directory (2)
2010-03-05 12:50:34.803 MMUnix::AddDevice() Error: failed to stat /dev/power,
eno: No such file or directory (2)
2010-03-05 12:50:34.818 NetworkControl: Listening for remote connections on port 6546
2010-03-05 12:50:34.821 XMLParseBase: Loading window theme from /usr/local/share/mythtv/themes/MythCenter-wide/menu-ui.xml
2010-03-05 12:50:35.043 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//mainmenu.xml
2010-03-05 12:50:35.047 Found mainmenu.xml for theme 'MythCenter-wide'
2010-03-05 12:50:35.067 Using NV NPOT texture extension
2010-03-05 12:50:35.164 MythContext: Connecting to backend server: 192.168.1.141:6543 (try 1 of 5)
2010-03-05 12:50:35.181 Using protocol version 56
2010-03-05 12:50:35.207 SendReceiveStringList(QUERY_TIME_ZONE) called from UI thread
2010-03-05 12:50:38.698 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//library.xml
2010-03-05 12:50:39.618 New DB connection, total: 2
2010-03-05 12:50:39.619 Connected to database 'mythconverg' at host: localhost
2010-03-05 12:50:39.622 XMLParseBase: Loading window theme from /usr/local/share/mythtv/themes/MythCenter-wide/recordings-ui.xml
2010-03-05 12:50:48.855 TV: StartTV() -- begin
2010-03-05 12:50:48.855 TV: ctor -- begin
2010-03-05 12:50:48.873 TV: ctor -- end
2010-03-05 12:50:48.873 TV: Init -- begin
2010-03-05 12:50:48.874 TV: Init -- end channel groups
2010-03-05 12:50:48.898 TV: DrawUnusedRects() -- begin
2010-03-05 12:50:48.898 TV: DrawUnusedRects() -- end
2010-03-05 12:50:48.899 TV: Init -- end
2010-03-05 12:50:48.899 SendReceiveStringList(MESSAGE,SYSTEM_EVENT PLAY_STARTED HOSTNAME cherry.kristjansson.com CHANID 2071 STARTTIME 2010-03-05T12:20:00 SENDER cherry.kristjansson.com) called from UI thread
2010-03-05 12:50:48.900 TV: tv->Playback() -- begin
2010-03-05 12:50:48.906 TV: tv->Playback() -- end
2010-03-05 12:50:48.907 TV: StartTV -- process events begin
2010-03-05 12:50:48.931 TV: HandleStateChange(0) -- begin
2010-03-05 12:50:48.932 TV: Attempting to change from None to Watching WatchingPreRecorded
2010-03-05 12:50:48.936 RingBuf(/video/2071_20100305122000.mpg): OpenFile(/video/2071_20100305122000.mpg, 12)
2010-03-05 12:50:48.971 RingBuf(/video/2071_20100305122000.mpg): CalcReadAheadThresh(0 KB)
-> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2010-03-05 12:50:49.031 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- begin
2010-03-05 12:50:49.031 TV: Elapsed time since TV constructor was called: 176 ms
2010-03-05 12:50:49.091 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.091 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.091 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.091 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.092 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.092 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.092 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.092 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.092 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.093 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.093 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.094 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.094 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.095 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.095 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.096 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.096 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.097 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.098 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.099 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.100 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.100 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.101 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.101 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.102 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.102 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.103 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.103 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.106 [mpeg2video @ 0x7fbffb4963a0]mpeg_decode_postinit() failure
2010-03-05 12:50:49.137 AFD: HandleStreamChange(): streams_changed 0x45df500 -- stream count 2
2010-03-05 12:50:49.137 AFD: SeekReset(0, 0, do flush, do discard)
2010-03-05 12:50:49.138 AFD: SeekReset() flushing
2010-03-05 12:50:49.138 AFD: Stream #0, has id 0x31 codec id MPEG2VIDEO, type Video, bitrate 0 at 0x45e2370
2010-03-05 12:50:49.141 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:49.141 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:49.141 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:49.142 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:49.142 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:49.142 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:49.142 VDP: LoadBestPreferences(16x16, 60)
2010-03-05 12:50:49.145 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:49.145 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:49.145 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:49.145 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:49.145 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:49.145 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:49.145 VDP: LoadBestPreferences(16x16, 60)
2010-03-05 12:50:49.145 Using 1 CPUs for decoding
2010-03-05 12:50:49.146 AFD: InitVideoCodec() 0x45e2590 id(MPEG2VIDEO) type (Video).
2010-03-05 12:50:49.146 AFD: InitVideoCodec invalid dimensions, resetting decoder.
2010-03-05 12:50:49.146 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
2010-03-05 12:50:49.146 AFD: EIA-708 caption service #1 is in the English language.
2010-03-05 12:50:49.147 AFD: Using ffmpeg for video decoding
2010-03-05 12:50:49.147 AFD: Looking for decoder for MPEG2VIDEO
2010-03-05 12:50:49.147 AFD: Opened codec 0x45e2590, id(MPEG2VIDEO) type(Video)
2010-03-05 12:50:49.147 AFD: Stream #1, has id 0x34 codec id AC3, type Audio, bitrate 0 at 0x45e2b50
2010-03-05 12:50:49.147 AFD: codec AC3 has 0 channels
2010-03-05 12:50:49.147 AFD: Looking for decoder for AC3
2010-03-05 12:50:49.148 AFD: Opened codec 0x45e2d70, id(AC3) type(Audio)
2010-03-05 12:50:50.199 RingBuf(/video/2071_20100305122000.mpg): Waited 1.0 seconds for data to become available...
2010-03-05 12:50:51.199 RingBuf(/video/2071_20100305122000.mpg): Waited 2.0 seconds for data to become available...
2010-03-05 12:50:51.541 AFD: Stream #0, has id 0x31 codec id MPEG2VIDEO, type Video, bitrate 0 at 0x45e2370
2010-03-05 12:50:51.545 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.545 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.545 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.546 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.546 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.546 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.546 VDP: LoadBestPreferences(16x16, 60)
2010-03-05 12:50:51.549 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.550 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.550 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.550 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.550 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.550 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.551 VDP: LoadBestPreferences(16x16, 60)
2010-03-05 12:50:51.551 Using 1 CPUs for decoding
2010-03-05 12:50:51.551 AFD: Warning, video codec 0x45e2590 id(MPEG2VIDEO) type (Video) already open.
2010-03-05 12:50:51.551 AFD: InitVideoCodec() 0x45e2590 id(MPEG2VIDEO) type (Video).
2010-03-05 12:50:51.551 AFD: InitVideoCodec invalid dimensions, resetting decoder.
2010-03-05 12:50:51.551 AFD: EIA-708 caption service #1 is in the English language.
2010-03-05 12:50:51.551 AFD: Using ffmpeg for video decoding
2010-03-05 12:50:51.551 AFD: Looking for decoder for MPEG2VIDEO
2010-03-05 12:50:51.552 AFD: Stream #1, has id 0x34 codec id AC3, type Audio, bitrate 0 at 0x45e2b50
2010-03-05 12:50:51.552 AFD: Warning, audio codec 0x45e2d70 id(AC3) type (Audio) already open, leaving it alone.
2010-03-05 12:50:51.552 AFD: codec AC3 has 0 channels
2010-03-05 12:50:51.552 AFD: Looking for decoder for AC3
2010-03-05 12:50:51.552 NVP(0): Disabling Audio, params(0,0,0)
2010-03-05 12:50:51.552 Dec: Trying to select track (w/lang)
2010-03-05 12:50:51.552 Dec: Selecting first track
2010-03-05 12:50:51.552 Dec: Selected track #1 in the Unknown language(0)
2010-03-05 12:50:51.553 Dec: Selected track #1 in the English language(6647399)
2010-03-05 12:50:51.553 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2010-03-05 12:50:51.562 Position map filled from DB to: 15990
2010-03-05 12:50:51.562 Dec: SyncPositionMap prerecorded, from DB: 534 entries
2010-03-05 12:50:51.562 Dec: SyncPositionMap, new totframes: 15990, new length: 533, posMap size: 534
2010-03-05 12:50:51.563 AFD: Position map found
2010-03-05 12:50:51.563 AFD: Successfully opened decoder for file: "/video/2071_20100305122000.mpg". novideo(0)
2010-03-05 12:50:51.569 VideoOutput: Allowed renderers: directfb,xv-blit,xshm,xlib,opengl
2010-03-05 12:50:51.569 VideoOutput: Allowed renderers (filt: ffmpeg): directfb,xlib,xshm,xv-blit,opengl
2010-03-05 12:50:51.572 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.572 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.572 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.572 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.572 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.572 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.573 VDP: LoadBestPreferences(640x480, 60)
2010-03-05 12:50:51.573 VideoOutput: Preferred renderer: xv-blit
2010-03-05 12:50:51.573 VideoOutput: Trying video renderer: 'xv-blit'
2010-03-05 12:50:51.585 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.585 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.585 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.585 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.586 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.586 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.639 VideoOutputXv: ctor
2010-03-05 12:50:51.639 VideoOutWindow::SetPIPState. pip_state: 0]
2010-03-05 12:50:51.643 VideoOutputXv: Creating gc
2010-03-05 12:50:51.644 VideoOutputXv: XJ_screen_num: '0'
2010-03-05 12:50:51.644 VideoOutputXv: XJ_curwin: '31457286'
2010-03-05 12:50:51.644 VideoOutputXv: XJ_win: '31457286'
2010-03-05 12:50:51.644 VideoOutputXv: XJ_root: '316'
2010-03-05 12:50:51.644 VideoOutputXv: XJ_gc: '0x45fd8b0'
2010-03-05 12:50:51.645 Snapping height to avoid scaling: height: 480, top: 0
2010-03-05 12:50:51.645 Display Rect left: 0, top: 0, width: 864, height: 480, aspect: 1.33333
2010-03-05 12:50:51.645 Video Rect left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
2010-03-05 12:50:51.645 VDP: LoadBestPreferences(640x480, 60)
2010-03-05 12:50:51.645 Snapping height to avoid scaling: height: 480, top: 0
2010-03-05 12:50:51.645 Display Rect left: 0, top: 0, width: 864, height: 480, aspect: 1.33333
2010-03-05 12:50:51.645 Video Rect left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
2010-03-05 12:50:51.646 VideoOutput: Pixel dimensions: Screen 1280x1024, window 864x480
2010-03-05 12:50:51.647 VideoOutput: Xinerama display dimensions: 472x354 mm Aspect: 1.33333
2010-03-05 12:50:51.647 VideoOutput: Estimated window dimensions: 318x165 mm Aspect: 1.92727
2010-03-05 12:50:51.647 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib
2010-03-05 12:50:51.652 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.653 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.653 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.653 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.653 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.653 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.653 VDP: LoadBestPreferences(640x480, 60)
2010-03-05 12:50:51.658 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask 10
2010-03-05 12:50:51.658 VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask
2010-03-05 12:50:51.658 VideoOutputXv: Has XVideo flags...
2010-03-05 12:50:51.659 VideoOutputXv: Has XV_BRIGHTNESS...
2010-03-05 12:50:51.659 VideoOutputXv: Here...
2010-03-05 12:50:51.659 VideoOutputXv: Grabbed xv port 280
2010-03-05 12:50:51.659 VideoOutputXv: XVideo surface found on port 280
2010-03-05 12:50:51.659 VideoOutputXv: XV_SET_DEFAULTS is supported on this port
2010-03-05 12:50:51.659 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2010-03-05 12:50:51.660 VideoOutputXv: XVideo Format #0 is 'YUY2'
2010-03-05 12:50:51.660 VideoOutputXv: XVideo Format #1 is 'YV12'
2010-03-05 12:50:51.660 VideoOutputXv: XVideo Format #2 is 'UYVY'
2010-03-05 12:50:51.660 VideoOutputXv: XVideo Format #3 is 'I420'
2010-03-05 12:50:51.660 VideoOutputXv: Using XVideo Format 'YV12'
2010-03-05 12:50:51.660 VideoOutputXv: CreateShmImages(32): video_dim: 640x480
2010-03-05 12:50:51.709 VDP: SetVideoRenderer(xv-blit)
2010-03-05 12:50:51.710 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2010-03-05 12:50:51.711 VideoOutputXv: Chromakeying not possible with this XVideo port.
2010-03-05 12:50:51.711 Snapping height to avoid scaling: height: 480, top: 0
2010-03-05 12:50:51.712 Display Rect left: 133, top: 0, width: 598, height: 480, aspect: 1.92727
2010-03-05 12:50:51.712 Video Rect left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
2010-03-05 12:50:51.715 Over/underscan. V: 0, H: 0
2010-03-05 12:50:51.715 Snapping height to avoid scaling: height: 480, top: 0
2010-03-05 12:50:51.715 Display Rect left: 133, top: 0, width: 598, height: 480, aspect: 1.92727
2010-03-05 12:50:51.716 Video Rect left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
2010-03-05 12:50:51.716 VDP: LoadBestPreferences(640x480, 29.97)
2010-03-05 12:50:51.717 NVP(0): LoadFilters(''..) -> 0x0
2010-03-05 12:50:51.719 OSD Theme Dimensions W: 640 H: 480
2010-03-05 12:50:51.803 NVP(0): ClearAfterSeek(1)
2010-03-05 12:50:51.803 VideoOutputXv: ClearAfterSeek()
2010-03-05 12:50:51.803 VideoOutputXv: DiscardFrames(0)
2010-03-05 12:50:51.803 playCtx: StartDecoderThread(): took 236 ms to start player.
2010-03-05 12:50:51.804 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:51.804 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- end ok
2010-03-05 12:50:51.804 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:51.804 SendReceiveStringList(MESSAGE,COMMFLAG_REQUEST 2071 2010-03-05T12:20:00) called from UI thread
2010-03-05 12:50:51.804 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.805 TV: Changing from None to Watching WatchingPreRecorded
2010-03-05 12:50:51.808 Realtime priority would require SUID as root.
2010-03-05 12:50:51.809 TV: HandleStateChange(0) -- end
2010-03-05 12:50:51.810 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdoubleprocessdeint'
2010-03-05 12:50:51.813 FilterManager: GetFilterInfo(convert) returning: 0x0
2010-03-05 12:50:51.813 FilterManager: GetFilterInfo(greedyhdoubleprocessdeint) returning: 0x46fb930
greedyhdeint: size changed from 0 x 0 -> 640 x 480
2010-03-05 12:50:51.815 Using deinterlace method greedyhdoubleprocessdeint
2010-03-05 12:50:51.815 AFD: HandleStreamChange(): streams_changed 0x45df500 -- stream count 3
2010-03-05 12:50:51.820 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2010-03-05 12:50:51.820 OpenGLVideoSync()
2010-03-05 12:50:51.816 AFD: SeekReset(0, 0, do flush, do discard)
2010-03-05 12:50:51.821 AFD: SeekReset() flushing
2010-03-05 12:50:51.821 VideoOutputXv: DiscardFrames(1)
2010-03-05 12:50:51.821 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:51.821 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.822 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:51.822 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.822 AFD: Stream #0, has id 0x31 codec id MPEG2VIDEO, type Video, bitrate 0 at 0x7fbfd8324cf0
2010-03-05 12:50:51.826 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.826 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.826 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.826 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.826 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.826 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.826 VDP: LoadBestPreferences(16x16, 60)
2010-03-05 12:50:51.829 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.829 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.829 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.830 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.830 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.830 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.830 VDP: LoadBestPreferences(16x16, 60)
2010-03-05 12:50:51.830 Using 1 CPUs for decoding
2010-03-05 12:50:51.830 AFD: InitVideoCodec() 0x7fbfd8324f10 id(MPEG2VIDEO) type (Video).
2010-03-05 12:50:51.830 AFD: InitVideoCodec invalid dimensions, resetting decoder.
2010-03-05 12:50:51.830 AFD: EIA-708 caption service #1 is in the English language.
2010-03-05 12:50:51.830 AFD: Using ffmpeg for video decoding
2010-03-05 12:50:51.830 AFD: Looking for decoder for MPEG2VIDEO
2010-03-05 12:50:51.831 AFD: Opened codec 0x7fbfd8324f10, id(MPEG2VIDEO) type(Video)
2010-03-05 12:50:51.831 AFD: Stream #1, has id 0x34 codec id AC3, type Audio, bitrate 0 at 0x7fbfd83254d0
2010-03-05 12:50:51.831 AFD: codec AC3 has 0 channels
2010-03-05 12:50:51.831 AFD: Looking for decoder for AC3
2010-03-05 12:50:51.832 AFD: Opened codec 0x7fbfd8323c10, id(AC3) type(Audio)
2010-03-05 12:50:51.832 AFD: Stream #2, has id 0x35 codec id AC3, type Audio, bitrate 0 at 0x7fbfd8324050
2010-03-05 12:50:51.832 AFD: codec AC3 has 0 channels
2010-03-05 12:50:51.832 AFD: Looking for decoder for AC3
2010-03-05 12:50:51.837 AFD: Opened codec 0x7fbfd8324270, id(AC3) type(Audio)
2010-03-05 12:50:51.839 Forcing GLX version to 1.2 (orig 1.3)
2010-03-05 12:50:51.841 ScreenSaverX11Private: ResetTimer -- begin
2010-03-05 12:50:51.841 ScreenSaverX11Private: StopTimer
2010-03-05 12:50:51.842 ScreenSaverX11Private: StartTimer
2010-03-05 12:50:51.842 ScreenSaverX11Private: ResetTimer -- end
2010-03-05 12:50:51.852 No codec context. Returning false
2010-03-05 12:50:51.881 Opening audio device 'default'. ch 2(2) sr 48000 (reenc 0)
2010-03-05 12:50:51.882 Opening ALSA audio device 'default'.
2010-03-05 12:50:51.894 GLCtx: Created OpenGL window.
2010-03-05 12:50:51.894 GLCtx: Created GLX context.
2010-03-05 12:50:51.894 GLCtx: GLX Version: 1.2
2010-03-05 12:50:51.894 GLCtx: Direct rendering: Yes
2010-03-05 12:50:51.914 NVP(0): Enabling Audio
2010-03-05 12:50:51.919 VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.919 VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,directfb,xlib,xshm,xv-blit,opengl))
2010-03-05 12:50:51.919 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2010-03-05 12:50:51.920 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,kerneldeint) filt()
2010-03-05 12:50:51.920 VDP: LoadBestPreferences(2048x2048, 0)
2010-03-05 12:50:51.920 VDP: LoadBestPreferences(2048x2048, 60)
2010-03-05 12:50:51.920 VDP: LoadBestPreferences(1280x720, 60)
2010-03-05 12:50:51.920 VideoOutputXv: InputChanged(1280,720,1.77778) 'MPEG2'->'MPEG2'
2010-03-05 12:50:51.920 VDP: LoadBestPreferences(1280x720, 29.97)
2010-03-05 12:50:51.920 VDP: GetFilteredDeint() : xv-blit -> 'linearblend'
2010-03-05 12:50:51.925 FilterManager: GetFilterInfo(convert) returning: 0x0
2010-03-05 12:50:51.925 FilterManager: GetFilterInfo(linearblend) returning: 0x7fbfd8971900
2010-03-05 12:50:51.926 Using deinterlace method linearblend
2010-03-05 12:50:51.926 VideoOutputXv: DiscardFrames(1)
2010-03-05 12:50:51.926 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:51.926 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.927 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:51.927 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.927 VideoOutputXv: DiscardFrames(1)
2010-03-05 12:50:51.927 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:51.928 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.928 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:51.928 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.928 VideoOutputXv: DiscardFrames(1)
2010-03-05 12:50:51.928 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:51.928 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.928 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:51.928 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:51.931 VideoOutputXv: CreateShmImages(32): video_dim: 1280x720
2010-03-05 12:50:52.014 GLCtx: OpenGL vendor : NVIDIA Corporation
2010-03-05 12:50:52.015 GLCtx: OpenGL renderer: GeForce 8300 GS/PCI/SSE2
2010-03-05 12:50:52.015 GLCtx: OpenGL version : 3.0.0 NVIDIA 180.44
2010-03-05 12:50:52.015 GLCtx: Max texture size: 8192 x 8192
2010-03-05 12:50:52.016 GLCtx: Max texture units: 4
2010-03-05 12:50:52.017 Set video sync frame interval to 16683
2010-03-05 12:50:52.017 Video sync method can't support double framerate (refresh rate too low for bob deint)
2010-03-05 12:50:52.017 Set video sync frame interval to 16683
2010-03-05 12:50:52.018 VDP: GetFilteredDeint(linearblend) : xv-blit -> 'linearblend'
2010-03-05 12:50:52.020 FilterManager: GetFilterInfo(convert) returning: 0x0
2010-03-05 12:50:52.021 FilterManager: GetFilterInfo(linearblend) returning: 0x46fa7d0
2010-03-05 12:50:52.021 Using deinterlace method linearblend
2010-03-05 12:50:52.023 Using audio as timebase
2010-03-05 12:50:52.024 Video timing method: SGI OpenGL
2010-03-05 12:50:52.024 Refresh rate: 16661, frame interval: 16683
2010-03-05 12:50:52.059 NVP(0): Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:52.130 VideoOutputXv: Chromakeying not possible with this XVideo port.
2010-03-05 12:50:52.130 Display Rect left: 33, top: 0, width: 797, height: 480, aspect: 1.92727
2010-03-05 12:50:52.130 Video Rect left: 0, top: 0, width: 1280, height: 720, aspect: 1.77778
2010-03-05 12:50:52.130 VDP: LoadBestPreferences(1280x720, 59.9401)
2010-03-05 12:50:52.173 NVP(0): Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:52.198 NVP(0): ClearAfterSeek(1)
2010-03-05 12:50:52.199 VideoOutputXv: ClearAfterSeek()
2010-03-05 12:50:52.199 VideoOutputXv: DiscardFrames(0)
2010-03-05 12:50:52.199 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:52.199 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:52.199 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:52.199 NVP(0): LoadFilters(''..) -> 0x0
2010-03-05 12:50:52.199 detectInterlace(Detect Scan, Interlaced Scan, 59.9401, 720) ->Progressive Scan
2010-03-05 12:50:52.200 Set video sync frame interval to 16683
2010-03-05 12:50:52.200 Disabled deinterlacing
2010-03-05 12:50:52.200 AFD: avFPS(119.88) != seqFPS(59.9401)
2010-03-05 12:50:52.227 Dec: Trying to reselect track
2010-03-05 12:50:52.228 Dec: Selected track #1 in the Unknown language(0)
2010-03-05 12:50:52.228 Dec: Selected track #1 in the English language(6647399)
CC length(31) seq_num(2) 0x90 0x5 0x3 0x0
2010-03-05 12:50:52.479 NVP(0): Video is 5.57454 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.523 NVP(0): Video is 9.56063 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.548 NVP(0): Video is 12.1606 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.575 NVP(0): Video is 13.9906 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.630 NVP(0): Video is 15.1983 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.670 NVP(0): Video is 15.5347 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.717 NVP(0): Video is 15.4273 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.725 NVP(0): Video is 14.8971 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.769 NVP(0): Video is 14.6344 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.817 NVP(0): Video is 14.0178 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.836 NVP(0): Video is 13.0908 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.892 NVP(0): Video is 12.3656 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.907 NVP(0): Video is 11.2372 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.937 NVP(0): Video is 10.421 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:52.992 NVP(0): Video is 9.61392 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:53.030 NVP(0): Video is 8.43919 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:53.072 NVP(0): Video is 7.21351 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:53.122 NVP(0): Video is 5.9346 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:53.135 NVP(0): Video is 4.46592 frames ahead of audio,
doubling video frame interval to slow down.
2010-03-05 12:50:53.189 NVP(0): Video is 3.40934 frames ahead of audio,
doubling video frame interval to slow down.
'video_output' mean = '20407.94', std. dev. = '11559.02', fps = '49.00'
'video_output' mean = '16848.24', std. dev. = '4138.63', fps = '59.35'
2010-03-05 12:50:56.429 NVP(0): Video is 3.00096 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.442 NVP(0): Video is 3.0449 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.449 NVP(0): Video is 3.03291 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.497 NVP(0): Video is 3.03968 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.512 NVP(0): Video is 3.10394 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.521 NVP(0): Video is 3.15213 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.527 NVP(0): Video is 3.03842 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.642 NVP(0): Video is 3.00036 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.696 NVP(0): Video is 3.2424 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.711 NVP(0): Video is 3.49571 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.731 NVP(0): Video is 3.64077 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.746 NVP(0): Video is 3.80951 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.747 NVP(0): Video is 3.89109 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.748 NVP(0): Video is 3.71252 frames behind audio (too slow), dropping frame to catch up.
2010-03-05 12:50:56.749 NVP(0): Video is 3.35383 frames behind audio (too slow), dropping frame to catch up.
'video_output' mean = '16462.56', std. dev. = '7268.21', fps = '60.74'
2010-03-05 12:50:57.965 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2010-03-05 12:50:57.965 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2010-03-05 12:50:58.005 TV: HandleStateChange(0) -- begin
2010-03-05 12:50:58.006 TV: Attempting to change from Watching WatchingPreRecorded to None
2010-03-05 12:50:58.006 TV: StopStuff() for player ctx 0 -- begin
2010-03-05 12:50:58.006 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2010-03-05 12:50:58.006 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2010-03-05 12:50:58.006 TV: StopStuff(): stopping ring buffer
2010-03-05 12:50:58.019 NVP(0): Exited decoder loop.
2010-03-05 12:50:58.040 TV: StopStuff(): stopping player
2010-03-05 12:50:58.040 TV: StopStuff() -- end
2010-03-05 12:50:58.040 TV: Changing from Watching WatchingPreRecorded to None
2010-03-05 12:50:58.041 TV: HandleStateChange(0) -- end
2010-03-05 12:50:58.041 TV: StartTV -- process events end
2010-03-05 12:50:58.041 TV: StartTV -- process events 2 begin
2010-03-05 12:50:58.045 ScreenSaverX11Private: StopTimer
2010-03-05 12:50:58.045 TV: StartTV -- process events 2 end
2010-03-05 12:50:58.046 TV::~TV() -- begin
2010-03-05 12:50:58.050 ~OpenGLVideoSync() -- closing opengl vsync
2010-03-05 12:50:58.050 GLCtx: Deleting OpenGL Resources
2010-03-05 12:50:58.056 GLCtx: Unmapping gl window
2010-03-05 12:50:58.057 GLCtx: Destroying gl window
2010-03-05 12:50:58.057 GLCtx: Destroying glx context
2010-03-05 12:50:58.062 GLCtx: Closing display
2010-03-05 12:50:58.063 VideoOutputXv: dtor
2010-03-05 12:50:58.063 VideoOutputXv: DiscardFrames(1)
2010-03-05 12:50:58.063 VideoBuffers::DiscardFrames(1): UUUUUUUuUULuAUUUUUUUUUUUUUUUUUU
2010-03-05 12:50:58.063 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:58.064 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:58.064 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:58.064 VideoOutputXv: DiscardFrames(1)
2010-03-05 12:50:58.064 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2010-03-05 12:50:58.064 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:58.064 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2010-03-05 12:50:58.064 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2010-03-05 12:50:58.068 VideoOutputXv: Closing XVideo port 280
2010-03-05 12:50:58.107 TV::~TV() -- lock
2010-03-05 12:50:58.118 TV::~TV() -- end
2010-03-05 12:50:58.119 SendReceiveStringList(MESSAGE,SYSTEM_EVENT PLAY_STOPPED HOSTNAME cherry.kristjansson.com CHANID 2071 STARTTIME 2010-03-05T12:20:00 SENDER cherry.kristjansson.com) called from UI thread
2010-03-05 12:50:58.120 TV: StartTV -- end