2009-02-14 13:11:36.470 mythfrontend version: trunk [19996] www.mythtv.org 2009-02-14 13:11:36.471 Using runtime prefix = /usr/local 2009-02-14 13:11:37.415 Empty LocalHostName. 2009-02-14 13:11:37.415 Using localhost value of mythbox 2009-02-14 13:11:37.422 New DB connection, total: 1 2009-02-14 13:11:37.426 Connected to database 'mythconverg' at host: localhost 2009-02-14 13:11:37.426 Closing DB connection named 'DBManager0' 2009-02-14 13:11:37.457 DPMS is disabled. 2009-02-14 13:11:37.459 Primary screen: 0. 2009-02-14 13:11:37.459 Connected to database 'mythconverg' at host: localhost 2009-02-14 13:11:37.461 Using screen 0, 1920x1080 at 0,0 2009-02-14 13:11:37.498 MythUI Image Cache size set to 20971520 bytes 2009-02-14 13:11:37.498 user: 1000 effective user: 1000 before privileged thread 2009-02-14 13:11:37.499 user: 1000 effective user: 1000 after privileged thread 2009-02-14 13:11:37.499 user: 1000 effective user: 1000 run_priv_thread 2009-02-14 13:11:37.499 Enabled verbose msgs: important general playback 2009-02-14 13:11:37.516 Connecting to lcd server: localhost:6545 (try 1 of 10) 2009-02-14 13:11:37.575 The theme (defaultmenu) is missing a themeinfo.xml file 2009-02-14 13:11:37.697 The theme (defaultmenu) is missing a themeinfo.xml file 2009-02-14 13:11:37.740 max_width: 1920 max_height: 1080 2009-02-14 13:11:37.846 Primary screen: 0. 2009-02-14 13:11:37.847 Using screen 0, 1920x1080 at 0,0 2009-02-14 13:11:37.848 Using theme base resolution of 1280x720 2009-02-14 13:11:37.856 LIRC: Successfully initialized '/dev/lircd' using '/home/spikeygg/.mythtv/lircrc' config 2009-02-14 13:11:38.040 Using the OpenGL painter 2009-02-14 13:11:38.205 Loading base theme from /usr/local/share/mythtv/themes/MythCenter-wide/base.xml 2009-02-14 13:11:38.359 Loading base theme from /usr/local/share/mythtv/themes/default-wide/base.xml 2009-02-14 13:11:38.403 Loading base theme from /usr/local/share/mythtv/themes/default/base.xml 2009-02-14 13:11:38.498 Current Schema Version: 1228 2009-02-14 13:11:38.503 Connecting to backend server: 192.168.0.10:6543 (try 1 of 5) 2009-02-14 13:11:38.504 Using protocol version 44 2009-02-14 13:11:38.596 Registering Internal as a media playback plugin. 2009-02-14 13:11:38.615 Cannot load language en_us for module mytharchive 2009-02-14 13:11:38.617 Cannot load language en_us for module mythbrowser 2009-02-14 13:11:38.618 Cannot load language en_us for module mythbookmarkmanager 2009-02-14 13:11:38.635 Cannot load language en_us for module mythgame 2009-02-14 13:11:38.744 MythMusic adding CD-Writer: ATA:0,0,0 -- DVD-E616A 2009-02-14 13:11:38.763 MythMusic adding CD-Writer: ATAPI:0,0,0 -- DVD-E616A 2009-02-14 13:11:38.821 MonitorRegisterExtensions(0x40, ogg,mp3,aac,flac) 2009-02-14 13:11:38.826 Cannot load language en_us for module mythmusic 2009-02-14 13:11:38.830 Cannot load language en_us for module mythnews 2009-02-14 13:11:38.866 Cannot load language en_us for module mythvideo 2009-02-14 13:11:38.872 Cannot load language en_us for module mythweather 2009-02-14 13:11:39.391 Loading window theme from /usr/local/share/mythtv/themes/MythCenter-wide/menu-ui.xml 2009-02-14 13:11:39.447 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//mainmenu.xml 2009-02-14 13:11:39.449 Found mainmenu.xml for theme 'MythCenter-wide' 2009-02-14 13:11:39.452 Using NV NPOT texture extension 2009-02-14 13:11:40.797 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//optical_menu.xml 2009-02-14 13:11:41.839 RingBuf(dvd://dev/dvd): OpenFile(dvd://dev/dvd, 12) 2009-02-14 13:11:41.839 OpenFile() trying DVD at /dev/dvd libdvdnav: Using dvdnav version svnR1166 libdvdnav: DVD Title: SUPERMAN_III libdvdnav: DVD Serial Number: 34F3A1FA libdvdnav: DVD Title (Alternative): SUPERMAN_III libdvdnav: Unable to find map file '/home/spikeygg/.dvdnav/SUPERMAN_III.map' libdvdnav: DVD disk reports itself with Region mask 0x00f00000. Regions: 1 2 3 4 2009-02-14 13:11:42.979 Opened DVD device at /dev/dvd libdvdnav: Suspected RCE Region Protection!!! 2009-02-14 13:11:43.114 There are 21 titles on the disk 2009-02-14 13:11:43.115 Title 0 has 0 parts. 2009-02-14 13:11:43.115 Title 1 has 39 parts. 2009-02-14 13:11:43.115 Title 2 has 1 parts. 2009-02-14 13:11:43.115 Title 3 has 1 parts. 2009-02-14 13:11:43.115 Title 4 has 1 parts. 2009-02-14 13:11:43.115 Title 5 has 1 parts. 2009-02-14 13:11:43.115 Title 6 has 11 parts. 2009-02-14 13:11:43.115 Title 7 has 1 parts. 2009-02-14 13:11:43.115 Title 8 has 1 parts. 2009-02-14 13:11:43.115 Title 9 has 1 parts. 2009-02-14 13:11:43.115 Title 10 has 1 parts. 2009-02-14 13:11:43.115 Title 11 has 1 parts. 2009-02-14 13:11:43.115 Title 12 has 1 parts. 2009-02-14 13:11:43.115 Title 13 has 1 parts. 2009-02-14 13:11:43.115 Title 14 has 1 parts. 2009-02-14 13:11:43.115 Title 15 has 1 parts. 2009-02-14 13:11:43.115 Title 16 has 1 parts. 2009-02-14 13:11:43.115 Title 17 has 1 parts. 2009-02-14 13:11:43.115 Title 18 has 1 parts. 2009-02-14 13:11:43.115 Title 19 has 1 parts. 2009-02-14 13:11:43.115 Title 20 has 1 parts. 2009-02-14 13:11:43.116 DVD Serial Number 34F3A1FA 2009-02-14 13:11:43.116 RingBuf(/dev/dvd): CalcReadAheadThresh(4000 KB) -> threshhold(64 KB) min read(32 KB) blk size(64 KB) 2009-02-14 13:11:43.117 TV: StartTV() -- begin 2009-02-14 13:11:43.117 TV: ctor 2009-02-14 13:11:43.126 New DB connection, total: 2 2009-02-14 13:11:43.127 Connected to database 'mythconverg' at host: localhost 2009-02-14 13:11:43.161 TV: tv->Playback() -- begin 2009-02-14 13:11:43.165 TV: tv->Playback() -- end 2009-02-14 13:11:43.165 TV: StartTV -- process events begin 2009-02-14 13:11:43.185 TV: HandleStateChange(0) -- begin 2009-02-14 13:11:43.185 TV: Attempting to change from None to WatchingPreRecorded 2009-02-14 13:11:43.185 RingBuf(dvd://dev/dvd): OpenFile(dvd://dev/dvd, 12) 2009-02-14 13:11:43.185 OpenFile() trying DVD at /dev/dvd libdvdnav: Using dvdnav version svnR1166 libdvdnav: DVD Title: SUPERMAN_III libdvdnav: DVD Serial Number: 34F3A1FA libdvdnav: DVD Title (Alternative): SUPERMAN_III libdvdnav: Unable to find map file '/home/spikeygg/.dvdnav/SUPERMAN_III.map' libdvdnav: DVD disk reports itself with Region mask 0x00f00000. Regions: 1 2 3 4 2009-02-14 13:11:43.487 Opened DVD device at /dev/dvd libdvdnav: Suspected RCE Region Protection!!! 2009-02-14 13:11:43.622 There are 21 titles on the disk 2009-02-14 13:11:43.622 Title 0 has 0 parts. 2009-02-14 13:11:43.622 Title 1 has 39 parts. 2009-02-14 13:11:43.622 Title 2 has 1 parts. 2009-02-14 13:11:43.622 Title 3 has 1 parts. 2009-02-14 13:11:43.622 Title 4 has 1 parts. 2009-02-14 13:11:43.622 Title 5 has 1 parts. 2009-02-14 13:11:43.622 Title 6 has 11 parts. 2009-02-14 13:11:43.622 Title 7 has 1 parts. 2009-02-14 13:11:43.622 Title 8 has 1 parts. 2009-02-14 13:11:43.622 Title 9 has 1 parts. 2009-02-14 13:11:43.622 Title 10 has 1 parts. 2009-02-14 13:11:43.622 Title 11 has 1 parts. 2009-02-14 13:11:43.622 Title 12 has 1 parts. 2009-02-14 13:11:43.622 Title 13 has 1 parts. 2009-02-14 13:11:43.622 Title 14 has 1 parts. 2009-02-14 13:11:43.622 Title 15 has 1 parts. 2009-02-14 13:11:43.622 Title 16 has 1 parts. 2009-02-14 13:11:43.622 Title 17 has 1 parts. 2009-02-14 13:11:43.622 Title 18 has 1 parts. 2009-02-14 13:11:43.622 Title 19 has 1 parts. 2009-02-14 13:11:43.622 Title 20 has 1 parts. 2009-02-14 13:11:43.622 DVD Serial Number 34F3A1FA 2009-02-14 13:11:43.622 RingBuf(/dev/dvd): CalcReadAheadThresh(4000 KB) -> threshhold(64 KB) min read(32 KB) blk size(64 KB) 2009-02-14 13:11:43.622 TV: StartPlayer(0, WatchingPreRecorded, main) -- begin 2009-02-14 13:11:43.844 DVDNAV_HIGHLIGHT: display==1, palette==0, sx==0, sy==0, ex==0, ey==0, pts==0, buttonN==1 2009-02-14 13:11:43.844 DVDNAV_VTS_CHANGE: old_vtsN==0, new_vtsN==2, aspect: 3, perm: 2 2009-02-14 13:11:43.844 DVDNAV_CELL_CHANGE: pg_length == 1080000, pgc_length == 1080000, cell_start == 0, pg_start == 0, title == 3, part == 1 titleParts 1 2009-02-14 13:11:43.844 DVDNAV_SPU_CLUT_CHANGE happened. 2009-02-14 13:11:43.844 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128 2009-02-14 13:11:43.844 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 2009-02-14 13:11:43.967 DVDNAV_HOP_CHANNEL happened. 2009-02-14 13:11:43.967 DVDNAV_CELL_CHANGE: pg_length == 1080000, pgc_length == 1080000, cell_start == 0, pg_start == 0, title == 3, part == 1 titleParts 1 2009-02-14 13:11:43.967 DVDNAV_SPU_CLUT_CHANGE happened. 2009-02-14 13:11:43.967 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128 2009-02-14 13:11:43.967 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 2009-02-14 13:11:43.977 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:43.979 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:43.980 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:43.980 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:43.980 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:43.980 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:43.981 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:43.981 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:43.981 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:43.982 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:43.982 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:43.982 Using 1 CPUs for decoding 2009-02-14 13:11:43.982 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:11:43.982 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:11:43.982 AFD: Using ffmpeg for video decoding 2009-02-14 13:11:43.982 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:43.982 AFD: Opened codec 0x7f9b09803140, id(MPEG2VIDEO) type(Video) 2009-02-14 13:11:43.982 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:43.982 NVP(0): Disabling Audio, params(-1,-1,-1) 2009-02-14 13:11:43.982 No codec context. Returning false 2009-02-14 13:11:43.982 Dec: Trying to select track (w/lang) 2009-02-14 13:11:43.982 Dec: Selecting first track 2009-02-14 13:11:43.982 Dec: Selected track #1 in the Unknown language(0) 2009-02-14 13:11:43.982 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2009-02-14 13:11:43.982 DVD Frame Rate 29.97 2009-02-14 13:11:43.982 Position map filled from DB to: 359 2009-02-14 13:11:43.982 Dec: SyncPositionMap prerecorded, from DB: 1 entries 2009-02-14 13:11:43.982 Dec: SyncPositionMap, new totframes: 359, new length: 12, posMap size: 1 2009-02-14 13:11:43.983 AFD: Position map found 2009-02-14 13:11:43.983 AFD: Successfully opened decoder for file: "/dev/dvd". novideo(0) 2009-02-14 13:11:43.987 VideoOutput: Allowed renderers: directfb,opengl,xv-blit,xshm,xlib 2009-02-14 13:11:43.988 VideoOutput: Allowed renderers (filt: ffmpeg): xlib,xshm,directfb,xv-blit,opengl 2009-02-14 13:11:43.989 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:43.989 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:43.989 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:43.989 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:43.990 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:43.990 VideoOutput: Preferred renderer: xv-blit 2009-02-14 13:11:43.990 VideoOutput: Trying video renderer: 'xv-blit' 2009-02-14 13:11:43.998 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:43.998 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:43.998 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:43.998 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.001 VideoOutputXv: ctor 2009-02-14 13:11:44.001 VideoOutWindow::SetPIPState. pip_state: 0] 2009-02-14 13:11:44.002 VideoOutputXv: Creating XJ_gc 2009-02-14 13:11:44.002 VideoOutputXv: XJ_screen: '0x876e90' 2009-02-14 13:11:44.002 VideoOutputXv: XJ_screen_num: '0' 2009-02-14 13:11:44.002 VideoOutputXv: XJ_curwin: '31457317' 2009-02-14 13:11:44.002 VideoOutputXv: XJ_win: '31457317' 2009-02-14 13:11:44.002 VideoOutputXv: XJ_root: '422' 2009-02-14 13:11:44.002 VideoOutputXv: XJ_gc: '0x8ec3d0' 2009-02-14 13:11:44.002 Display Rect left: 0, top: 60, width: 1920, height: 960, aspect: 1.33333 2009-02-14 13:11:44.003 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.5 2009-02-14 13:11:44.003 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.007 GLCtx: Created window and GLX context. 2009-02-14 13:11:44.007 GLCtx: GLX Version: 1.2 2009-02-14 13:11:44.007 GLCtx: Direct rendering: Yes 2009-02-14 13:11:44.028 GLCtx: OpenGL vendor : NVIDIA Corporation 2009-02-14 13:11:44.028 GLCtx: OpenGL renderer: GeForce 6200 A-LE/AGP/SSE2 2009-02-14 13:11:44.028 GLCtx: OpenGL version : 2.1.2 NVIDIA 177.80 2009-02-14 13:11:44.028 GLCtx: Max texture size: 4096 x 4096 2009-02-14 13:11:44.029 VideoOutputXv Warning: GLContextCreatedWait: Waited 26 ms 2009-02-14 13:11:44.031 VideoOutputXv: Pixel dimensions: Screen 1920x1080, window 1920x1080 2009-02-14 13:11:44.032 VideoOutputXv: Estimated display dimensions: 610x343 mm Aspect: 1.77843 2009-02-14 13:11:44.032 VideoOutputXv: Estimated window dimensions: 610x343 mm Aspect: 1.77843 2009-02-14 13:11:44.033 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: opengl,xv-blit,xshm,xlib 2009-02-14 13:11:44.037 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:44.037 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:44.037 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:44.037 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.037 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.038 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask 10 2009-02-14 13:11:44.038 VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 2009-02-14 13:11:44.038 VideoOutputXv: Has XVideo flags... 2009-02-14 13:11:44.038 VideoOutputXv: Missing XV_BRIGHTNESS, rejecting. 2009-02-14 13:11:44.038 VideoOutputXv: Adaptor#1: NV05 Video Blitter has flag[s]: XvInputMask XvImageMask 2009-02-14 13:11:44.038 VideoOutputXv: Has XVideo flags... 2009-02-14 13:11:44.038 VideoOutputXv: Missing XV_BRIGHTNESS, rejecting. 2009-02-14 13:11:44.038 VideoOutputXv: @ j=1 Looking for flag[s]: XvInputMask XvImageMask 0 2009-02-14 13:11:44.038 VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 2009-02-14 13:11:44.038 VideoOutputXv: Has XVideo flags... 2009-02-14 13:11:44.038 VideoOutputXv: Here... 2009-02-14 13:11:44.039 VideoOutputXv: Grabbed xv port 355 2009-02-14 13:11:44.039 VideoOutputXv: XVideo surface found on port 355 2009-02-14 13:11:44.039 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture' 2009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #0 is 'YUY2' 2009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #1 is 'YV12' 2009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #2 is 'UYVY' 2009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #3 is 'I420' 2009-02-14 13:11:44.039 VideoOutputXv: Using XVideo Format 'YV12' 2009-02-14 13:11:44.039 VideoOutputXv: CreateShmImages(32): video_dim: 720x480 2009-02-14 13:11:44.063 VDP: SetVideoRenderer(xv-blit) 2009-02-14 13:11:44.063 VDP: SetVideoRender(xv-blit) == GetVideoRenderer() 2009-02-14 13:11:44.063 VideoOutputXv: Chromakeying not possible with this XVideo port. 2009-02-14 13:11:44.063 Display Rect left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778 2009-02-14 13:11:44.063 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.5 2009-02-14 13:11:44.063 Over/underscan. V: 0, H: 0 2009-02-14 13:11:44.063 Display Rect left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778 2009-02-14 13:11:44.064 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.5 2009-02-14 13:11:44.064 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:11:44.064 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:11:44.066 OSD Theme Dimensions W: 640 H: 480 2009-02-14 13:11:44.351 NVP(0): ClearAfterSeek(1) 2009-02-14 13:11:44.351 playCtx: StartDecoderThread(): took 367 ms to start player. 2009-02-14 13:11:44.351 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:11:44.351 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:11:44.351 TV: StartPlayer(0, WatchingPreRecorded, main) -- end ok 2009-02-14 13:11:44.351 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.352 TV: Changing from None to WatchingPreRecorded 2009-02-14 13:11:44.352 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.352 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.352 TV: HandleStateChange(0) -- end 2009-02-14 13:11:44.354 No codec context. Returning false 2009-02-14 13:11:44.354 AFD: DVD Title Changed 2009-02-14 13:11:44.354 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2009-02-14 13:11:44.355 DVD Frame Rate 29.97 2009-02-14 13:11:44.355 Position map filled from DB to: 359 2009-02-14 13:11:44.355 Dec: SyncPositionMap prerecorded, from DB: 1 entries 2009-02-14 13:11:44.355 Dec: SyncPositionMap, new totframes: 359, new length: 12, posMap size: 1 2009-02-14 13:11:44.355 AFD: DVD Cell Changed. Update framesPlayed: 0 2009-02-14 13:11:44.355 DVDNAV_HOP_CHANNEL happened. 2009-02-14 13:11:44.355 DVDNAV_CELL_CHANGE: pg_length == 1080000, pgc_length == 1080000, cell_start == 0, pg_start == 0, title == 3, part == 1 titleParts 1 2009-02-14 13:11:44.355 DVDNAV_SPU_CLUT_CHANGE happened. 2009-02-14 13:11:44.355 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128 2009-02-14 13:11:44.355 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 2009-02-14 13:11:44.355 AFD: DVD Cell Changed. Update framesPlayed: 0 2009-02-14 13:11:44.355 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:11:44.355 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:11:44.357 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:11:44.357 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a7300f0 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:11:44.360 Using deinterlace method greedyhdeint 2009-02-14 13:11:44.360 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:11:44.360 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.360 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.360 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.360 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.369 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2009-02-14 13:11:44.370 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.77778 2009-02-14 13:11:44.373 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory 2009-02-14 13:11:44.373 OpenGLVideoSync() 2009-02-14 13:11:44.396 Using audio as timebase 2009-02-14 13:11:44.396 Video timing method: SGI OpenGL 2009-02-14 13:11:44.396 Refresh rate: 16666, frame interval: 33366 2009-02-14 13:11:44.413 NVP(0): Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.496 NVP(0): ClearAfterSeek(1) 2009-02-14 13:11:44.496 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:11:44.496 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:11:44.497 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.497 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.497 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.497 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:11:44.497 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:11:44.497 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 2 2009-02-14 13:11:44.497 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:44.499 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:44.499 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:44.499 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:44.499 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.499 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.501 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:44.501 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:44.501 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:44.502 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.502 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.502 Using 1 CPUs for decoding 2009-02-14 13:11:44.502 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:11:44.502 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:11:44.502 VideoOutputXv: InputChanged(720,480,1.5) 'MPEG2'->'MPEG2' 2009-02-14 13:11:44.502 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:11:44.503 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:11:44.503 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a730870 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:11:44.503 Using deinterlace method greedyhdeint 2009-02-14 13:11:44.503 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:11:44.503 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.504 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.504 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.504 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.508 Display Rect left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778 2009-02-14 13:11:44.508 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.5 2009-02-14 13:11:44.562 NVP(0): Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.628 NVP(0): ClearAfterSeek(1) 2009-02-14 13:11:44.628 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:11:44.628 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:11:44.628 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.628 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.628 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.628 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:11:44.629 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:11:44.629 AFD: Using ffmpeg for video decoding 2009-02-14 13:11:44.629 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:44.629 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a4353c0 2009-02-14 13:11:44.629 AFD: codec AC3 has 0 channels 2009-02-14 13:11:44.629 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.629 AFD: Opened codec 0x7f9b0a02afa0, id(AC3) type(Audio) 2009-02-14 13:11:44.629 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:44.632 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:11:44.632 Opening ALSA audio device 'default'. 2009-02-14 13:11:44.640 NVP(0): Enabling Audio 2009-02-14 13:11:44.642 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:11:44.642 Opening ALSA audio device 'default'. 2009-02-14 13:11:44.644 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 3 2009-02-14 13:11:44.644 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:44.645 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:44.646 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:44.646 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:44.646 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.646 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.647 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:44.647 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:44.647 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:44.647 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.647 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.648 Using 1 CPUs for decoding 2009-02-14 13:11:44.648 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:11:44.648 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:11:44.648 AFD: Using ffmpeg for video decoding 2009-02-14 13:11:44.648 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:44.648 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a4353c0 2009-02-14 13:11:44.648 AFD: Warning, audio codec 0x7f9b0a02afa0 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:44.648 AFD: codec AC3 has 2 channels 2009-02-14 13:11:44.648 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.648 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0bf9b790 2009-02-14 13:11:44.648 AFD: codec AC3 has 0 channels 2009-02-14 13:11:44.648 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.648 AFD: Opened codec 0x7f9b0bf9b940, id(AC3) type(Audio) 2009-02-14 13:11:44.648 RingBuf(/dev/dvd): CalcReadAheadThresh(7692 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:44.649 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:11:44.649 AFD: DVD Audio Track Map Stream id #130 2009-02-14 13:11:44.650 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:11:44.650 Opening ALSA audio device 'default'. 2009-02-14 13:11:44.652 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4 2009-02-14 13:11:44.652 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:44.653 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:44.653 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:44.653 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:44.653 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.654 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.655 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:44.655 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:44.655 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:44.655 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:44.655 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:44.655 Using 1 CPUs for decoding 2009-02-14 13:11:44.655 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:11:44.655 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:11:44.655 AFD: Using ffmpeg for video decoding 2009-02-14 13:11:44.656 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:44.656 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a4353c0 2009-02-14 13:11:44.656 AFD: Warning, audio codec 0x7f9b0a02afa0 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:44.656 AFD: codec AC3 has 2 channels 2009-02-14 13:11:44.656 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.656 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf9b790 2009-02-14 13:11:44.656 AFD: Warning, audio codec 0x7f9b0bf9b940 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:44.656 AFD: codec AC3 has 2 channels 2009-02-14 13:11:44.656 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.656 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a792a70 2009-02-14 13:11:44.656 AFD: codec AC3 has 0 channels 2009-02-14 13:11:44.656 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.656 AFD: Opened codec 0x7f9b0a792c20, id(AC3) type(Audio) 2009-02-14 13:11:44.656 RingBuf(/dev/dvd): CalcReadAheadThresh(7884 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:44.656 AFD: DVD Audio Track Map Stream id #128 2009-02-14 13:11:44.656 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:11:44.656 AFD: DVD Audio Track Map Stream id #130 2009-02-14 13:11:44.657 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:44.657 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:44.657 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a4353c0 2009-02-14 13:11:44.657 AFD: Warning, audio codec 0x7f9b0a02afa0 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:44.657 AFD: codec AC3 has 2 channels 2009-02-14 13:11:44.657 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.657 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf9b790 2009-02-14 13:11:44.657 AFD: Warning, audio codec 0x7f9b0bf9b940 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:44.657 AFD: codec AC3 has 2 channels 2009-02-14 13:11:44.657 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.657 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a792a70 2009-02-14 13:11:44.657 AFD: Warning, audio codec 0x7f9b0a792c20 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:44.657 AFD: codec AC3 has 2 channels 2009-02-14 13:11:44.657 AFD: Looking for decoder for AC3 2009-02-14 13:11:44.657 RingBuf(/dev/dvd): CalcReadAheadThresh(8076 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:44.657 AFD: DVD Audio Track Map Stream id #128 2009-02-14 13:11:44.657 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:11:44.657 AFD: DVD Audio Track Map Stream id #130 2009-02-14 13:11:44.658 VideoOutputXv: InputChanged(720,480,1.33333) 'MPEG2'->'MPEG2' 2009-02-14 13:11:44.658 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:11:44.660 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:11:44.660 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf9aca0 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:11:44.660 Using deinterlace method greedyhdeint 2009-02-14 13:11:44.660 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:11:44.660 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.660 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.660 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.660 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.665 Display Rect left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778 2009-02-14 13:11:44.665 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333 2009-02-14 13:11:44.665 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:11:44.712 NVP(0): Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.789 NVP(0): ClearAfterSeek(1) 2009-02-14 13:11:44.789 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:11:44.789 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:11:44.789 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.790 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.790 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.790 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:11:44.790 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:11:44.790 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:11:44.790 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:11:44.791 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:11:44.791 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf911c0 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:11:44.791 Using deinterlace method greedyhdeint 2009-02-14 13:11:44.791 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:11:44.791 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.791 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.792 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.792 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.796 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2009-02-14 13:11:44.796 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.77778 2009-02-14 13:11:44.797 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:11:44.863 NVP(0): Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.921 NVP(0): ClearAfterSeek(1) 2009-02-14 13:11:44.921 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:11:44.921 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:11:44.921 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:44.921 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:44.921 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:44.921 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:11:44.921 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:11:44.923 Dec: Trying to reselect track 2009-02-14 13:11:44.924 Dec: Selected track #1 in the Unknown language(0) 2009-02-14 13:11:44.932 AFD: HandleGopStart: gopset not set, syncing positionMap 2009-02-14 13:11:44.932 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0) 2009-02-14 13:11:44.932 AFD: HandleGopStart: Initial key frame distance: 15. 2009-02-14 13:11:44.933 AFD: HandleGopStart: Key frame distance changed from 14 to 1. 'video_output' mean = '32875.06', std. dev. = '3232.32', fps = '30.42' 'video_output' mean = '33332.36', std. dev. = '143.53', fps = '30.00' 'video_output' mean = '33329.99', std. dev. = '159.86', fps = '30.00' 2009-02-14 13:11:55.765 DVDNAV_CELL_CHANGE: pg_length == 1083000, pgc_length == 1083000, cell_start == 0, pg_start == 0, title == 2, part == 1 titleParts 1 2009-02-14 13:11:55.766 DVDNAV_SPU_CLUT_CHANGE happened. 2009-02-14 13:11:55.766 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128 2009-02-14 13:11:55.766 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 2009-02-14 13:11:55.826 AFD: DVD Title Changed 2009-02-14 13:11:55.828 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2009-02-14 13:11:55.828 DVD Frame Rate 29.97 2009-02-14 13:11:55.828 Position map filled from DB to: 359 2009-02-14 13:11:55.828 Dec: SyncPositionMap prerecorded, from DB: 1 entries 2009-02-14 13:11:55.828 Dec: SyncPositionMap, new totframes: 359, new length: 12, posMap size: 1 2009-02-14 13:11:55.828 AFD: DVD Cell Changed. Update framesPlayed: 0 2009-02-14 13:11:55.842 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:55.842 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:55.842 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:55.842 NVP(0): Disabling Audio, params(-1,-1,-1) 2009-02-14 13:11:55.844 VideoOutputXv: InputChanged(720,480,1.33333) 'MPEG2'->'MPEG2' 2009-02-14 13:11:55.845 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:11:55.846 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:11:55.846 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a605930 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:11:55.846 Using deinterlace method greedyhdeint 2009-02-14 13:11:55.846 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:11:55.846 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUUUUUUUUUUuUULAAAUU 2009-02-14 13:11:55.846 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:55.846 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:55.846 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:55.851 Display Rect left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778 2009-02-14 13:11:55.851 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.33333 2009-02-14 13:11:55.851 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:11:55.868 NVP(0): prebuffering pause 2009-02-14 13:11:55.868 NVP(0): Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:55.975 NVP(0): ClearAfterSeek(1) 2009-02-14 13:11:55.975 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:11:55.975 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:11:55.975 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:55.975 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:55.975 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:55.975 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:11:55.975 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:11:55.976 No codec context. Returning false 2009-02-14 13:11:55.977 Dec: Trying to reselect track 2009-02-14 13:11:55.977 Dec: Selected track #1 in the Unknown language(0) 2009-02-14 13:11:55.978 No codec context. Returning false 2009-02-14 13:11:55.979 No codec context. Returning false 2009-02-14 13:11:55.980 No codec context. Returning false 2009-02-14 13:11:55.981 No codec context. Returning false 2009-02-14 13:11:55.982 No codec context. Returning false 2009-02-14 13:11:55.983 No codec context. Returning false 2009-02-14 13:11:55.984 No codec context. Returning false 2009-02-14 13:11:55.985 No codec context. Returning false 2009-02-14 13:11:55.986 No codec context. Returning false 2009-02-14 13:11:55.986 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 2 2009-02-14 13:11:55.986 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:55.988 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:55.988 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:55.988 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:55.988 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:55.988 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:55.990 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:55.990 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:55.990 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:55.990 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:55.990 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:55.990 Using 1 CPUs for decoding 2009-02-14 13:11:55.990 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:11:55.990 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:11:55.990 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:11:55.990 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:11:55.991 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:11:55.991 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a7304a0 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:11:55.992 Using deinterlace method greedyhdeint 2009-02-14 13:11:55.992 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:11:55.992 VideoBuffers::DiscardFrames(1): UUuUALAAAAAAAAAAAAAAAAAAA(AU)UUUUU 2009-02-14 13:11:55.992 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:55.992 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:55.992 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:55.997 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2009-02-14 13:11:55.997 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.77778 2009-02-14 13:11:55.997 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:11:56.013 NVP(0): Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:56.119 NVP(0): ClearAfterSeek(1) 2009-02-14 13:11:56.119 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:11:56.119 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:11:56.119 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:11:56.119 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:11:56.120 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:11:56.120 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:11:56.120 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:11:56.120 AFD: Using ffmpeg for video decoding 2009-02-14 13:11:56.120 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:56.120 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0bf94fd0 2009-02-14 13:11:56.120 AFD: codec AC3 has 0 channels 2009-02-14 13:11:56.120 AFD: Looking for decoder for AC3 2009-02-14 13:11:56.120 AFD: Opened codec 0x7f9b0bf94770, id(AC3) type(Audio) 2009-02-14 13:11:56.120 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:56.121 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:11:56.121 Opening ALSA audio device 'default'. 2009-02-14 13:11:56.122 NVP(0): Enabling Audio 2009-02-14 13:11:56.125 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:11:56.125 Opening ALSA audio device 'default'. 2009-02-14 13:11:56.127 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 3 2009-02-14 13:11:56.127 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:56.128 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:56.128 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:56.129 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:56.129 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:56.129 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:56.130 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:56.131 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:56.131 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:56.131 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:56.131 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:56.131 Using 1 CPUs for decoding 2009-02-14 13:11:56.131 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:11:56.131 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:11:56.131 AFD: Using ffmpeg for video decoding 2009-02-14 13:11:56.131 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:56.131 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf94fd0 2009-02-14 13:11:56.131 AFD: Warning, audio codec 0x7f9b0bf94770 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:56.131 AFD: codec AC3 has 2 channels 2009-02-14 13:11:56.131 AFD: Looking for decoder for AC3 2009-02-14 13:11:56.131 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a32a870 2009-02-14 13:11:56.131 AFD: codec AC3 has 0 channels 2009-02-14 13:11:56.131 AFD: Looking for decoder for AC3 2009-02-14 13:11:56.132 AFD: Opened codec 0x7f9b0a32aa20, id(AC3) type(Audio) 2009-02-14 13:11:56.132 RingBuf(/dev/dvd): CalcReadAheadThresh(7692 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:56.132 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:11:56.132 AFD: DVD Audio Track Map Stream id #130 2009-02-14 13:11:56.133 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:11:56.133 Opening ALSA audio device 'default'. 2009-02-14 13:11:56.134 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4 2009-02-14 13:11:56.134 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:11:56.136 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:56.136 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:56.136 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:56.136 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:56.136 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:56.138 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:11:56.138 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:11:56.138 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:11:56.138 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:11:56.138 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:11:56.138 Using 1 CPUs for decoding 2009-02-14 13:11:56.138 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:11:56.138 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:11:56.138 AFD: Using ffmpeg for video decoding 2009-02-14 13:11:56.138 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:11:56.138 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf94fd0 2009-02-14 13:11:56.138 AFD: Warning, audio codec 0x7f9b0bf94770 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:56.138 AFD: codec AC3 has 2 channels 2009-02-14 13:11:56.138 AFD: Looking for decoder for AC3 2009-02-14 13:11:56.139 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a32a870 2009-02-14 13:11:56.139 AFD: Warning, audio codec 0x7f9b0a32aa20 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:11:56.139 AFD: codec AC3 has 2 channels 2009-02-14 13:11:56.139 AFD: Looking for decoder for AC3 2009-02-14 13:11:56.139 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a5ec370 2009-02-14 13:11:56.139 AFD: codec AC3 has 0 channels 2009-02-14 13:11:56.139 AFD: Looking for decoder for AC3 2009-02-14 13:11:56.139 AFD: Opened codec 0x7f9b0a5ec520, id(AC3) type(Audio) 2009-02-14 13:11:56.139 RingBuf(/dev/dvd): CalcReadAheadThresh(7884 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:11:56.139 AFD: DVD Audio Track Map Stream id #128 2009-02-14 13:11:56.139 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:11:56.139 AFD: DVD Audio Track Map Stream id #130 2009-02-14 13:11:56.141 Dec: Trying to reselect track 2009-02-14 13:11:56.141 Dec: Selected track #1 in the Unknown language(0) 2009-02-14 13:11:56.141 AFD: HandleGopStart: Key frame distance changed from 15 to 11. 2009-02-14 13:11:56.142 AFD: HandleGopStart: Key frame distance changed from 11 to 1. 2009-02-14 13:11:56.163 NVP(0): progressive frame seen after 2 interlaced frames 2009-02-14 13:11:56.163 Disabled deinterlacing 2009-02-14 13:11:56.177 GetNextFreeFrame() served a busy frame F. Dropping. UUAUUUUUUUUUUUUUUUUUUUUUUUUUULU 2009-02-14 13:11:57.813 NVP(0): interlaced frame seen after 46 progressive frames 2009-02-14 13:11:57.813 Enabled deinterlacing 'video_output' mean = '37997.67', std. dev. = '28949.78', fps = '26.32' 'video_output' mean = '33330.19', std. dev. = '126.69', fps = '30.00' 'video_output' mean = '33330.13', std. dev. = '5145.69', fps = '30.00' 2009-02-14 13:12:05.863 NVP(0): progressive frame seen after 242 interlaced frames 2009-02-14 13:12:05.864 Disabled deinterlacing 2009-02-14 13:12:06.314 DVDNAV_VTS_CHANGE: old_vtsN==2, new_vtsN==2, aspect: 3, perm: 1 2009-02-14 13:12:06.314 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2009-02-14 13:12:06.314 Video Rect left: 0, top: 0, width: 720, height: 480, aspect: 1.77778 2009-02-14 13:12:06.314 DVDNAV_CELL_CHANGE: pg_length == 6198000, pgc_length == 6198000, cell_start == 0, pg_start == 0, title == 0, part == 3 titleParts 0 2009-02-14 13:12:06.314 DVDNAV_SPU_CLUT_CHANGE happened. 2009-02-14 13:12:06.314 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==1, current_track==0 2009-02-14 13:12:06.314 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 2009-02-14 13:12:06.314 AFD: DVD Title Changed 2009-02-14 13:12:06.314 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2009-02-14 13:12:06.314 DVD Frame Rate 29.97 2009-02-14 13:12:06.314 Position map filled from DB to: 2037 2009-02-14 13:12:06.314 Dec: SyncPositionMap prerecorded, from DB: 1 entries 2009-02-14 13:12:06.314 Dec: SyncPositionMap, new totframes: 2037, new length: 68, posMap size: 1 2009-02-14 13:12:06.314 AFD: DVD Cell Changed. Update framesPlayed: 0 2009-02-14 13:12:06.315 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:12:06.315 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:12:06.316 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:12:06.317 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf9ac30 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:12:06.317 Using deinterlace method greedyhdeint 2009-02-14 13:12:06.317 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:06.317 VideoBuffers::DiscardFrames(1): UULAUUUUUUUUUUUUUUUUUUUUUUUUUuU 2009-02-14 13:12:06.317 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.317 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:06.317 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.366 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.376 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.386 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.396 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.406 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.417 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.427 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.437 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.446 NVP(0): ClearAfterSeek(1) 2009-02-14 13:12:06.446 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:12:06.446 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:12:06.446 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:06.446 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:06.446 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.446 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:12:06.446 detectInterlace(Detect Scan, Progressive Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:12:06.446 Enabled deinterlacing 2009-02-14 13:12:06.446 Entering DVD Still Frame 2009-02-14 13:12:06.446 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120 2009-02-14 13:12:06.446 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:06.446 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB) -> threshhold(64 KB) min read(32 KB) blk size(256 KB) 2009-02-14 13:12:06.446 NVP(0): Disabling Audio, params(-1,-1,-1) 2009-02-14 13:12:06.447 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.447 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:12:06.447 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:12:06.448 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:12:06.448 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a32bf90 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:12:06.449 Using deinterlace method greedyhdeint 2009-02-14 13:12:06.449 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:06.449 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:06.449 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.449 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:06.449 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.454 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:12:06.457 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.467 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.477 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.487 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.497 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.507 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.517 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.527 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.537 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.547 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.558 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.568 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.577 NVP(0): ClearAfterSeek(1) 2009-02-14 13:12:06.577 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:12:06.577 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:12:06.577 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:06.577 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:06.577 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.577 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:12:06.577 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:12:06.578 AFD: HandleGopStart: gopset not set, syncing positionMap 2009-02-14 13:12:06.578 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0) 2009-02-14 13:12:06.578 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.585 No codec context. Returning false 2009-02-14 13:12:06.585 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 2 2009-02-14 13:12:06.585 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120 2009-02-14 13:12:06.587 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:06.587 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:06.588 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:06.588 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:06.588 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:06.589 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:06.589 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:06.589 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:06.589 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:06.589 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:06.589 Using 1 CPUs for decoding 2009-02-14 13:12:06.590 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:12:06.590 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:12:06.590 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:12:06.590 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:12:06.591 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:12:06.591 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bab3b90 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:12:06.591 Using deinterlace method greedyhdeint 2009-02-14 13:12:06.591 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:06.591 VideoBuffers::DiscardFrames(1): ALAuAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:06.591 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.591 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:06.591 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.596 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:12:06.621 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:06.734 NVP(0): ClearAfterSeek(1) 2009-02-14 13:12:06.734 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:12:06.734 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:12:06.734 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:06.734 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:06.734 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:06.736 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:12:06.736 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:12:06.736 AFD: Using ffmpeg for video decoding 2009-02-14 13:12:06.736 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:06.736 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:06.736 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:06.736 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:06.736 AFD: Opened codec 0x7f9b0a335360, id(DVD_SUBTITLE) type(Subtitle) 2009-02-14 13:12:06.736 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:06.736 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB) -> threshhold(64 KB) min read(32 KB) blk size(256 KB) 2009-02-14 13:12:06.736 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:06.736 Leaving DVD Still Frame 2009-02-14 13:12:06.737 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 3 2009-02-14 13:12:06.737 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120 2009-02-14 13:12:06.739 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:06.739 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:06.739 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:06.739 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:06.739 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:06.741 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:06.741 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:06.741 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:06.741 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:06.741 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:06.741 Using 1 CPUs for decoding 2009-02-14 13:12:06.741 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:12:06.741 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:12:06.741 AFD: Using ffmpeg for video decoding 2009-02-14 13:12:06.741 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:06.741 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:06.741 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:06.741 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:06.741 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:06.741 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0 2009-02-14 13:12:06.741 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:06.741 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:06.741 AFD: Opened codec 0x534b1a0, id(DVD_SUBTITLE) type(Subtitle) 2009-02-14 13:12:06.742 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972). 2009-02-14 13:12:06.742 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB) -> threshhold(64 KB) min read(32 KB) blk size(256 KB) 2009-02-14 13:12:06.742 AFD: DVD Subtitle Track Map Stream id #32 2009-02-14 13:12:06.742 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:06.742 DVDNAV_HOP_CHANNEL happened. 2009-02-14 13:12:06.742 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1 2009-02-14 13:12:06.742 DVDNAV_CELL_CHANGE: pg_length == 6198000, pgc_length == 6198000, cell_start == 0, pg_start == 0, title == 0, part == 3 titleParts 0 2009-02-14 13:12:06.742 DVDNAV_SPU_CLUT_CHANGE happened. 2009-02-14 13:12:06.742 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==1, current_track==0 2009-02-14 13:12:06.742 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 2009-02-14 13:12:06.743 AFD: HandleGopStart: gopset not set, syncing positionMap 2009-02-14 13:12:06.743 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0) 2009-02-14 13:12:06.743 AFD: HandleGopStart: Initial key frame distance: 15. 2009-02-14 13:12:06.743 Entering DVD Still Frame 2009-02-14 13:12:06.743 AFD: DVD Cell Changed. Update framesPlayed: 0 2009-02-14 13:12:06.746 NVP(0), Error: In DVD Menu: No video frames in queue 2009-02-14 13:12:06.751 No codec context. Returning false 2009-02-14 13:12:06.751 Leaving DVD Still Frame 2009-02-14 13:12:06.751 DVDRB: Clearing Menu SPU Packet 2009-02-14 13:12:06.752 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1 2009-02-14 13:12:06.752 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4 2009-02-14 13:12:06.752 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120 2009-02-14 13:12:06.754 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:06.754 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:06.754 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:06.754 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:06.754 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:06.755 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:06.755 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:06.755 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:06.756 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:06.756 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:06.756 Using 1 CPUs for decoding 2009-02-14 13:12:06.756 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:12:06.756 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:12:06.756 AFD: Using ffmpeg for video decoding 2009-02-14 13:12:06.756 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:06.756 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:06.756 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:06.756 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:06.756 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:06.756 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0 2009-02-14 13:12:06.756 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:06.756 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:06.756 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972). 2009-02-14 13:12:06.756 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a24cb30 2009-02-14 13:12:06.756 AFD: codec AC3 has 0 channels 2009-02-14 13:12:06.756 AFD: Looking for decoder for AC3 2009-02-14 13:12:06.757 AFD: Opened codec 0x7f9b0a23e0a0, id(AC3) type(Audio) 2009-02-14 13:12:06.757 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB) -> threshhold(64 KB) min read(32 KB) blk size(256 KB) 2009-02-14 13:12:06.757 AFD: DVD Subtitle Track Map Stream id #32 2009-02-14 13:12:06.757 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:06.759 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:12:06.759 Opening ALSA audio device 'default'. 2009-02-14 13:12:06.761 NVP(0): Enabling Audio 2009-02-14 13:12:06.763 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:12:06.763 Opening ALSA audio device 'default'. 2009-02-14 13:12:06.789 VideoOutputXv: UpdatePauseFrame() AAAAAuLAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:06.897 DVDRB: Entering DVDNAV_WAIT 2009-02-14 13:12:06.946 DVDRB: Exiting DVDNAV_WAIT status 2009-02-14 13:12:06.948 DVDNAV_VTS_CHANGE: old_vtsN==2, new_vtsN==2, aspect: 3, perm: 2 2009-02-14 13:12:06.948 DVDNAV_CELL_CHANGE: pg_length == 13968000, pgc_length == 674460000, cell_start == 0, pg_start == 0, title == 1, part == 1 titleParts 39 2009-02-14 13:12:06.948 DVDNAV_SPU_CLUT_CHANGE happened. 2009-02-14 13:12:06.948 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==129, physical_pan_scan==128, current_track==-128 2009-02-14 13:12:06.948 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 2009-02-14 13:12:07.025 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:12:07.025 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:12:07.027 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:12:07.027 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a4856f0 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:12:07.027 Using deinterlace method greedyhdeint 2009-02-14 13:12:07.027 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:07.027 VideoBuffers::DiscardFrames(1): AAAAAuLAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.027 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.027 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.027 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.156 NVP(0): ClearAfterSeek(1) 2009-02-14 13:12:07.157 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:12:07.157 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:12:07.157 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.157 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.157 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.158 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:12:07.158 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:12:07.159 AFD: DVD Title Changed 2009-02-14 13:12:07.159 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2009-02-14 13:12:07.159 DVD Frame Rate 29.97 2009-02-14 13:12:07.159 Position map filled from DB to: 224595 2009-02-14 13:12:07.159 Dec: SyncPositionMap prerecorded, from DB: 1 entries 2009-02-14 13:12:07.159 Dec: SyncPositionMap, new totframes: 224595, new length: 7494, posMap size: 1 2009-02-14 13:12:07.159 AFD: DVD Cell Changed. Update framesPlayed: 0 2009-02-14 13:12:07.159 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 5 2009-02-14 13:12:07.159 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:12:07.161 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.161 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.161 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.161 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.161 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.163 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.163 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.164 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.164 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.164 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.164 Using 1 CPUs for decoding 2009-02-14 13:12:07.164 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:12:07.164 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:12:07.164 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:12:07.164 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:12:07.165 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:12:07.165 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf951d0 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:12:07.166 Using deinterlace method greedyhdeint 2009-02-14 13:12:07.166 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:07.166 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.166 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.166 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.166 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.292 NVP(0): ClearAfterSeek(1) 2009-02-14 13:12:07.292 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:12:07.292 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:12:07.292 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.292 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.292 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.294 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:12:07.294 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:12:07.294 AFD: Using ffmpeg for video decoding 2009-02-14 13:12:07.294 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:07.294 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:07.294 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.294 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.294 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.294 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0 2009-02-14 13:12:07.294 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.294 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.294 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.294 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:12:07.294 AFD: DVD Subtitle Track Map Stream id #32 2009-02-14 13:12:07.294 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:07.295 NVP(0): Disabling Audio, params(-1,-1,-1) 2009-02-14 13:12:07.297 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4 2009-02-14 13:12:07.297 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:12:07.299 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.299 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.299 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.299 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.299 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.301 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.301 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.301 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.301 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.301 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.301 Using 1 CPUs for decoding 2009-02-14 13:12:07.301 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:12:07.301 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:12:07.301 AFD: Using ffmpeg for video decoding 2009-02-14 13:12:07.301 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:07.301 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:07.301 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.301 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.301 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.301 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0 2009-02-14 13:12:07.301 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.301 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.301 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.301 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0bab6a30 2009-02-14 13:12:07.302 AFD: codec AC3 has 0 channels 2009-02-14 13:12:07.302 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.302 AFD: Opened codec 0x7f9b0ba09430, id(AC3) type(Audio) 2009-02-14 13:12:07.302 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:12:07.302 AFD: DVD Subtitle Track Map Stream id #32 2009-02-14 13:12:07.302 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:07.303 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:12:07.303 Opening ALSA audio device 'default'. 2009-02-14 13:12:07.304 NVP(0): Enabling Audio 2009-02-14 13:12:07.306 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:12:07.306 Opening ALSA audio device 'default'. 2009-02-14 13:12:07.308 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 5 2009-02-14 13:12:07.308 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:12:07.310 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.310 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.310 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.310 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.310 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.312 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.312 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.312 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.312 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.312 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.312 Using 1 CPUs for decoding 2009-02-14 13:12:07.312 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:12:07.312 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:12:07.312 AFD: Using ffmpeg for video decoding 2009-02-14 13:12:07.312 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:07.312 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:07.312 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.312 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.312 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.312 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0 2009-02-14 13:12:07.312 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.312 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.312 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.313 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bab6a30 2009-02-14 13:12:07.313 AFD: Warning, audio codec 0x7f9b0ba09430 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:12:07.313 AFD: codec AC3 has 2 channels 2009-02-14 13:12:07.313 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.313 AFD: Stream #4, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a35e160 2009-02-14 13:12:07.313 AFD: codec AC3 has 0 channels 2009-02-14 13:12:07.313 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.313 AFD: Opened codec 0x7f9b0a240e60, id(AC3) type(Audio) 2009-02-14 13:12:07.313 RingBuf(/dev/dvd): CalcReadAheadThresh(7692 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:12:07.313 AFD: DVD Audio Track Map Stream id #128 2009-02-14 13:12:07.313 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:12:07.314 Opening audio device 'default'. ch 2(2) sr 48000 2009-02-14 13:12:07.314 Opening ALSA audio device 'default'. 2009-02-14 13:12:07.316 AFD: DVD Subtitle Track Map Stream id #32 2009-02-14 13:12:07.316 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:07.317 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 6 2009-02-14 13:12:07.317 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:12:07.318 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.318 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.319 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.319 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.319 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.320 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt() 2009-02-14 13:12:07.320 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,kerneldeint) filt() 2009-02-14 13:12:07.320 VDP: LoadBestPreferences(2048x2048, 0) 2009-02-14 13:12:07.320 VDP: LoadBestPreferences(2048x2048, 60) 2009-02-14 13:12:07.320 VDP: LoadBestPreferences(720x480, 60) 2009-02-14 13:12:07.320 Using 1 CPUs for decoding 2009-02-14 13:12:07.320 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open. 2009-02-14 13:12:07.321 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video). 2009-02-14 13:12:07.321 AFD: Using ffmpeg for video decoding 2009-02-14 13:12:07.321 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:07.321 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:07.321 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.321 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.321 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.321 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0 2009-02-14 13:12:07.321 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.321 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.321 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.321 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bab6a30 2009-02-14 13:12:07.321 AFD: Warning, audio codec 0x7f9b0ba09430 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:12:07.321 AFD: codec AC3 has 2 channels 2009-02-14 13:12:07.321 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.321 AFD: Stream #4, has id 0x128 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a35e160 2009-02-14 13:12:07.321 AFD: Warning, audio codec 0x7f9b0a240e60 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:12:07.321 AFD: codec AC3 has 2 channels 2009-02-14 13:12:07.321 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.321 AFD: Stream #5, has id 0x130 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a334970 2009-02-14 13:12:07.321 AFD: codec AC3 has 0 channels 2009-02-14 13:12:07.321 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.322 AFD: Opened codec 0x7f9b0a35c910, id(AC3) type(Audio) 2009-02-14 13:12:07.322 RingBuf(/dev/dvd): CalcReadAheadThresh(7884 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:12:07.322 AFD: DVD Audio Track Map Stream id #128 2009-02-14 13:12:07.322 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:12:07.322 AFD: DVD Audio Track Map Stream id #130 2009-02-14 13:12:07.322 AFD: DVD Subtitle Track Map Stream id #32 2009-02-14 13:12:07.322 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:07.322 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120 2009-02-14 13:12:07.322 AFD: Looking for decoder for MPEG2VIDEO 2009-02-14 13:12:07.322 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0 2009-02-14 13:12:07.322 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.322 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.322 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.322 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0 2009-02-14 13:12:07.322 AFD: subtitle codec (Subtitle) 2009-02-14 13:12:07.322 AFD: Looking for decoder for DVD_SUBTITLE 2009-02-14 13:12:07.322 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972). 2009-02-14 13:12:07.322 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bab6a30 2009-02-14 13:12:07.322 AFD: Warning, audio codec 0x7f9b0ba09430 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:12:07.322 AFD: codec AC3 has 2 channels 2009-02-14 13:12:07.322 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.322 AFD: Stream #4, has id 0x128 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a35e160 2009-02-14 13:12:07.322 AFD: Warning, audio codec 0x7f9b0a240e60 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:12:07.323 AFD: codec AC3 has 2 channels 2009-02-14 13:12:07.323 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.323 AFD: Stream #5, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a334970 2009-02-14 13:12:07.323 AFD: Warning, audio codec 0x7f9b0a35c910 id(AC3) type (Audio) already open, leaving it alone. 2009-02-14 13:12:07.323 AFD: codec AC3 has 2 channels 2009-02-14 13:12:07.323 AFD: Looking for decoder for AC3 2009-02-14 13:12:07.323 RingBuf(/dev/dvd): CalcReadAheadThresh(8076 KB) -> threshhold(64 KB) min read(32 KB) blk size(128 KB) 2009-02-14 13:12:07.323 AFD: DVD Audio Track Map Stream id #128 2009-02-14 13:12:07.323 AFD: DVD Audio Track Map Stream id #129 2009-02-14 13:12:07.323 AFD: DVD Audio Track Map Stream id #130 2009-02-14 13:12:07.323 AFD: DVD Subtitle Track Map Stream id #32 2009-02-14 13:12:07.323 AFD: DVD Subtitle Track Map Stream id #33 2009-02-14 13:12:07.323 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:12:07.323 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:12:07.324 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:12:07.324 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a436c90 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:12:07.325 Using deinterlace method greedyhdeint 2009-02-14 13:12:07.325 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:07.325 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.325 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.325 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.325 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.329 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:12:07.452 NVP(0): ClearAfterSeek(1) 2009-02-14 13:12:07.452 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:12:07.452 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:12:07.452 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.452 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.452 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.454 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:12:07.454 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:12:07.454 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2' 2009-02-14 13:12:07.454 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint' 2009-02-14 13:12:07.455 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-02-14 13:12:07.455 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a438700 greedyhdeint: size changed from 0 x 0 -> 720 x 480 2009-02-14 13:12:07.456 Using deinterlace method greedyhdeint 2009-02-14 13:12:07.456 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:07.456 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.456 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.456 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.456 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.461 VDP: LoadBestPreferences(720x480, 29.97) 2009-02-14 13:12:07.583 NVP(0): ClearAfterSeek(1) 2009-02-14 13:12:07.583 VideoOutputXv: ClearAfterSeek() 2009-02-14 13:12:07.583 VideoOutputXv: DiscardFrames(0) 2009-02-14 13:12:07.583 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:07.583 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:07.583 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:07.585 NVP(0): LoadFilters(''..) -> 0x0 2009-02-14 13:12:07.585 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan 2009-02-14 13:12:07.585 AFD: HandleGopStart: gopset not set, syncing positionMap 2009-02-14 13:12:07.585 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0) 2009-02-14 13:12:07.586 AFD: HandleGopStart: gopset not set, syncing positionMap 2009-02-14 13:12:07.586 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0) 2009-02-14 13:12:07.588 Dec: Trying to select track (w/lang) 2009-02-14 13:12:07.588 Dec: Selecting first track 2009-02-14 13:12:07.588 Dec: Selected track #1 in the Undetermined language(7695972) 2009-02-14 13:12:07.588 Dec: Trying to reselect track 2009-02-14 13:12:07.589 Dec: Selected track #1 in the Unknown language(0) 2009-02-14 13:12:07.603 NVP(0): Waiting for prebuffer.. 0 AAAAUAAUUUUuUALLAAAAAAAAAAAAAAA 2009-02-14 13:12:07.604 AFD: HandleGopStart: gopset not set, syncing positionMap 2009-02-14 13:12:07.604 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0) 2009-02-14 13:12:07.604 AFD: HandleGopStart: Initial key frame distance: 15. 2009-02-14 13:12:07.605 AFD: HandleGopStart: Key frame distance changed from 11 to 1. 2009-02-14 13:12:07.613 NVP(0): progressive frame seen after 2 interlaced frames 2009-02-14 13:12:07.613 Disabled deinterlacing 'video_output' mean = '51497.70', std. dev. = '122742.72', fps = '19.42' 2009-02-14 13:12:14.098 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2009-02-14 13:12:14.098 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2009-02-14 13:12:14.138 TV: HandleStateChange(0) -- begin 2009-02-14 13:12:14.138 TV: Attempting to change from WatchingPreRecorded to None 2009-02-14 13:12:14.138 TV: StopStuff() for player ctx 0 -- begin 2009-02-14 13:12:14.138 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2009-02-14 13:12:14.138 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2009-02-14 13:12:14.138 TV: StopStuff() -- get dvd player out of still frame or wait status 2009-02-14 13:12:14.138 TV: StopStuff(): stopping ring buffer 2009-02-14 13:12:14.138 TV: StopStuff(): stopping player 2009-02-14 13:12:14.138 TV: StopStuff() -- end 2009-02-14 13:12:14.138 TV: Changing from WatchingPreRecorded to None 2009-02-14 13:12:14.138 TV: HandleStateChange(0) -- end 2009-02-14 13:12:14.138 TV: StartTV -- process events end 2009-02-14 13:12:14.138 TV: StartTV -- process events 2 begin 2009-02-14 13:12:14.139 TV: StartTV -- process events 2 end 2009-02-14 13:12:14.139 TV::~TV() -- begin 2009-02-14 13:12:14.139 TV::~TV() -- lock 2009-02-14 13:12:14.139 TV: StopStuff() for player ctx 0 -- begin 2009-02-14 13:12:14.139 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2009-02-14 13:12:14.140 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2009-02-14 13:12:14.140 TV: StopStuff() -- get dvd player out of still frame or wait status 2009-02-14 13:12:14.140 TV: StopStuff(): stopping ring buffer 2009-02-14 13:12:14.140 TV: StopStuff(): stopping player 2009-02-14 13:12:14.140 TV: StopStuff(): stopping recorder 2009-02-14 13:12:14.140 TV: StopStuff() -- end 2009-02-14 13:12:14.150 NVP(0): Exited decoder loop. 2009-02-14 13:12:14.197 ~OpenGLVideoSync() -- closing opengl vsync 2009-02-14 13:12:14.197 VideoOutputXv: dtor 2009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): UULUUUUUUUUUUUUUUUAUUUUUUUuUUUU 2009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames(1) 2009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-02-14 13:12:14.199 GLCtx: Deleting OpenGL Resources 2009-02-14 13:12:14.202 GLCtx: Unmapping gl window 2009-02-14 13:12:14.202 GLCtx: Destroying gl window 2009-02-14 13:12:14.223 GLCtx: Destroying glx context 2009-02-14 13:12:14.223 VideoOutputXv: Closing XVideo port 355 2009-02-14 13:12:14.247 DVDRB: Clearing Menu SPU Packet 2009-02-14 13:12:14.248 TV::~TV() -- end 2009-02-14 13:12:14.248 TV: StartTV -- end 2009-02-14 13:12:17.537 Deleting UPnP client...