Ticket #6268: Superman3_Log.txt

File Superman3_Log.txt, 93.8 KB (added by Greg G. <spikeygg@…>, 15 years ago)

Superman 3 Playback Log File

Line 
12009-02-14 13:11:36.470 mythfrontend version: trunk [19996] www.mythtv.org
22009-02-14 13:11:36.471 Using runtime prefix = /usr/local
32009-02-14 13:11:37.415 Empty LocalHostName.
42009-02-14 13:11:37.415 Using localhost value of mythbox
52009-02-14 13:11:37.422 New DB connection, total: 1
62009-02-14 13:11:37.426 Connected to database 'mythconverg' at host: localhost
72009-02-14 13:11:37.426 Closing DB connection named 'DBManager0'
82009-02-14 13:11:37.457 DPMS is disabled.
92009-02-14 13:11:37.459 Primary screen: 0.
102009-02-14 13:11:37.459 Connected to database 'mythconverg' at host: localhost
112009-02-14 13:11:37.461 Using screen 0, 1920x1080 at 0,0
122009-02-14 13:11:37.498 MythUI Image Cache size set to 20971520 bytes
132009-02-14 13:11:37.498 user: 1000 effective user: 1000 before privileged thread
142009-02-14 13:11:37.499 user: 1000 effective user: 1000 after privileged thread
152009-02-14 13:11:37.499 user: 1000 effective user: 1000 run_priv_thread
162009-02-14 13:11:37.499 Enabled verbose msgs:  important general playback
172009-02-14 13:11:37.516 Connecting to lcd server: localhost:6545 (try 1 of 10)
182009-02-14 13:11:37.575 The theme (defaultmenu) is missing a themeinfo.xml file
192009-02-14 13:11:37.697 The theme (defaultmenu) is missing a themeinfo.xml file
202009-02-14 13:11:37.740 max_width: 1920 max_height: 1080
212009-02-14 13:11:37.846 Primary screen: 0.
222009-02-14 13:11:37.847 Using screen 0, 1920x1080 at 0,0
232009-02-14 13:11:37.848 Using theme base resolution of 1280x720
242009-02-14 13:11:37.856 LIRC: Successfully initialized '/dev/lircd' using '/home/spikeygg/.mythtv/lircrc' config
252009-02-14 13:11:38.040 Using the OpenGL painter
262009-02-14 13:11:38.205 Loading base theme from /usr/local/share/mythtv/themes/MythCenter-wide/base.xml
272009-02-14 13:11:38.359 Loading base theme from /usr/local/share/mythtv/themes/default-wide/base.xml
282009-02-14 13:11:38.403 Loading base theme from /usr/local/share/mythtv/themes/default/base.xml
292009-02-14 13:11:38.498 Current Schema Version: 1228
302009-02-14 13:11:38.503 Connecting to backend server: 192.168.0.10:6543 (try 1 of 5)
312009-02-14 13:11:38.504 Using protocol version 44
322009-02-14 13:11:38.596 Registering Internal as a media playback plugin.
332009-02-14 13:11:38.615 Cannot load language en_us for module mytharchive
342009-02-14 13:11:38.617 Cannot load language en_us for module mythbrowser
352009-02-14 13:11:38.618 Cannot load language en_us for module mythbookmarkmanager
362009-02-14 13:11:38.635 Cannot load language en_us for module mythgame
372009-02-14 13:11:38.744 MythMusic adding CD-Writer: ATA:0,0,0 -- DVD-E616A       
382009-02-14 13:11:38.763 MythMusic adding CD-Writer: ATAPI:0,0,0 -- DVD-E616A       
392009-02-14 13:11:38.821 MonitorRegisterExtensions(0x40, ogg,mp3,aac,flac)
402009-02-14 13:11:38.826 Cannot load language en_us for module mythmusic
412009-02-14 13:11:38.830 Cannot load language en_us for module mythnews
422009-02-14 13:11:38.866 Cannot load language en_us for module mythvideo
432009-02-14 13:11:38.872 Cannot load language en_us for module mythweather
442009-02-14 13:11:39.391 Loading window theme from /usr/local/share/mythtv/themes/MythCenter-wide/menu-ui.xml
452009-02-14 13:11:39.447 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//mainmenu.xml
462009-02-14 13:11:39.449 Found mainmenu.xml for theme 'MythCenter-wide'
472009-02-14 13:11:39.452 Using NV NPOT texture extension
482009-02-14 13:11:40.797 Loading menu theme from /usr/local/share/mythtv/themes/defaultmenu//optical_menu.xml
492009-02-14 13:11:41.839 RingBuf(dvd://dev/dvd): OpenFile(dvd://dev/dvd, 12)
502009-02-14 13:11:41.839 OpenFile() trying DVD at /dev/dvd
51libdvdnav: Using dvdnav version svnR1166
52libdvdnav: DVD Title: SUPERMAN_III
53libdvdnav: DVD Serial Number: 34F3A1FA
54libdvdnav: DVD Title (Alternative): SUPERMAN_III
55libdvdnav: Unable to find map file '/home/spikeygg/.dvdnav/SUPERMAN_III.map'
56libdvdnav: DVD disk reports itself with Region mask 0x00f00000. Regions: 1 2 3 4
572009-02-14 13:11:42.979 Opened DVD device at /dev/dvd
58libdvdnav: Suspected RCE Region Protection!!!
592009-02-14 13:11:43.114 There are 21 titles on the disk
602009-02-14 13:11:43.115 Title 0 has 0 parts.
612009-02-14 13:11:43.115 Title 1 has 39 parts.
622009-02-14 13:11:43.115 Title 2 has 1 parts.
632009-02-14 13:11:43.115 Title 3 has 1 parts.
642009-02-14 13:11:43.115 Title 4 has 1 parts.
652009-02-14 13:11:43.115 Title 5 has 1 parts.
662009-02-14 13:11:43.115 Title 6 has 11 parts.
672009-02-14 13:11:43.115 Title 7 has 1 parts.
682009-02-14 13:11:43.115 Title 8 has 1 parts.
692009-02-14 13:11:43.115 Title 9 has 1 parts.
702009-02-14 13:11:43.115 Title 10 has 1 parts.
712009-02-14 13:11:43.115 Title 11 has 1 parts.
722009-02-14 13:11:43.115 Title 12 has 1 parts.
732009-02-14 13:11:43.115 Title 13 has 1 parts.
742009-02-14 13:11:43.115 Title 14 has 1 parts.
752009-02-14 13:11:43.115 Title 15 has 1 parts.
762009-02-14 13:11:43.115 Title 16 has 1 parts.
772009-02-14 13:11:43.115 Title 17 has 1 parts.
782009-02-14 13:11:43.115 Title 18 has 1 parts.
792009-02-14 13:11:43.115 Title 19 has 1 parts.
802009-02-14 13:11:43.115 Title 20 has 1 parts.
812009-02-14 13:11:43.116 DVD Serial Number 34F3A1FA
822009-02-14 13:11:43.116 RingBuf(/dev/dvd): CalcReadAheadThresh(4000 KB)
83                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
842009-02-14 13:11:43.117 TV: StartTV() -- begin
852009-02-14 13:11:43.117 TV: ctor
862009-02-14 13:11:43.126 New DB connection, total: 2
872009-02-14 13:11:43.127 Connected to database 'mythconverg' at host: localhost
882009-02-14 13:11:43.161 TV: tv->Playback() -- begin
892009-02-14 13:11:43.165 TV: tv->Playback() -- end
902009-02-14 13:11:43.165 TV: StartTV -- process events begin
912009-02-14 13:11:43.185 TV: HandleStateChange(0) -- begin
922009-02-14 13:11:43.185 TV: Attempting to change from None to WatchingPreRecorded
932009-02-14 13:11:43.185 RingBuf(dvd://dev/dvd): OpenFile(dvd://dev/dvd, 12)
942009-02-14 13:11:43.185 OpenFile() trying DVD at /dev/dvd
95libdvdnav: Using dvdnav version svnR1166
96libdvdnav: DVD Title: SUPERMAN_III
97libdvdnav: DVD Serial Number: 34F3A1FA
98libdvdnav: DVD Title (Alternative): SUPERMAN_III
99libdvdnav: Unable to find map file '/home/spikeygg/.dvdnav/SUPERMAN_III.map'
100libdvdnav: DVD disk reports itself with Region mask 0x00f00000. Regions: 1 2 3 4
1012009-02-14 13:11:43.487 Opened DVD device at /dev/dvd
102libdvdnav: Suspected RCE Region Protection!!!
1032009-02-14 13:11:43.622 There are 21 titles on the disk
1042009-02-14 13:11:43.622 Title 0 has 0 parts.
1052009-02-14 13:11:43.622 Title 1 has 39 parts.
1062009-02-14 13:11:43.622 Title 2 has 1 parts.
1072009-02-14 13:11:43.622 Title 3 has 1 parts.
1082009-02-14 13:11:43.622 Title 4 has 1 parts.
1092009-02-14 13:11:43.622 Title 5 has 1 parts.
1102009-02-14 13:11:43.622 Title 6 has 11 parts.
1112009-02-14 13:11:43.622 Title 7 has 1 parts.
1122009-02-14 13:11:43.622 Title 8 has 1 parts.
1132009-02-14 13:11:43.622 Title 9 has 1 parts.
1142009-02-14 13:11:43.622 Title 10 has 1 parts.
1152009-02-14 13:11:43.622 Title 11 has 1 parts.
1162009-02-14 13:11:43.622 Title 12 has 1 parts.
1172009-02-14 13:11:43.622 Title 13 has 1 parts.
1182009-02-14 13:11:43.622 Title 14 has 1 parts.
1192009-02-14 13:11:43.622 Title 15 has 1 parts.
1202009-02-14 13:11:43.622 Title 16 has 1 parts.
1212009-02-14 13:11:43.622 Title 17 has 1 parts.
1222009-02-14 13:11:43.622 Title 18 has 1 parts.
1232009-02-14 13:11:43.622 Title 19 has 1 parts.
1242009-02-14 13:11:43.622 Title 20 has 1 parts.
1252009-02-14 13:11:43.622 DVD Serial Number 34F3A1FA
1262009-02-14 13:11:43.622 RingBuf(/dev/dvd): CalcReadAheadThresh(4000 KB)
127                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
1282009-02-14 13:11:43.622 TV: StartPlayer(0, WatchingPreRecorded, main) -- begin
1292009-02-14 13:11:43.844 DVDNAV_HIGHLIGHT: display==1, palette==0, sx==0, sy==0, ex==0, ey==0, pts==0, buttonN==1
1302009-02-14 13:11:43.844 DVDNAV_VTS_CHANGE: old_vtsN==0, new_vtsN==2, aspect: 3, perm: 2
1312009-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
1322009-02-14 13:11:43.844 DVDNAV_SPU_CLUT_CHANGE happened.
1332009-02-14 13:11:43.844 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128
1342009-02-14 13:11:43.844 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0
1352009-02-14 13:11:43.967 DVDNAV_HOP_CHANNEL happened.
1362009-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
1372009-02-14 13:11:43.967 DVDNAV_SPU_CLUT_CHANGE happened.
1382009-02-14 13:11:43.967 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128
1392009-02-14 13:11:43.967 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0
1402009-02-14 13:11:43.977 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
1412009-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()
1422009-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()
1432009-02-14 13:11:43.980 VDP: LoadBestPreferences(2048x2048, 0)
1442009-02-14 13:11:43.980 VDP: LoadBestPreferences(2048x2048, 60)
1452009-02-14 13:11:43.980 VDP: LoadBestPreferences(720x480, 60)
1462009-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()
1472009-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()
1482009-02-14 13:11:43.981 VDP: LoadBestPreferences(2048x2048, 0)
1492009-02-14 13:11:43.982 VDP: LoadBestPreferences(2048x2048, 60)
1502009-02-14 13:11:43.982 VDP: LoadBestPreferences(720x480, 60)
1512009-02-14 13:11:43.982 Using 1 CPUs for decoding
1522009-02-14 13:11:43.982 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
1532009-02-14 13:11:43.982 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
1542009-02-14 13:11:43.982 AFD: Using ffmpeg for video decoding
1552009-02-14 13:11:43.982 AFD: Looking for decoder for MPEG2VIDEO
1562009-02-14 13:11:43.982 AFD: Opened codec 0x7f9b09803140, id(MPEG2VIDEO) type(Video)
1572009-02-14 13:11:43.982 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB)
158                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
1592009-02-14 13:11:43.982 NVP(0): Disabling Audio, params(-1,-1,-1)
1602009-02-14 13:11:43.982 No codec context. Returning false
1612009-02-14 13:11:43.982 Dec: Trying to select track (w/lang)
1622009-02-14 13:11:43.982 Dec: Selecting first track
1632009-02-14 13:11:43.982 Dec: Selected track #1 in the Unknown language(0)
1642009-02-14 13:11:43.982 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
1652009-02-14 13:11:43.982 DVD Frame Rate 29.97
1662009-02-14 13:11:43.982 Position map filled from DB to: 359
1672009-02-14 13:11:43.982 Dec: SyncPositionMap prerecorded, from DB: 1 entries
1682009-02-14 13:11:43.982 Dec: SyncPositionMap, new totframes: 359, new length: 12, posMap size: 1
1692009-02-14 13:11:43.983 AFD: Position map found
1702009-02-14 13:11:43.983 AFD: Successfully opened decoder for file: "/dev/dvd". novideo(0)
1712009-02-14 13:11:43.987 VideoOutput: Allowed renderers: directfb,opengl,xv-blit,xshm,xlib
1722009-02-14 13:11:43.988 VideoOutput: Allowed renderers (filt: ffmpeg): xlib,xshm,directfb,xv-blit,opengl
1732009-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()
1742009-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()
1752009-02-14 13:11:43.989 VDP: LoadBestPreferences(2048x2048, 0)
1762009-02-14 13:11:43.989 VDP: LoadBestPreferences(2048x2048, 60)
1772009-02-14 13:11:43.990 VDP: LoadBestPreferences(720x480, 60)
1782009-02-14 13:11:43.990 VideoOutput: Preferred renderer: xv-blit
1792009-02-14 13:11:43.990 VideoOutput: Trying video renderer: 'xv-blit'
1802009-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()
1812009-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()
1822009-02-14 13:11:43.998 VDP: LoadBestPreferences(2048x2048, 0)
1832009-02-14 13:11:43.998 VDP: LoadBestPreferences(2048x2048, 60)
1842009-02-14 13:11:44.001 VideoOutputXv: ctor
1852009-02-14 13:11:44.001 VideoOutWindow::SetPIPState. pip_state: 0]
1862009-02-14 13:11:44.002 VideoOutputXv: Creating XJ_gc
1872009-02-14 13:11:44.002 VideoOutputXv: XJ_screen:     '0x876e90'
1882009-02-14 13:11:44.002 VideoOutputXv: XJ_screen_num: '0'
1892009-02-14 13:11:44.002 VideoOutputXv: XJ_curwin:     '31457317'
1902009-02-14 13:11:44.002 VideoOutputXv: XJ_win:        '31457317'
1912009-02-14 13:11:44.002 VideoOutputXv: XJ_root:       '422'
1922009-02-14 13:11:44.002 VideoOutputXv: XJ_gc:         '0x8ec3d0'
1932009-02-14 13:11:44.002 Display Rect  left: 0, top: 60, width: 1920, height: 960, aspect: 1.33333
1942009-02-14 13:11:44.003 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.5
1952009-02-14 13:11:44.003 VDP: LoadBestPreferences(720x480, 60)
1962009-02-14 13:11:44.007 GLCtx: Created window and GLX context.
1972009-02-14 13:11:44.007 GLCtx: GLX Version: 1.2
1982009-02-14 13:11:44.007 GLCtx: Direct rendering: Yes
1992009-02-14 13:11:44.028 GLCtx: OpenGL vendor  : NVIDIA Corporation
2002009-02-14 13:11:44.028 GLCtx: OpenGL renderer: GeForce 6200 A-LE/AGP/SSE2
2012009-02-14 13:11:44.028 GLCtx: OpenGL version : 2.1.2 NVIDIA 177.80
2022009-02-14 13:11:44.028 GLCtx: Max texture size: 4096 x 4096
2032009-02-14 13:11:44.029 VideoOutputXv Warning: GLContextCreatedWait: Waited 26 ms
2042009-02-14 13:11:44.031 VideoOutputXv: Pixel dimensions: Screen 1920x1080, window 1920x1080
2052009-02-14 13:11:44.032 VideoOutputXv: Estimated display dimensions: 610x343 mm  Aspect: 1.77843
2062009-02-14 13:11:44.032 VideoOutputXv: Estimated window dimensions: 610x343 mm  Aspect: 1.77843
2072009-02-14 13:11:44.033 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: opengl,xv-blit,xshm,xlib
2082009-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()
2092009-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()
2102009-02-14 13:11:44.037 VDP: LoadBestPreferences(2048x2048, 0)
2112009-02-14 13:11:44.037 VDP: LoadBestPreferences(2048x2048, 60)
2122009-02-14 13:11:44.037 VDP: LoadBestPreferences(720x480, 60)
2132009-02-14 13:11:44.038 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  10
2142009-02-14 13:11:44.038 VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask
2152009-02-14 13:11:44.038 VideoOutputXv: Has XVideo flags...
2162009-02-14 13:11:44.038 VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2172009-02-14 13:11:44.038 VideoOutputXv: Adaptor#1: NV05 Video Blitter has flag[s]: XvInputMask XvImageMask
2182009-02-14 13:11:44.038 VideoOutputXv: Has XVideo flags...
2192009-02-14 13:11:44.038 VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2202009-02-14 13:11:44.038 VideoOutputXv: @ j=1 Looking for flag[s]: XvInputMask XvImageMask  0
2212009-02-14 13:11:44.038 VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask
2222009-02-14 13:11:44.038 VideoOutputXv: Has XVideo flags...
2232009-02-14 13:11:44.038 VideoOutputXv: Here...
2242009-02-14 13:11:44.039 VideoOutputXv: Grabbed xv port 355
2252009-02-14 13:11:44.039 VideoOutputXv: XVideo surface found on port 355
2262009-02-14 13:11:44.039 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2272009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #0 is 'YUY2'
2282009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #1 is 'YV12'
2292009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #2 is 'UYVY'
2302009-02-14 13:11:44.039 VideoOutputXv: XVideo Format #3 is 'I420'
2312009-02-14 13:11:44.039 VideoOutputXv: Using XVideo Format 'YV12'
2322009-02-14 13:11:44.039 VideoOutputXv: CreateShmImages(32): video_dim: 720x480
2332009-02-14 13:11:44.063 VDP: SetVideoRenderer(xv-blit)
2342009-02-14 13:11:44.063 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2352009-02-14 13:11:44.063 VideoOutputXv: Chromakeying not possible with this XVideo port.
2362009-02-14 13:11:44.063 Display Rect  left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778
2372009-02-14 13:11:44.063 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.5
2382009-02-14 13:11:44.063 Over/underscan. V: 0, H: 0
2392009-02-14 13:11:44.063 Display Rect  left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778
2402009-02-14 13:11:44.064 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.5
2412009-02-14 13:11:44.064 VDP: LoadBestPreferences(720x480, 29.97)
2422009-02-14 13:11:44.064 NVP(0): LoadFilters(''..) -> 0x0
2432009-02-14 13:11:44.066 OSD Theme Dimensions W: 640 H: 480
2442009-02-14 13:11:44.351 NVP(0): ClearAfterSeek(1)
2452009-02-14 13:11:44.351 playCtx: StartDecoderThread(): took 367 ms to start player.
2462009-02-14 13:11:44.351 VideoOutputXv: ClearAfterSeek()
2472009-02-14 13:11:44.351 VideoOutputXv: DiscardFrames(0)
2482009-02-14 13:11:44.351 TV: StartPlayer(0, WatchingPreRecorded, main) -- end ok
2492009-02-14 13:11:44.351 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2502009-02-14 13:11:44.352 TV: Changing from None to WatchingPreRecorded
2512009-02-14 13:11:44.352 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2522009-02-14 13:11:44.352 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2532009-02-14 13:11:44.352 TV: HandleStateChange(0) -- end
2542009-02-14 13:11:44.354 No codec context. Returning false
2552009-02-14 13:11:44.354 AFD: DVD Title Changed
2562009-02-14 13:11:44.354 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2572009-02-14 13:11:44.355 DVD Frame Rate 29.97
2582009-02-14 13:11:44.355 Position map filled from DB to: 359
2592009-02-14 13:11:44.355 Dec: SyncPositionMap prerecorded, from DB: 1 entries
2602009-02-14 13:11:44.355 Dec: SyncPositionMap, new totframes: 359, new length: 12, posMap size: 1
2612009-02-14 13:11:44.355 AFD: DVD Cell Changed. Update framesPlayed: 0
2622009-02-14 13:11:44.355 DVDNAV_HOP_CHANNEL happened.
2632009-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
2642009-02-14 13:11:44.355 DVDNAV_SPU_CLUT_CHANGE happened.
2652009-02-14 13:11:44.355 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128
2662009-02-14 13:11:44.355 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0
2672009-02-14 13:11:44.355 AFD: DVD Cell Changed. Update framesPlayed: 0
2682009-02-14 13:11:44.355 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
2692009-02-14 13:11:44.355 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
2702009-02-14 13:11:44.357 FilterManager: GetFilterInfo(convert) returning: 0x0
2712009-02-14 13:11:44.357 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a7300f0
272greedyhdeint: size changed from 0 x 0 -> 720 x 480
2732009-02-14 13:11:44.360 Using deinterlace method greedyhdeint
2742009-02-14 13:11:44.360 VideoOutputXv: DiscardFrames(1)
2752009-02-14 13:11:44.360 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2762009-02-14 13:11:44.360 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2772009-02-14 13:11:44.360 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2782009-02-14 13:11:44.360 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2792009-02-14 13:11:44.369 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2802009-02-14 13:11:44.370 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.77778
2812009-02-14 13:11:44.373 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2822009-02-14 13:11:44.373 OpenGLVideoSync()
2832009-02-14 13:11:44.396 Using audio as timebase
2842009-02-14 13:11:44.396 Video timing method: SGI OpenGL
2852009-02-14 13:11:44.396 Refresh rate: 16666, frame interval: 33366
2862009-02-14 13:11:44.413 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2872009-02-14 13:11:44.496 NVP(0): ClearAfterSeek(1)
2882009-02-14 13:11:44.496 VideoOutputXv: ClearAfterSeek()
2892009-02-14 13:11:44.496 VideoOutputXv: DiscardFrames(0)
2902009-02-14 13:11:44.497 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2912009-02-14 13:11:44.497 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2922009-02-14 13:11:44.497 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2932009-02-14 13:11:44.497 NVP(0): LoadFilters(''..) -> 0x0
2942009-02-14 13:11:44.497 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
2952009-02-14 13:11:44.497 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 2
2962009-02-14 13:11:44.497 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
2972009-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()
2982009-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()
2992009-02-14 13:11:44.499 VDP: LoadBestPreferences(2048x2048, 0)
3002009-02-14 13:11:44.499 VDP: LoadBestPreferences(2048x2048, 60)
3012009-02-14 13:11:44.499 VDP: LoadBestPreferences(720x480, 60)
3022009-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()
3032009-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()
3042009-02-14 13:11:44.501 VDP: LoadBestPreferences(2048x2048, 0)
3052009-02-14 13:11:44.502 VDP: LoadBestPreferences(2048x2048, 60)
3062009-02-14 13:11:44.502 VDP: LoadBestPreferences(720x480, 60)
3072009-02-14 13:11:44.502 Using 1 CPUs for decoding
3082009-02-14 13:11:44.502 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
3092009-02-14 13:11:44.502 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
3102009-02-14 13:11:44.502 VideoOutputXv: InputChanged(720,480,1.5) 'MPEG2'->'MPEG2'
3112009-02-14 13:11:44.502 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
3122009-02-14 13:11:44.503 FilterManager: GetFilterInfo(convert) returning: 0x0
3132009-02-14 13:11:44.503 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a730870
314greedyhdeint: size changed from 0 x 0 -> 720 x 480
3152009-02-14 13:11:44.503 Using deinterlace method greedyhdeint
3162009-02-14 13:11:44.503 VideoOutputXv: DiscardFrames(1)
3172009-02-14 13:11:44.503 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3182009-02-14 13:11:44.504 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3192009-02-14 13:11:44.504 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3202009-02-14 13:11:44.504 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3212009-02-14 13:11:44.508 Display Rect  left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778
3222009-02-14 13:11:44.508 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.5
3232009-02-14 13:11:44.562 NVP(0): Waiting for prebuffer..  1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3242009-02-14 13:11:44.628 NVP(0): ClearAfterSeek(1)
3252009-02-14 13:11:44.628 VideoOutputXv: ClearAfterSeek()
3262009-02-14 13:11:44.628 VideoOutputXv: DiscardFrames(0)
3272009-02-14 13:11:44.628 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3282009-02-14 13:11:44.628 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3292009-02-14 13:11:44.628 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3302009-02-14 13:11:44.628 NVP(0): LoadFilters(''..) -> 0x0
3312009-02-14 13:11:44.629 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
3322009-02-14 13:11:44.629 AFD: Using ffmpeg for video decoding
3332009-02-14 13:11:44.629 AFD: Looking for decoder for MPEG2VIDEO
3342009-02-14 13:11:44.629 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a4353c0
3352009-02-14 13:11:44.629 AFD: codec AC3 has 0 channels
3362009-02-14 13:11:44.629 AFD: Looking for decoder for AC3
3372009-02-14 13:11:44.629 AFD: Opened codec 0x7f9b0a02afa0, id(AC3) type(Audio)
3382009-02-14 13:11:44.629 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB)
339                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
3402009-02-14 13:11:44.632 Opening audio device 'default'. ch 2(2) sr 48000
3412009-02-14 13:11:44.632 Opening ALSA audio device 'default'.
3422009-02-14 13:11:44.640 NVP(0): Enabling Audio
3432009-02-14 13:11:44.642 Opening audio device 'default'. ch 2(2) sr 48000
3442009-02-14 13:11:44.642 Opening ALSA audio device 'default'.
3452009-02-14 13:11:44.644 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 3
3462009-02-14 13:11:44.644 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
3472009-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()
3482009-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()
3492009-02-14 13:11:44.646 VDP: LoadBestPreferences(2048x2048, 0)
3502009-02-14 13:11:44.646 VDP: LoadBestPreferences(2048x2048, 60)
3512009-02-14 13:11:44.646 VDP: LoadBestPreferences(720x480, 60)
3522009-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()
3532009-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()
3542009-02-14 13:11:44.647 VDP: LoadBestPreferences(2048x2048, 0)
3552009-02-14 13:11:44.647 VDP: LoadBestPreferences(2048x2048, 60)
3562009-02-14 13:11:44.647 VDP: LoadBestPreferences(720x480, 60)
3572009-02-14 13:11:44.648 Using 1 CPUs for decoding
3582009-02-14 13:11:44.648 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
3592009-02-14 13:11:44.648 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
3602009-02-14 13:11:44.648 AFD: Using ffmpeg for video decoding
3612009-02-14 13:11:44.648 AFD: Looking for decoder for MPEG2VIDEO
3622009-02-14 13:11:44.648 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a4353c0
3632009-02-14 13:11:44.648 AFD: Warning, audio codec 0x7f9b0a02afa0 id(AC3) type (Audio) already open, leaving it alone.
3642009-02-14 13:11:44.648 AFD: codec AC3 has 2 channels
3652009-02-14 13:11:44.648 AFD: Looking for decoder for AC3
3662009-02-14 13:11:44.648 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0bf9b790
3672009-02-14 13:11:44.648 AFD: codec AC3 has 0 channels
3682009-02-14 13:11:44.648 AFD: Looking for decoder for AC3
3692009-02-14 13:11:44.648 AFD: Opened codec 0x7f9b0bf9b940, id(AC3) type(Audio)
3702009-02-14 13:11:44.648 RingBuf(/dev/dvd): CalcReadAheadThresh(7692 KB)
371                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
3722009-02-14 13:11:44.649 AFD: DVD Audio Track Map Stream id #129
3732009-02-14 13:11:44.649 AFD: DVD Audio Track Map Stream id #130
3742009-02-14 13:11:44.650 Opening audio device 'default'. ch 2(2) sr 48000
3752009-02-14 13:11:44.650 Opening ALSA audio device 'default'.
3762009-02-14 13:11:44.652 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4
3772009-02-14 13:11:44.652 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
3782009-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()
3792009-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()
3802009-02-14 13:11:44.653 VDP: LoadBestPreferences(2048x2048, 0)
3812009-02-14 13:11:44.653 VDP: LoadBestPreferences(2048x2048, 60)
3822009-02-14 13:11:44.654 VDP: LoadBestPreferences(720x480, 60)
3832009-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()
3842009-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()
3852009-02-14 13:11:44.655 VDP: LoadBestPreferences(2048x2048, 0)
3862009-02-14 13:11:44.655 VDP: LoadBestPreferences(2048x2048, 60)
3872009-02-14 13:11:44.655 VDP: LoadBestPreferences(720x480, 60)
3882009-02-14 13:11:44.655 Using 1 CPUs for decoding
3892009-02-14 13:11:44.655 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
3902009-02-14 13:11:44.655 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
3912009-02-14 13:11:44.655 AFD: Using ffmpeg for video decoding
3922009-02-14 13:11:44.656 AFD: Looking for decoder for MPEG2VIDEO
3932009-02-14 13:11:44.656 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a4353c0
3942009-02-14 13:11:44.656 AFD: Warning, audio codec 0x7f9b0a02afa0 id(AC3) type (Audio) already open, leaving it alone.
3952009-02-14 13:11:44.656 AFD: codec AC3 has 2 channels
3962009-02-14 13:11:44.656 AFD: Looking for decoder for AC3
3972009-02-14 13:11:44.656 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf9b790
3982009-02-14 13:11:44.656 AFD: Warning, audio codec 0x7f9b0bf9b940 id(AC3) type (Audio) already open, leaving it alone.
3992009-02-14 13:11:44.656 AFD: codec AC3 has 2 channels
4002009-02-14 13:11:44.656 AFD: Looking for decoder for AC3
4012009-02-14 13:11:44.656 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a792a70
4022009-02-14 13:11:44.656 AFD: codec AC3 has 0 channels
4032009-02-14 13:11:44.656 AFD: Looking for decoder for AC3
4042009-02-14 13:11:44.656 AFD: Opened codec 0x7f9b0a792c20, id(AC3) type(Audio)
4052009-02-14 13:11:44.656 RingBuf(/dev/dvd): CalcReadAheadThresh(7884 KB)
406                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
4072009-02-14 13:11:44.656 AFD: DVD Audio Track Map Stream id #128
4082009-02-14 13:11:44.656 AFD: DVD Audio Track Map Stream id #129
4092009-02-14 13:11:44.656 AFD: DVD Audio Track Map Stream id #130
4102009-02-14 13:11:44.657 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
4112009-02-14 13:11:44.657 AFD: Looking for decoder for MPEG2VIDEO
4122009-02-14 13:11:44.657 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a4353c0
4132009-02-14 13:11:44.657 AFD: Warning, audio codec 0x7f9b0a02afa0 id(AC3) type (Audio) already open, leaving it alone.
4142009-02-14 13:11:44.657 AFD: codec AC3 has 2 channels
4152009-02-14 13:11:44.657 AFD: Looking for decoder for AC3
4162009-02-14 13:11:44.657 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf9b790
4172009-02-14 13:11:44.657 AFD: Warning, audio codec 0x7f9b0bf9b940 id(AC3) type (Audio) already open, leaving it alone.
4182009-02-14 13:11:44.657 AFD: codec AC3 has 2 channels
4192009-02-14 13:11:44.657 AFD: Looking for decoder for AC3
4202009-02-14 13:11:44.657 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a792a70
4212009-02-14 13:11:44.657 AFD: Warning, audio codec 0x7f9b0a792c20 id(AC3) type (Audio) already open, leaving it alone.
4222009-02-14 13:11:44.657 AFD: codec AC3 has 2 channels
4232009-02-14 13:11:44.657 AFD: Looking for decoder for AC3
4242009-02-14 13:11:44.657 RingBuf(/dev/dvd): CalcReadAheadThresh(8076 KB)
425                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
4262009-02-14 13:11:44.657 AFD: DVD Audio Track Map Stream id #128
4272009-02-14 13:11:44.657 AFD: DVD Audio Track Map Stream id #129
4282009-02-14 13:11:44.657 AFD: DVD Audio Track Map Stream id #130
4292009-02-14 13:11:44.658 VideoOutputXv: InputChanged(720,480,1.33333) 'MPEG2'->'MPEG2'
4302009-02-14 13:11:44.658 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
4312009-02-14 13:11:44.660 FilterManager: GetFilterInfo(convert) returning: 0x0
4322009-02-14 13:11:44.660 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf9aca0
433greedyhdeint: size changed from 0 x 0 -> 720 x 480
4342009-02-14 13:11:44.660 Using deinterlace method greedyhdeint
4352009-02-14 13:11:44.660 VideoOutputXv: DiscardFrames(1)
4362009-02-14 13:11:44.660 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4372009-02-14 13:11:44.660 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4382009-02-14 13:11:44.660 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4392009-02-14 13:11:44.660 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4402009-02-14 13:11:44.665 Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
4412009-02-14 13:11:44.665 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
4422009-02-14 13:11:44.665 VDP: LoadBestPreferences(720x480, 29.97)
4432009-02-14 13:11:44.712 NVP(0): Waiting for prebuffer..  2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4442009-02-14 13:11:44.789 NVP(0): ClearAfterSeek(1)
4452009-02-14 13:11:44.789 VideoOutputXv: ClearAfterSeek()
4462009-02-14 13:11:44.789 VideoOutputXv: DiscardFrames(0)
4472009-02-14 13:11:44.789 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4482009-02-14 13:11:44.790 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4492009-02-14 13:11:44.790 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4502009-02-14 13:11:44.790 NVP(0): LoadFilters(''..) -> 0x0
4512009-02-14 13:11:44.790 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
4522009-02-14 13:11:44.790 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
4532009-02-14 13:11:44.790 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
4542009-02-14 13:11:44.791 FilterManager: GetFilterInfo(convert) returning: 0x0
4552009-02-14 13:11:44.791 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf911c0
456greedyhdeint: size changed from 0 x 0 -> 720 x 480
4572009-02-14 13:11:44.791 Using deinterlace method greedyhdeint
4582009-02-14 13:11:44.791 VideoOutputXv: DiscardFrames(1)
4592009-02-14 13:11:44.791 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4602009-02-14 13:11:44.791 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4612009-02-14 13:11:44.792 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4622009-02-14 13:11:44.792 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4632009-02-14 13:11:44.796 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
4642009-02-14 13:11:44.796 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.77778
4652009-02-14 13:11:44.797 VDP: LoadBestPreferences(720x480, 29.97)
4662009-02-14 13:11:44.863 NVP(0): Waiting for prebuffer..  3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4672009-02-14 13:11:44.921 NVP(0): ClearAfterSeek(1)
4682009-02-14 13:11:44.921 VideoOutputXv: ClearAfterSeek()
4692009-02-14 13:11:44.921 VideoOutputXv: DiscardFrames(0)
4702009-02-14 13:11:44.921 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4712009-02-14 13:11:44.921 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4722009-02-14 13:11:44.921 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4732009-02-14 13:11:44.921 NVP(0): LoadFilters(''..) -> 0x0
4742009-02-14 13:11:44.921 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
4752009-02-14 13:11:44.923 Dec: Trying to reselect track
4762009-02-14 13:11:44.924 Dec: Selected track #1 in the Unknown language(0)
4772009-02-14 13:11:44.932 AFD: HandleGopStart: gopset not set, syncing positionMap
4782009-02-14 13:11:44.932 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
4792009-02-14 13:11:44.932 AFD: HandleGopStart: Initial key frame distance: 15.
4802009-02-14 13:11:44.933 AFD: HandleGopStart: Key frame distance changed from 14 to 1.
481'video_output' mean = '32875.06', std. dev. = '3232.32', fps = '30.42'
482'video_output' mean = '33332.36', std. dev. = '143.53', fps = '30.00'
483'video_output' mean = '33329.99', std. dev. = '159.86', fps = '30.00'
4842009-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
4852009-02-14 13:11:55.766 DVDNAV_SPU_CLUT_CHANGE happened.
4862009-02-14 13:11:55.766 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==128, physical_pan_scan==128, current_track==-128
4872009-02-14 13:11:55.766 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0
4882009-02-14 13:11:55.826 AFD: DVD Title Changed
4892009-02-14 13:11:55.828 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
4902009-02-14 13:11:55.828 DVD Frame Rate 29.97
4912009-02-14 13:11:55.828 Position map filled from DB to: 359
4922009-02-14 13:11:55.828 Dec: SyncPositionMap prerecorded, from DB: 1 entries
4932009-02-14 13:11:55.828 Dec: SyncPositionMap, new totframes: 359, new length: 12, posMap size: 1
4942009-02-14 13:11:55.828 AFD: DVD Cell Changed. Update framesPlayed: 0
4952009-02-14 13:11:55.842 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
4962009-02-14 13:11:55.842 AFD: Looking for decoder for MPEG2VIDEO
4972009-02-14 13:11:55.842 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB)
498                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
4992009-02-14 13:11:55.842 NVP(0): Disabling Audio, params(-1,-1,-1)
5002009-02-14 13:11:55.844 VideoOutputXv: InputChanged(720,480,1.33333) 'MPEG2'->'MPEG2'
5012009-02-14 13:11:55.845 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
5022009-02-14 13:11:55.846 FilterManager: GetFilterInfo(convert) returning: 0x0
5032009-02-14 13:11:55.846 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a605930
504greedyhdeint: size changed from 0 x 0 -> 720 x 480
5052009-02-14 13:11:55.846 Using deinterlace method greedyhdeint
5062009-02-14 13:11:55.846 VideoOutputXv: DiscardFrames(1)
5072009-02-14 13:11:55.846 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUUUUUUUUUUuUULAAAUU
5082009-02-14 13:11:55.846 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5092009-02-14 13:11:55.846 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5102009-02-14 13:11:55.846 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5112009-02-14 13:11:55.851 Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
5122009-02-14 13:11:55.851 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
5132009-02-14 13:11:55.851 VDP: LoadBestPreferences(720x480, 29.97)
5142009-02-14 13:11:55.868 NVP(0): prebuffering pause
5152009-02-14 13:11:55.868 NVP(0): Waiting for prebuffer..  0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5162009-02-14 13:11:55.975 NVP(0): ClearAfterSeek(1)
5172009-02-14 13:11:55.975 VideoOutputXv: ClearAfterSeek()
5182009-02-14 13:11:55.975 VideoOutputXv: DiscardFrames(0)
5192009-02-14 13:11:55.975 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5202009-02-14 13:11:55.975 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5212009-02-14 13:11:55.975 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5222009-02-14 13:11:55.975 NVP(0): LoadFilters(''..) -> 0x0
5232009-02-14 13:11:55.975 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
5242009-02-14 13:11:55.976 No codec context. Returning false
5252009-02-14 13:11:55.977 Dec: Trying to reselect track
5262009-02-14 13:11:55.977 Dec: Selected track #1 in the Unknown language(0)
5272009-02-14 13:11:55.978 No codec context. Returning false
5282009-02-14 13:11:55.979 No codec context. Returning false
5292009-02-14 13:11:55.980 No codec context. Returning false
5302009-02-14 13:11:55.981 No codec context. Returning false
5312009-02-14 13:11:55.982 No codec context. Returning false
5322009-02-14 13:11:55.983 No codec context. Returning false
5332009-02-14 13:11:55.984 No codec context. Returning false
5342009-02-14 13:11:55.985 No codec context. Returning false
5352009-02-14 13:11:55.986 No codec context. Returning false
5362009-02-14 13:11:55.986 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 2
5372009-02-14 13:11:55.986 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
5382009-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()
5392009-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()
5402009-02-14 13:11:55.988 VDP: LoadBestPreferences(2048x2048, 0)
5412009-02-14 13:11:55.988 VDP: LoadBestPreferences(2048x2048, 60)
5422009-02-14 13:11:55.988 VDP: LoadBestPreferences(720x480, 60)
5432009-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()
5442009-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()
5452009-02-14 13:11:55.990 VDP: LoadBestPreferences(2048x2048, 0)
5462009-02-14 13:11:55.990 VDP: LoadBestPreferences(2048x2048, 60)
5472009-02-14 13:11:55.990 VDP: LoadBestPreferences(720x480, 60)
5482009-02-14 13:11:55.990 Using 1 CPUs for decoding
5492009-02-14 13:11:55.990 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
5502009-02-14 13:11:55.990 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
5512009-02-14 13:11:55.990 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
5522009-02-14 13:11:55.990 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
5532009-02-14 13:11:55.991 FilterManager: GetFilterInfo(convert) returning: 0x0
5542009-02-14 13:11:55.991 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a7304a0
555greedyhdeint: size changed from 0 x 0 -> 720 x 480
5562009-02-14 13:11:55.992 Using deinterlace method greedyhdeint
5572009-02-14 13:11:55.992 VideoOutputXv: DiscardFrames(1)
5582009-02-14 13:11:55.992 VideoBuffers::DiscardFrames(1): UUuUALAAAAAAAAAAAAAAAAAAA(AU)UUUUU
5592009-02-14 13:11:55.992 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5602009-02-14 13:11:55.992 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5612009-02-14 13:11:55.992 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5622009-02-14 13:11:55.997 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
5632009-02-14 13:11:55.997 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.77778
5642009-02-14 13:11:55.997 VDP: LoadBestPreferences(720x480, 29.97)
5652009-02-14 13:11:56.013 NVP(0): Waiting for prebuffer..  1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5662009-02-14 13:11:56.119 NVP(0): ClearAfterSeek(1)
5672009-02-14 13:11:56.119 VideoOutputXv: ClearAfterSeek()
5682009-02-14 13:11:56.119 VideoOutputXv: DiscardFrames(0)
5692009-02-14 13:11:56.119 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5702009-02-14 13:11:56.119 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5712009-02-14 13:11:56.120 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5722009-02-14 13:11:56.120 NVP(0): LoadFilters(''..) -> 0x0
5732009-02-14 13:11:56.120 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
5742009-02-14 13:11:56.120 AFD: Using ffmpeg for video decoding
5752009-02-14 13:11:56.120 AFD: Looking for decoder for MPEG2VIDEO
5762009-02-14 13:11:56.120 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0bf94fd0
5772009-02-14 13:11:56.120 AFD: codec AC3 has 0 channels
5782009-02-14 13:11:56.120 AFD: Looking for decoder for AC3
5792009-02-14 13:11:56.120 AFD: Opened codec 0x7f9b0bf94770, id(AC3) type(Audio)
5802009-02-14 13:11:56.120 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB)
581                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
5822009-02-14 13:11:56.121 Opening audio device 'default'. ch 2(2) sr 48000
5832009-02-14 13:11:56.121 Opening ALSA audio device 'default'.
5842009-02-14 13:11:56.122 NVP(0): Enabling Audio
5852009-02-14 13:11:56.125 Opening audio device 'default'. ch 2(2) sr 48000
5862009-02-14 13:11:56.125 Opening ALSA audio device 'default'.
5872009-02-14 13:11:56.127 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 3
5882009-02-14 13:11:56.127 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
5892009-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()
5902009-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()
5912009-02-14 13:11:56.129 VDP: LoadBestPreferences(2048x2048, 0)
5922009-02-14 13:11:56.129 VDP: LoadBestPreferences(2048x2048, 60)
5932009-02-14 13:11:56.129 VDP: LoadBestPreferences(720x480, 60)
5942009-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()
5952009-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()
5962009-02-14 13:11:56.131 VDP: LoadBestPreferences(2048x2048, 0)
5972009-02-14 13:11:56.131 VDP: LoadBestPreferences(2048x2048, 60)
5982009-02-14 13:11:56.131 VDP: LoadBestPreferences(720x480, 60)
5992009-02-14 13:11:56.131 Using 1 CPUs for decoding
6002009-02-14 13:11:56.131 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
6012009-02-14 13:11:56.131 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
6022009-02-14 13:11:56.131 AFD: Using ffmpeg for video decoding
6032009-02-14 13:11:56.131 AFD: Looking for decoder for MPEG2VIDEO
6042009-02-14 13:11:56.131 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf94fd0
6052009-02-14 13:11:56.131 AFD: Warning, audio codec 0x7f9b0bf94770 id(AC3) type (Audio) already open, leaving it alone.
6062009-02-14 13:11:56.131 AFD: codec AC3 has 2 channels
6072009-02-14 13:11:56.131 AFD: Looking for decoder for AC3
6082009-02-14 13:11:56.131 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a32a870
6092009-02-14 13:11:56.131 AFD: codec AC3 has 0 channels
6102009-02-14 13:11:56.131 AFD: Looking for decoder for AC3
6112009-02-14 13:11:56.132 AFD: Opened codec 0x7f9b0a32aa20, id(AC3) type(Audio)
6122009-02-14 13:11:56.132 RingBuf(/dev/dvd): CalcReadAheadThresh(7692 KB)
613                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
6142009-02-14 13:11:56.132 AFD: DVD Audio Track Map Stream id #129
6152009-02-14 13:11:56.132 AFD: DVD Audio Track Map Stream id #130
6162009-02-14 13:11:56.133 Opening audio device 'default'. ch 2(2) sr 48000
6172009-02-14 13:11:56.133 Opening ALSA audio device 'default'.
6182009-02-14 13:11:56.134 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4
6192009-02-14 13:11:56.134 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
6202009-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()
6212009-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()
6222009-02-14 13:11:56.136 VDP: LoadBestPreferences(2048x2048, 0)
6232009-02-14 13:11:56.136 VDP: LoadBestPreferences(2048x2048, 60)
6242009-02-14 13:11:56.136 VDP: LoadBestPreferences(720x480, 60)
6252009-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()
6262009-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()
6272009-02-14 13:11:56.138 VDP: LoadBestPreferences(2048x2048, 0)
6282009-02-14 13:11:56.138 VDP: LoadBestPreferences(2048x2048, 60)
6292009-02-14 13:11:56.138 VDP: LoadBestPreferences(720x480, 60)
6302009-02-14 13:11:56.138 Using 1 CPUs for decoding
6312009-02-14 13:11:56.138 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
6322009-02-14 13:11:56.138 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
6332009-02-14 13:11:56.138 AFD: Using ffmpeg for video decoding
6342009-02-14 13:11:56.138 AFD: Looking for decoder for MPEG2VIDEO
6352009-02-14 13:11:56.138 AFD: Stream #1, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bf94fd0
6362009-02-14 13:11:56.138 AFD: Warning, audio codec 0x7f9b0bf94770 id(AC3) type (Audio) already open, leaving it alone.
6372009-02-14 13:11:56.138 AFD: codec AC3 has 2 channels
6382009-02-14 13:11:56.138 AFD: Looking for decoder for AC3
6392009-02-14 13:11:56.139 AFD: Stream #2, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a32a870
6402009-02-14 13:11:56.139 AFD: Warning, audio codec 0x7f9b0a32aa20 id(AC3) type (Audio) already open, leaving it alone.
6412009-02-14 13:11:56.139 AFD: codec AC3 has 2 channels
6422009-02-14 13:11:56.139 AFD: Looking for decoder for AC3
6432009-02-14 13:11:56.139 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a5ec370
6442009-02-14 13:11:56.139 AFD: codec AC3 has 0 channels
6452009-02-14 13:11:56.139 AFD: Looking for decoder for AC3
6462009-02-14 13:11:56.139 AFD: Opened codec 0x7f9b0a5ec520, id(AC3) type(Audio)
6472009-02-14 13:11:56.139 RingBuf(/dev/dvd): CalcReadAheadThresh(7884 KB)
648                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
6492009-02-14 13:11:56.139 AFD: DVD Audio Track Map Stream id #128
6502009-02-14 13:11:56.139 AFD: DVD Audio Track Map Stream id #129
6512009-02-14 13:11:56.139 AFD: DVD Audio Track Map Stream id #130
6522009-02-14 13:11:56.141 Dec: Trying to reselect track
6532009-02-14 13:11:56.141 Dec: Selected track #1 in the Unknown language(0)
6542009-02-14 13:11:56.141 AFD: HandleGopStart: Key frame distance changed from 15 to 11.
6552009-02-14 13:11:56.142 AFD: HandleGopStart: Key frame distance changed from 11 to 1.
6562009-02-14 13:11:56.163 NVP(0): progressive frame seen after 2 interlaced  frames
6572009-02-14 13:11:56.163 Disabled deinterlacing
6582009-02-14 13:11:56.177 GetNextFreeFrame() served a busy frame F. Dropping. UUAUUUUUUUUUUUUUUUUUUUUUUUUUULU
6592009-02-14 13:11:57.813 NVP(0): interlaced frame seen after 46 progressive frames
6602009-02-14 13:11:57.813 Enabled deinterlacing
661'video_output' mean = '37997.67', std. dev. = '28949.78', fps = '26.32'
662'video_output' mean = '33330.19', std. dev. = '126.69', fps = '30.00'
663'video_output' mean = '33330.13', std. dev. = '5145.69', fps = '30.00'
6642009-02-14 13:12:05.863 NVP(0): progressive frame seen after 242 interlaced  frames
6652009-02-14 13:12:05.864 Disabled deinterlacing
6662009-02-14 13:12:06.314 DVDNAV_VTS_CHANGE: old_vtsN==2, new_vtsN==2, aspect: 3, perm: 1
6672009-02-14 13:12:06.314 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
6682009-02-14 13:12:06.314 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.77778
6692009-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
6702009-02-14 13:12:06.314 DVDNAV_SPU_CLUT_CHANGE happened.
6712009-02-14 13:12:06.314 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==1, current_track==0
6722009-02-14 13:12:06.314 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0
6732009-02-14 13:12:06.314 AFD: DVD Title Changed
6742009-02-14 13:12:06.314 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
6752009-02-14 13:12:06.314 DVD Frame Rate 29.97
6762009-02-14 13:12:06.314 Position map filled from DB to: 2037
6772009-02-14 13:12:06.314 Dec: SyncPositionMap prerecorded, from DB: 1 entries
6782009-02-14 13:12:06.314 Dec: SyncPositionMap, new totframes: 2037, new length: 68, posMap size: 1
6792009-02-14 13:12:06.314 AFD: DVD Cell Changed. Update framesPlayed: 0
6802009-02-14 13:12:06.315 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
6812009-02-14 13:12:06.315 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
6822009-02-14 13:12:06.316 FilterManager: GetFilterInfo(convert) returning: 0x0
6832009-02-14 13:12:06.317 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf9ac30
684greedyhdeint: size changed from 0 x 0 -> 720 x 480
6852009-02-14 13:12:06.317 Using deinterlace method greedyhdeint
6862009-02-14 13:12:06.317 VideoOutputXv: DiscardFrames(1)
6872009-02-14 13:12:06.317 VideoBuffers::DiscardFrames(1): UULAUUUUUUUUUUUUUUUUUUUUUUUUUuU
6882009-02-14 13:12:06.317 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6892009-02-14 13:12:06.317 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6902009-02-14 13:12:06.317 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6912009-02-14 13:12:06.366 NVP(0), Error: In DVD Menu: No video frames in queue
6922009-02-14 13:12:06.376 NVP(0), Error: In DVD Menu: No video frames in queue
6932009-02-14 13:12:06.386 NVP(0), Error: In DVD Menu: No video frames in queue
6942009-02-14 13:12:06.396 NVP(0), Error: In DVD Menu: No video frames in queue
6952009-02-14 13:12:06.406 NVP(0), Error: In DVD Menu: No video frames in queue
6962009-02-14 13:12:06.417 NVP(0), Error: In DVD Menu: No video frames in queue
6972009-02-14 13:12:06.427 NVP(0), Error: In DVD Menu: No video frames in queue
6982009-02-14 13:12:06.437 NVP(0), Error: In DVD Menu: No video frames in queue
6992009-02-14 13:12:06.446 NVP(0): ClearAfterSeek(1)
7002009-02-14 13:12:06.446 VideoOutputXv: ClearAfterSeek()
7012009-02-14 13:12:06.446 VideoOutputXv: DiscardFrames(0)
7022009-02-14 13:12:06.446 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7032009-02-14 13:12:06.446 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7042009-02-14 13:12:06.446 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7052009-02-14 13:12:06.446 NVP(0): LoadFilters(''..) -> 0x0
7062009-02-14 13:12:06.446 detectInterlace(Detect Scan, Progressive Scan, 29.97, 480) ->Interlaced Scan
7072009-02-14 13:12:06.446 Enabled deinterlacing
7082009-02-14 13:12:06.446 Entering DVD Still Frame
7092009-02-14 13:12:06.446 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120
7102009-02-14 13:12:06.446 AFD: Looking for decoder for MPEG2VIDEO
7112009-02-14 13:12:06.446 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB)
712                         -> threshhold(64 KB) min read(32 KB) blk size(256 KB)
7132009-02-14 13:12:06.446 NVP(0): Disabling Audio, params(-1,-1,-1)
7142009-02-14 13:12:06.447 NVP(0), Error: In DVD Menu: No video frames in queue
7152009-02-14 13:12:06.447 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
7162009-02-14 13:12:06.447 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
7172009-02-14 13:12:06.448 FilterManager: GetFilterInfo(convert) returning: 0x0
7182009-02-14 13:12:06.448 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a32bf90
719greedyhdeint: size changed from 0 x 0 -> 720 x 480
7202009-02-14 13:12:06.449 Using deinterlace method greedyhdeint
7212009-02-14 13:12:06.449 VideoOutputXv: DiscardFrames(1)
7222009-02-14 13:12:06.449 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7232009-02-14 13:12:06.449 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7242009-02-14 13:12:06.449 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7252009-02-14 13:12:06.449 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7262009-02-14 13:12:06.454 VDP: LoadBestPreferences(720x480, 29.97)
7272009-02-14 13:12:06.457 NVP(0), Error: In DVD Menu: No video frames in queue
7282009-02-14 13:12:06.467 NVP(0), Error: In DVD Menu: No video frames in queue
7292009-02-14 13:12:06.477 NVP(0), Error: In DVD Menu: No video frames in queue
7302009-02-14 13:12:06.487 NVP(0), Error: In DVD Menu: No video frames in queue
7312009-02-14 13:12:06.497 NVP(0), Error: In DVD Menu: No video frames in queue
7322009-02-14 13:12:06.507 NVP(0), Error: In DVD Menu: No video frames in queue
7332009-02-14 13:12:06.517 NVP(0), Error: In DVD Menu: No video frames in queue
7342009-02-14 13:12:06.527 NVP(0), Error: In DVD Menu: No video frames in queue
7352009-02-14 13:12:06.537 NVP(0), Error: In DVD Menu: No video frames in queue
7362009-02-14 13:12:06.547 NVP(0), Error: In DVD Menu: No video frames in queue
7372009-02-14 13:12:06.558 NVP(0), Error: In DVD Menu: No video frames in queue
7382009-02-14 13:12:06.568 NVP(0), Error: In DVD Menu: No video frames in queue
7392009-02-14 13:12:06.577 NVP(0): ClearAfterSeek(1)
7402009-02-14 13:12:06.577 VideoOutputXv: ClearAfterSeek()
7412009-02-14 13:12:06.577 VideoOutputXv: DiscardFrames(0)
7422009-02-14 13:12:06.577 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7432009-02-14 13:12:06.577 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7442009-02-14 13:12:06.577 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7452009-02-14 13:12:06.577 NVP(0): LoadFilters(''..) -> 0x0
7462009-02-14 13:12:06.577 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
7472009-02-14 13:12:06.578 AFD: HandleGopStart: gopset not set, syncing positionMap
7482009-02-14 13:12:06.578 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
7492009-02-14 13:12:06.578 NVP(0), Error: In DVD Menu: No video frames in queue
7502009-02-14 13:12:06.585 No codec context. Returning false
7512009-02-14 13:12:06.585 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 2
7522009-02-14 13:12:06.585 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120
7532009-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()
7542009-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()
7552009-02-14 13:12:06.588 VDP: LoadBestPreferences(2048x2048, 0)
7562009-02-14 13:12:06.588 VDP: LoadBestPreferences(2048x2048, 60)
7572009-02-14 13:12:06.588 VDP: LoadBestPreferences(720x480, 60)
7582009-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()
7592009-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()
7602009-02-14 13:12:06.589 VDP: LoadBestPreferences(2048x2048, 0)
7612009-02-14 13:12:06.589 VDP: LoadBestPreferences(2048x2048, 60)
7622009-02-14 13:12:06.589 VDP: LoadBestPreferences(720x480, 60)
7632009-02-14 13:12:06.589 Using 1 CPUs for decoding
7642009-02-14 13:12:06.590 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
7652009-02-14 13:12:06.590 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
7662009-02-14 13:12:06.590 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
7672009-02-14 13:12:06.590 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
7682009-02-14 13:12:06.591 FilterManager: GetFilterInfo(convert) returning: 0x0
7692009-02-14 13:12:06.591 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bab3b90
770greedyhdeint: size changed from 0 x 0 -> 720 x 480
7712009-02-14 13:12:06.591 Using deinterlace method greedyhdeint
7722009-02-14 13:12:06.591 VideoOutputXv: DiscardFrames(1)
7732009-02-14 13:12:06.591 VideoBuffers::DiscardFrames(1): ALAuAAAAAAAAAAAAAAAAAAAAAAAAAAA
7742009-02-14 13:12:06.591 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7752009-02-14 13:12:06.591 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7762009-02-14 13:12:06.591 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7772009-02-14 13:12:06.596 VDP: LoadBestPreferences(720x480, 29.97)
7782009-02-14 13:12:06.621 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7792009-02-14 13:12:06.734 NVP(0): ClearAfterSeek(1)
7802009-02-14 13:12:06.734 VideoOutputXv: ClearAfterSeek()
7812009-02-14 13:12:06.734 VideoOutputXv: DiscardFrames(0)
7822009-02-14 13:12:06.734 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7832009-02-14 13:12:06.734 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7842009-02-14 13:12:06.734 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7852009-02-14 13:12:06.736 NVP(0): LoadFilters(''..) -> 0x0
7862009-02-14 13:12:06.736 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
7872009-02-14 13:12:06.736 AFD: Using ffmpeg for video decoding
7882009-02-14 13:12:06.736 AFD: Looking for decoder for MPEG2VIDEO
7892009-02-14 13:12:06.736 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
7902009-02-14 13:12:06.736 AFD: subtitle codec (Subtitle)
7912009-02-14 13:12:06.736 AFD: Looking for decoder for DVD_SUBTITLE
7922009-02-14 13:12:06.736 AFD: Opened codec 0x7f9b0a335360, id(DVD_SUBTITLE) type(Subtitle)
7932009-02-14 13:12:06.736 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
7942009-02-14 13:12:06.736 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB)
795                         -> threshhold(64 KB) min read(32 KB) blk size(256 KB)
7962009-02-14 13:12:06.736 AFD: DVD Subtitle Track Map Stream id #33
7972009-02-14 13:12:06.736 Leaving DVD Still Frame
7982009-02-14 13:12:06.737 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 3
7992009-02-14 13:12:06.737 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120
8002009-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()
8012009-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()
8022009-02-14 13:12:06.739 VDP: LoadBestPreferences(2048x2048, 0)
8032009-02-14 13:12:06.739 VDP: LoadBestPreferences(2048x2048, 60)
8042009-02-14 13:12:06.739 VDP: LoadBestPreferences(720x480, 60)
8052009-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()
8062009-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()
8072009-02-14 13:12:06.741 VDP: LoadBestPreferences(2048x2048, 0)
8082009-02-14 13:12:06.741 VDP: LoadBestPreferences(2048x2048, 60)
8092009-02-14 13:12:06.741 VDP: LoadBestPreferences(720x480, 60)
8102009-02-14 13:12:06.741 Using 1 CPUs for decoding
8112009-02-14 13:12:06.741 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
8122009-02-14 13:12:06.741 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
8132009-02-14 13:12:06.741 AFD: Using ffmpeg for video decoding
8142009-02-14 13:12:06.741 AFD: Looking for decoder for MPEG2VIDEO
8152009-02-14 13:12:06.741 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
8162009-02-14 13:12:06.741 AFD: subtitle codec (Subtitle)
8172009-02-14 13:12:06.741 AFD: Looking for decoder for DVD_SUBTITLE
8182009-02-14 13:12:06.741 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
8192009-02-14 13:12:06.741 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0
8202009-02-14 13:12:06.741 AFD: subtitle codec (Subtitle)
8212009-02-14 13:12:06.741 AFD: Looking for decoder for DVD_SUBTITLE
8222009-02-14 13:12:06.741 AFD: Opened codec 0x534b1a0, id(DVD_SUBTITLE) type(Subtitle)
8232009-02-14 13:12:06.742 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
8242009-02-14 13:12:06.742 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB)
825                         -> threshhold(64 KB) min read(32 KB) blk size(256 KB)
8262009-02-14 13:12:06.742 AFD: DVD Subtitle Track Map Stream id #32
8272009-02-14 13:12:06.742 AFD: DVD Subtitle Track Map Stream id #33
8282009-02-14 13:12:06.742 DVDNAV_HOP_CHANNEL happened.
8292009-02-14 13:12:06.742 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1
8302009-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
8312009-02-14 13:12:06.742 DVDNAV_SPU_CLUT_CHANGE happened.
8322009-02-14 13:12:06.742 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==1, current_track==0
8332009-02-14 13:12:06.742 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0
8342009-02-14 13:12:06.743 AFD: HandleGopStart: gopset not set, syncing positionMap
8352009-02-14 13:12:06.743 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
8362009-02-14 13:12:06.743 AFD: HandleGopStart: Initial key frame distance: 15.
8372009-02-14 13:12:06.743 Entering DVD Still Frame
8382009-02-14 13:12:06.743 AFD: DVD Cell Changed. Update framesPlayed: 0
8392009-02-14 13:12:06.746 NVP(0), Error: In DVD Menu: No video frames in queue
8402009-02-14 13:12:06.751 No codec context. Returning false
8412009-02-14 13:12:06.751 Leaving DVD Still Frame
8422009-02-14 13:12:06.751 DVDRB: Clearing Menu SPU Packet
8432009-02-14 13:12:06.752 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1
8442009-02-14 13:12:06.752 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4
8452009-02-14 13:12:06.752 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x7f9b09446120
8462009-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()
8472009-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()
8482009-02-14 13:12:06.754 VDP: LoadBestPreferences(2048x2048, 0)
8492009-02-14 13:12:06.754 VDP: LoadBestPreferences(2048x2048, 60)
8502009-02-14 13:12:06.754 VDP: LoadBestPreferences(720x480, 60)
8512009-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()
8522009-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()
8532009-02-14 13:12:06.755 VDP: LoadBestPreferences(2048x2048, 0)
8542009-02-14 13:12:06.756 VDP: LoadBestPreferences(2048x2048, 60)
8552009-02-14 13:12:06.756 VDP: LoadBestPreferences(720x480, 60)
8562009-02-14 13:12:06.756 Using 1 CPUs for decoding
8572009-02-14 13:12:06.756 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
8582009-02-14 13:12:06.756 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
8592009-02-14 13:12:06.756 AFD: Using ffmpeg for video decoding
8602009-02-14 13:12:06.756 AFD: Looking for decoder for MPEG2VIDEO
8612009-02-14 13:12:06.756 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
8622009-02-14 13:12:06.756 AFD: subtitle codec (Subtitle)
8632009-02-14 13:12:06.756 AFD: Looking for decoder for DVD_SUBTITLE
8642009-02-14 13:12:06.756 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
8652009-02-14 13:12:06.756 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0
8662009-02-14 13:12:06.756 AFD: subtitle codec (Subtitle)
8672009-02-14 13:12:06.756 AFD: Looking for decoder for DVD_SUBTITLE
8682009-02-14 13:12:06.756 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
8692009-02-14 13:12:06.756 AFD: Stream #3, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a24cb30
8702009-02-14 13:12:06.756 AFD: codec AC3 has 0 channels
8712009-02-14 13:12:06.756 AFD: Looking for decoder for AC3
8722009-02-14 13:12:06.757 AFD: Opened codec 0x7f9b0a23e0a0, id(AC3) type(Audio)
8732009-02-14 13:12:06.757 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB)
874                         -> threshhold(64 KB) min read(32 KB) blk size(256 KB)
8752009-02-14 13:12:06.757 AFD: DVD Subtitle Track Map Stream id #32
8762009-02-14 13:12:06.757 AFD: DVD Subtitle Track Map Stream id #33
8772009-02-14 13:12:06.759 Opening audio device 'default'. ch 2(2) sr 48000
8782009-02-14 13:12:06.759 Opening ALSA audio device 'default'.
8792009-02-14 13:12:06.761 NVP(0): Enabling Audio
8802009-02-14 13:12:06.763 Opening audio device 'default'. ch 2(2) sr 48000
8812009-02-14 13:12:06.763 Opening ALSA audio device 'default'.
8822009-02-14 13:12:06.789 VideoOutputXv: UpdatePauseFrame() AAAAAuLAAAAAAAAAAAAAAAAAAAAAAAA
8832009-02-14 13:12:06.897 DVDRB: Entering DVDNAV_WAIT
8842009-02-14 13:12:06.946 DVDRB: Exiting DVDNAV_WAIT status
8852009-02-14 13:12:06.948 DVDNAV_VTS_CHANGE: old_vtsN==2, new_vtsN==2, aspect: 3, perm: 2
8862009-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
8872009-02-14 13:12:06.948 DVDNAV_SPU_CLUT_CHANGE happened.
8882009-02-14 13:12:06.948 DVDNAV_SPU_STREAM_CHANGE: physical_wide==128, physical_letterbox==129, physical_pan_scan==128, current_track==-128
8892009-02-14 13:12:06.948 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0
8902009-02-14 13:12:07.025 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
8912009-02-14 13:12:07.025 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
8922009-02-14 13:12:07.027 FilterManager: GetFilterInfo(convert) returning: 0x0
8932009-02-14 13:12:07.027 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a4856f0
894greedyhdeint: size changed from 0 x 0 -> 720 x 480
8952009-02-14 13:12:07.027 Using deinterlace method greedyhdeint
8962009-02-14 13:12:07.027 VideoOutputXv: DiscardFrames(1)
8972009-02-14 13:12:07.027 VideoBuffers::DiscardFrames(1): AAAAAuLAAAAAAAAAAAAAAAAAAAAAAAA
8982009-02-14 13:12:07.027 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
8992009-02-14 13:12:07.027 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9002009-02-14 13:12:07.027 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9012009-02-14 13:12:07.156 NVP(0): ClearAfterSeek(1)
9022009-02-14 13:12:07.157 VideoOutputXv: ClearAfterSeek()
9032009-02-14 13:12:07.157 VideoOutputXv: DiscardFrames(0)
9042009-02-14 13:12:07.157 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
9052009-02-14 13:12:07.157 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9062009-02-14 13:12:07.157 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9072009-02-14 13:12:07.158 NVP(0): LoadFilters(''..) -> 0x0
9082009-02-14 13:12:07.158 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
9092009-02-14 13:12:07.159 AFD: DVD Title Changed
9102009-02-14 13:12:07.159 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
9112009-02-14 13:12:07.159 DVD Frame Rate 29.97
9122009-02-14 13:12:07.159 Position map filled from DB to: 224595
9132009-02-14 13:12:07.159 Dec: SyncPositionMap prerecorded, from DB: 1 entries
9142009-02-14 13:12:07.159 Dec: SyncPositionMap, new totframes: 224595, new length: 7494, posMap size: 1
9152009-02-14 13:12:07.159 AFD: DVD Cell Changed. Update framesPlayed: 0
9162009-02-14 13:12:07.159 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 5
9172009-02-14 13:12:07.159 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
9182009-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()
9192009-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()
9202009-02-14 13:12:07.161 VDP: LoadBestPreferences(2048x2048, 0)
9212009-02-14 13:12:07.161 VDP: LoadBestPreferences(2048x2048, 60)
9222009-02-14 13:12:07.161 VDP: LoadBestPreferences(720x480, 60)
9232009-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()
9242009-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()
9252009-02-14 13:12:07.164 VDP: LoadBestPreferences(2048x2048, 0)
9262009-02-14 13:12:07.164 VDP: LoadBestPreferences(2048x2048, 60)
9272009-02-14 13:12:07.164 VDP: LoadBestPreferences(720x480, 60)
9282009-02-14 13:12:07.164 Using 1 CPUs for decoding
9292009-02-14 13:12:07.164 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
9302009-02-14 13:12:07.164 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
9312009-02-14 13:12:07.164 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
9322009-02-14 13:12:07.164 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
9332009-02-14 13:12:07.165 FilterManager: GetFilterInfo(convert) returning: 0x0
9342009-02-14 13:12:07.165 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0bf951d0
935greedyhdeint: size changed from 0 x 0 -> 720 x 480
9362009-02-14 13:12:07.166 Using deinterlace method greedyhdeint
9372009-02-14 13:12:07.166 VideoOutputXv: DiscardFrames(1)
9382009-02-14 13:12:07.166 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
9392009-02-14 13:12:07.166 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9402009-02-14 13:12:07.166 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9412009-02-14 13:12:07.166 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9422009-02-14 13:12:07.292 NVP(0): ClearAfterSeek(1)
9432009-02-14 13:12:07.292 VideoOutputXv: ClearAfterSeek()
9442009-02-14 13:12:07.292 VideoOutputXv: DiscardFrames(0)
9452009-02-14 13:12:07.292 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
9462009-02-14 13:12:07.292 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9472009-02-14 13:12:07.292 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9482009-02-14 13:12:07.294 NVP(0): LoadFilters(''..) -> 0x0
9492009-02-14 13:12:07.294 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
9502009-02-14 13:12:07.294 AFD: Using ffmpeg for video decoding
9512009-02-14 13:12:07.294 AFD: Looking for decoder for MPEG2VIDEO
9522009-02-14 13:12:07.294 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
9532009-02-14 13:12:07.294 AFD: subtitle codec (Subtitle)
9542009-02-14 13:12:07.294 AFD: Looking for decoder for DVD_SUBTITLE
9552009-02-14 13:12:07.294 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
9562009-02-14 13:12:07.294 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0
9572009-02-14 13:12:07.294 AFD: subtitle codec (Subtitle)
9582009-02-14 13:12:07.294 AFD: Looking for decoder for DVD_SUBTITLE
9592009-02-14 13:12:07.294 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
9602009-02-14 13:12:07.294 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB)
961                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
9622009-02-14 13:12:07.294 AFD: DVD Subtitle Track Map Stream id #32
9632009-02-14 13:12:07.294 AFD: DVD Subtitle Track Map Stream id #33
9642009-02-14 13:12:07.295 NVP(0): Disabling Audio, params(-1,-1,-1)
9652009-02-14 13:12:07.297 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 4
9662009-02-14 13:12:07.297 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
9672009-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()
9682009-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()
9692009-02-14 13:12:07.299 VDP: LoadBestPreferences(2048x2048, 0)
9702009-02-14 13:12:07.299 VDP: LoadBestPreferences(2048x2048, 60)
9712009-02-14 13:12:07.299 VDP: LoadBestPreferences(720x480, 60)
9722009-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()
9732009-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()
9742009-02-14 13:12:07.301 VDP: LoadBestPreferences(2048x2048, 0)
9752009-02-14 13:12:07.301 VDP: LoadBestPreferences(2048x2048, 60)
9762009-02-14 13:12:07.301 VDP: LoadBestPreferences(720x480, 60)
9772009-02-14 13:12:07.301 Using 1 CPUs for decoding
9782009-02-14 13:12:07.301 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
9792009-02-14 13:12:07.301 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
9802009-02-14 13:12:07.301 AFD: Using ffmpeg for video decoding
9812009-02-14 13:12:07.301 AFD: Looking for decoder for MPEG2VIDEO
9822009-02-14 13:12:07.301 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
9832009-02-14 13:12:07.301 AFD: subtitle codec (Subtitle)
9842009-02-14 13:12:07.301 AFD: Looking for decoder for DVD_SUBTITLE
9852009-02-14 13:12:07.301 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
9862009-02-14 13:12:07.301 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0
9872009-02-14 13:12:07.301 AFD: subtitle codec (Subtitle)
9882009-02-14 13:12:07.301 AFD: Looking for decoder for DVD_SUBTITLE
9892009-02-14 13:12:07.301 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
9902009-02-14 13:12:07.301 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0bab6a30
9912009-02-14 13:12:07.302 AFD: codec AC3 has 0 channels
9922009-02-14 13:12:07.302 AFD: Looking for decoder for AC3
9932009-02-14 13:12:07.302 AFD: Opened codec 0x7f9b0ba09430, id(AC3) type(Audio)
9942009-02-14 13:12:07.302 RingBuf(/dev/dvd): CalcReadAheadThresh(7500 KB)
995                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
9962009-02-14 13:12:07.302 AFD: DVD Subtitle Track Map Stream id #32
9972009-02-14 13:12:07.302 AFD: DVD Subtitle Track Map Stream id #33
9982009-02-14 13:12:07.303 Opening audio device 'default'. ch 2(2) sr 48000
9992009-02-14 13:12:07.303 Opening ALSA audio device 'default'.
10002009-02-14 13:12:07.304 NVP(0): Enabling Audio
10012009-02-14 13:12:07.306 Opening audio device 'default'. ch 2(2) sr 48000
10022009-02-14 13:12:07.306 Opening ALSA audio device 'default'.
10032009-02-14 13:12:07.308 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 5
10042009-02-14 13:12:07.308 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
10052009-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()
10062009-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()
10072009-02-14 13:12:07.310 VDP: LoadBestPreferences(2048x2048, 0)
10082009-02-14 13:12:07.310 VDP: LoadBestPreferences(2048x2048, 60)
10092009-02-14 13:12:07.310 VDP: LoadBestPreferences(720x480, 60)
10102009-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()
10112009-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()
10122009-02-14 13:12:07.312 VDP: LoadBestPreferences(2048x2048, 0)
10132009-02-14 13:12:07.312 VDP: LoadBestPreferences(2048x2048, 60)
10142009-02-14 13:12:07.312 VDP: LoadBestPreferences(720x480, 60)
10152009-02-14 13:12:07.312 Using 1 CPUs for decoding
10162009-02-14 13:12:07.312 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
10172009-02-14 13:12:07.312 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
10182009-02-14 13:12:07.312 AFD: Using ffmpeg for video decoding
10192009-02-14 13:12:07.312 AFD: Looking for decoder for MPEG2VIDEO
10202009-02-14 13:12:07.312 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
10212009-02-14 13:12:07.312 AFD: subtitle codec (Subtitle)
10222009-02-14 13:12:07.312 AFD: Looking for decoder for DVD_SUBTITLE
10232009-02-14 13:12:07.312 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
10242009-02-14 13:12:07.312 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0
10252009-02-14 13:12:07.312 AFD: subtitle codec (Subtitle)
10262009-02-14 13:12:07.312 AFD: Looking for decoder for DVD_SUBTITLE
10272009-02-14 13:12:07.312 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
10282009-02-14 13:12:07.313 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bab6a30
10292009-02-14 13:12:07.313 AFD: Warning, audio codec 0x7f9b0ba09430 id(AC3) type (Audio) already open, leaving it alone.
10302009-02-14 13:12:07.313 AFD: codec AC3 has 2 channels
10312009-02-14 13:12:07.313 AFD: Looking for decoder for AC3
10322009-02-14 13:12:07.313 AFD: Stream #4, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a35e160
10332009-02-14 13:12:07.313 AFD: codec AC3 has 0 channels
10342009-02-14 13:12:07.313 AFD: Looking for decoder for AC3
10352009-02-14 13:12:07.313 AFD: Opened codec 0x7f9b0a240e60, id(AC3) type(Audio)
10362009-02-14 13:12:07.313 RingBuf(/dev/dvd): CalcReadAheadThresh(7692 KB)
1037                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
10382009-02-14 13:12:07.313 AFD: DVD Audio Track Map Stream id #128
10392009-02-14 13:12:07.313 AFD: DVD Audio Track Map Stream id #129
10402009-02-14 13:12:07.314 Opening audio device 'default'. ch 2(2) sr 48000
10412009-02-14 13:12:07.314 Opening ALSA audio device 'default'.
10422009-02-14 13:12:07.316 AFD: DVD Subtitle Track Map Stream id #32
10432009-02-14 13:12:07.316 AFD: DVD Subtitle Track Map Stream id #33
10442009-02-14 13:12:07.317 AFD: HandleStreamChange(): streams_changed 0x7f9b08a20d40 -- stream count 6
10452009-02-14 13:12:07.317 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
10462009-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()
10472009-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()
10482009-02-14 13:12:07.319 VDP: LoadBestPreferences(2048x2048, 0)
10492009-02-14 13:12:07.319 VDP: LoadBestPreferences(2048x2048, 60)
10502009-02-14 13:12:07.319 VDP: LoadBestPreferences(720x480, 60)
10512009-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()
10522009-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()
10532009-02-14 13:12:07.320 VDP: LoadBestPreferences(2048x2048, 0)
10542009-02-14 13:12:07.320 VDP: LoadBestPreferences(2048x2048, 60)
10552009-02-14 13:12:07.320 VDP: LoadBestPreferences(720x480, 60)
10562009-02-14 13:12:07.320 Using 1 CPUs for decoding
10572009-02-14 13:12:07.320 AFD: Warning, video codec 0x7f9b09803140 id(MPEG2VIDEO) type (Video) already open.
10582009-02-14 13:12:07.321 AFD: InitVideoCodec() 0x7f9b09803140 id(MPEG2VIDEO) type (Video).
10592009-02-14 13:12:07.321 AFD: Using ffmpeg for video decoding
10602009-02-14 13:12:07.321 AFD: Looking for decoder for MPEG2VIDEO
10612009-02-14 13:12:07.321 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
10622009-02-14 13:12:07.321 AFD: subtitle codec (Subtitle)
10632009-02-14 13:12:07.321 AFD: Looking for decoder for DVD_SUBTITLE
10642009-02-14 13:12:07.321 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
10652009-02-14 13:12:07.321 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0
10662009-02-14 13:12:07.321 AFD: subtitle codec (Subtitle)
10672009-02-14 13:12:07.321 AFD: Looking for decoder for DVD_SUBTITLE
10682009-02-14 13:12:07.321 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
10692009-02-14 13:12:07.321 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bab6a30
10702009-02-14 13:12:07.321 AFD: Warning, audio codec 0x7f9b0ba09430 id(AC3) type (Audio) already open, leaving it alone.
10712009-02-14 13:12:07.321 AFD: codec AC3 has 2 channels
10722009-02-14 13:12:07.321 AFD: Looking for decoder for AC3
10732009-02-14 13:12:07.321 AFD: Stream #4, has id 0x128 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a35e160
10742009-02-14 13:12:07.321 AFD: Warning, audio codec 0x7f9b0a240e60 id(AC3) type (Audio) already open, leaving it alone.
10752009-02-14 13:12:07.321 AFD: codec AC3 has 2 channels
10762009-02-14 13:12:07.321 AFD: Looking for decoder for AC3
10772009-02-14 13:12:07.321 AFD: Stream #5, has id 0x130 codec id AC3, type Audio, bitrate 0 at 0x0x7f9b0a334970
10782009-02-14 13:12:07.321 AFD: codec AC3 has 0 channels
10792009-02-14 13:12:07.321 AFD: Looking for decoder for AC3
10802009-02-14 13:12:07.322 AFD: Opened codec 0x7f9b0a35c910, id(AC3) type(Audio)
10812009-02-14 13:12:07.322 RingBuf(/dev/dvd): CalcReadAheadThresh(7884 KB)
1082                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
10832009-02-14 13:12:07.322 AFD: DVD Audio Track Map Stream id #128
10842009-02-14 13:12:07.322 AFD: DVD Audio Track Map Stream id #129
10852009-02-14 13:12:07.322 AFD: DVD Audio Track Map Stream id #130
10862009-02-14 13:12:07.322 AFD: DVD Subtitle Track Map Stream id #32
10872009-02-14 13:12:07.322 AFD: DVD Subtitle Track Map Stream id #33
10882009-02-14 13:12:07.322 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 7500000 at 0x0x7f9b09446120
10892009-02-14 13:12:07.322 AFD: Looking for decoder for MPEG2VIDEO
10902009-02-14 13:12:07.322 AFD: Stream #1, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x7f9b0a436ae0
10912009-02-14 13:12:07.322 AFD: subtitle codec (Subtitle)
10922009-02-14 13:12:07.322 AFD: Looking for decoder for DVD_SUBTITLE
10932009-02-14 13:12:07.322 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
10942009-02-14 13:12:07.322 AFD: Stream #2, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x55945b0
10952009-02-14 13:12:07.322 AFD: subtitle codec (Subtitle)
10962009-02-14 13:12:07.322 AFD: Looking for decoder for DVD_SUBTITLE
10972009-02-14 13:12:07.322 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
10982009-02-14 13:12:07.322 AFD: Stream #3, has id 0x129 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0bab6a30
10992009-02-14 13:12:07.322 AFD: Warning, audio codec 0x7f9b0ba09430 id(AC3) type (Audio) already open, leaving it alone.
11002009-02-14 13:12:07.322 AFD: codec AC3 has 2 channels
11012009-02-14 13:12:07.322 AFD: Looking for decoder for AC3
11022009-02-14 13:12:07.322 AFD: Stream #4, has id 0x128 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a35e160
11032009-02-14 13:12:07.322 AFD: Warning, audio codec 0x7f9b0a240e60 id(AC3) type (Audio) already open, leaving it alone.
11042009-02-14 13:12:07.323 AFD: codec AC3 has 2 channels
11052009-02-14 13:12:07.323 AFD: Looking for decoder for AC3
11062009-02-14 13:12:07.323 AFD: Stream #5, has id 0x130 codec id AC3, type Audio, bitrate 192000 at 0x0x7f9b0a334970
11072009-02-14 13:12:07.323 AFD: Warning, audio codec 0x7f9b0a35c910 id(AC3) type (Audio) already open, leaving it alone.
11082009-02-14 13:12:07.323 AFD: codec AC3 has 2 channels
11092009-02-14 13:12:07.323 AFD: Looking for decoder for AC3
11102009-02-14 13:12:07.323 RingBuf(/dev/dvd): CalcReadAheadThresh(8076 KB)
1111                         -> threshhold(64 KB) min read(32 KB) blk size(128 KB)
11122009-02-14 13:12:07.323 AFD: DVD Audio Track Map Stream id #128
11132009-02-14 13:12:07.323 AFD: DVD Audio Track Map Stream id #129
11142009-02-14 13:12:07.323 AFD: DVD Audio Track Map Stream id #130
11152009-02-14 13:12:07.323 AFD: DVD Subtitle Track Map Stream id #32
11162009-02-14 13:12:07.323 AFD: DVD Subtitle Track Map Stream id #33
11172009-02-14 13:12:07.323 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
11182009-02-14 13:12:07.323 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
11192009-02-14 13:12:07.324 FilterManager: GetFilterInfo(convert) returning: 0x0
11202009-02-14 13:12:07.324 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a436c90
1121greedyhdeint: size changed from 0 x 0 -> 720 x 480
11222009-02-14 13:12:07.325 Using deinterlace method greedyhdeint
11232009-02-14 13:12:07.325 VideoOutputXv: DiscardFrames(1)
11242009-02-14 13:12:07.325 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
11252009-02-14 13:12:07.325 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
11262009-02-14 13:12:07.325 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
11272009-02-14 13:12:07.325 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
11282009-02-14 13:12:07.329 VDP: LoadBestPreferences(720x480, 29.97)
11292009-02-14 13:12:07.452 NVP(0): ClearAfterSeek(1)
11302009-02-14 13:12:07.452 VideoOutputXv: ClearAfterSeek()
11312009-02-14 13:12:07.452 VideoOutputXv: DiscardFrames(0)
11322009-02-14 13:12:07.452 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
11332009-02-14 13:12:07.452 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
11342009-02-14 13:12:07.452 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
11352009-02-14 13:12:07.454 NVP(0): LoadFilters(''..) -> 0x0
11362009-02-14 13:12:07.454 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
11372009-02-14 13:12:07.454 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
11382009-02-14 13:12:07.454 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
11392009-02-14 13:12:07.455 FilterManager: GetFilterInfo(convert) returning: 0x0
11402009-02-14 13:12:07.455 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f9b0a438700
1141greedyhdeint: size changed from 0 x 0 -> 720 x 480
11422009-02-14 13:12:07.456 Using deinterlace method greedyhdeint
11432009-02-14 13:12:07.456 VideoOutputXv: DiscardFrames(1)
11442009-02-14 13:12:07.456 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
11452009-02-14 13:12:07.456 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
11462009-02-14 13:12:07.456 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
11472009-02-14 13:12:07.456 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
11482009-02-14 13:12:07.461 VDP: LoadBestPreferences(720x480, 29.97)
11492009-02-14 13:12:07.583 NVP(0): ClearAfterSeek(1)
11502009-02-14 13:12:07.583 VideoOutputXv: ClearAfterSeek()
11512009-02-14 13:12:07.583 VideoOutputXv: DiscardFrames(0)
11522009-02-14 13:12:07.583 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
11532009-02-14 13:12:07.583 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
11542009-02-14 13:12:07.583 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
11552009-02-14 13:12:07.585 NVP(0): LoadFilters(''..) -> 0x0
11562009-02-14 13:12:07.585 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
11572009-02-14 13:12:07.585 AFD: HandleGopStart: gopset not set, syncing positionMap
11582009-02-14 13:12:07.585 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
11592009-02-14 13:12:07.586 AFD: HandleGopStart: gopset not set, syncing positionMap
11602009-02-14 13:12:07.586 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
11612009-02-14 13:12:07.588 Dec: Trying to select track (w/lang)
11622009-02-14 13:12:07.588 Dec: Selecting first track
11632009-02-14 13:12:07.588 Dec: Selected track #1 in the Undetermined language(7695972)
11642009-02-14 13:12:07.588 Dec: Trying to reselect track
11652009-02-14 13:12:07.589 Dec: Selected track #1 in the Unknown language(0)
11662009-02-14 13:12:07.603 NVP(0): Waiting for prebuffer..  0 AAAAUAAUUUUuUALLAAAAAAAAAAAAAAA
11672009-02-14 13:12:07.604 AFD: HandleGopStart: gopset not set, syncing positionMap
11682009-02-14 13:12:07.604 Dec: Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
11692009-02-14 13:12:07.604 AFD: HandleGopStart: Initial key frame distance: 15.
11702009-02-14 13:12:07.605 AFD: HandleGopStart: Key frame distance changed from 11 to 1.
11712009-02-14 13:12:07.613 NVP(0): progressive frame seen after 2 interlaced  frames
11722009-02-14 13:12:07.613 Disabled deinterlacing
1173'video_output' mean = '51497.70', std. dev. = '122742.72', fps = '19.42'
11742009-02-14 13:12:14.098 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
11752009-02-14 13:12:14.098 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
11762009-02-14 13:12:14.138 TV: HandleStateChange(0) -- begin
11772009-02-14 13:12:14.138 TV: Attempting to change from WatchingPreRecorded to None
11782009-02-14 13:12:14.138 TV: StopStuff() for player ctx 0 -- begin
11792009-02-14 13:12:14.138 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
11802009-02-14 13:12:14.138 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
11812009-02-14 13:12:14.138 TV:  StopStuff() -- get dvd player out of still frame or wait status
11822009-02-14 13:12:14.138 TV: StopStuff(): stopping ring buffer
11832009-02-14 13:12:14.138 TV: StopStuff(): stopping player
11842009-02-14 13:12:14.138 TV: StopStuff() -- end
11852009-02-14 13:12:14.138 TV: Changing from WatchingPreRecorded to None
11862009-02-14 13:12:14.138 TV: HandleStateChange(0) -- end
11872009-02-14 13:12:14.138 TV: StartTV -- process events end
11882009-02-14 13:12:14.138 TV: StartTV -- process events 2 begin
11892009-02-14 13:12:14.139 TV: StartTV -- process events 2 end
11902009-02-14 13:12:14.139 TV::~TV() -- begin
11912009-02-14 13:12:14.139 TV::~TV() -- lock
11922009-02-14 13:12:14.139 TV: StopStuff() for player ctx 0 -- begin
11932009-02-14 13:12:14.139 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
11942009-02-14 13:12:14.140 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
11952009-02-14 13:12:14.140 TV:  StopStuff() -- get dvd player out of still frame or wait status
11962009-02-14 13:12:14.140 TV: StopStuff(): stopping ring buffer
11972009-02-14 13:12:14.140 TV: StopStuff(): stopping player
11982009-02-14 13:12:14.140 TV: StopStuff(): stopping recorder
11992009-02-14 13:12:14.140 TV: StopStuff() -- end
12002009-02-14 13:12:14.150 NVP(0): Exited decoder loop.
12012009-02-14 13:12:14.197 ~OpenGLVideoSync() -- closing opengl vsync
12022009-02-14 13:12:14.197 VideoOutputXv: dtor
12032009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames(1)
12042009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): UULUUUUUUUUUUUUUUUAUUUUUUUuUUUU
12052009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
12062009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
12072009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
12082009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames(1)
12092009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
12102009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
12112009-02-14 13:12:14.197 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
12122009-02-14 13:12:14.197 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
12132009-02-14 13:12:14.199 GLCtx: Deleting OpenGL Resources
12142009-02-14 13:12:14.202 GLCtx: Unmapping gl window
12152009-02-14 13:12:14.202 GLCtx: Destroying gl window
12162009-02-14 13:12:14.223 GLCtx: Destroying glx context
12172009-02-14 13:12:14.223 VideoOutputXv: Closing XVideo port 355
12182009-02-14 13:12:14.247 DVDRB: Clearing Menu SPU Packet
12192009-02-14 13:12:14.248 TV::~TV() -- end
12202009-02-14 13:12:14.248 TV: StartTV -- end
12212009-02-14 13:12:17.537 Deleting UPnP client...