Ticket #5657: Wit_log.txt

File Wit_log.txt, 71.1 KB (added by Greg Grotsky <spikeygg@…>, 12 years ago)

Log from Trunk@19241 "Wit" DVD root menu failure (-v playback)

Line 
12008-12-12 16:46:37.581 mythfrontend version: trunk [19241] www.mythtv.org
22008-12-12 16:46:37.609 Using runtime prefix = /usr/local
32008-12-12 16:46:38.580 Empty LocalHostName.
42008-12-12 16:46:38.580 Using localhost value of mythbox
52008-12-12 16:46:38.650 New DB connection, total: 1
62008-12-12 16:46:38.654 Connected to database 'mythconverg' at host: localhost
72008-12-12 16:46:38.666 Closing DB connection named 'DBManager0'
82008-12-12 16:46:38.734 DPMS is disabled.
92008-12-12 16:46:38.736 Primary screen: 0.
102008-12-12 16:46:38.736 Connected to database 'mythconverg' at host: localhost
112008-12-12 16:46:38.738 Using screen 0, 1920x1080 at 0,0
122008-12-12 16:46:38.782 MythUI Image Cache size set to 20971520 bytes
132008-12-12 16:46:38.782 user: 1000 effective user: 1000 before privileged thread
142008-12-12 16:46:38.782 user: 1000 effective user: 1000 after privileged thread
152008-12-12 16:46:38.783 user: 1000 effective user: 1000 run_priv_thread
162008-12-12 16:46:38.803 Current Schema Version: 1226
172008-12-12 16:46:38.803 Enabled verbose msgs:  important general playback
182008-12-12 16:46:38.925 Connecting to lcd server: localhost:6545 (try 1 of 10)
192008-12-12 16:46:38.965 New DB connection, total: 2
202008-12-12 16:46:38.966 Connected to database 'mythconverg' at host: localhost
212008-12-12 16:46:40.367 max_width: 1920 max_height: 1080
222008-12-12 16:46:40.588 Primary screen: 0.
232008-12-12 16:46:40.589 Using screen 0, 1920x1080 at 0,0
242008-12-12 16:46:40.590 Switching to wide mode (blootube-wide)
252008-12-12 16:46:40.604 Using the OpenGL painter
262008-12-12 16:46:40.644 lirc init success using configuration file: /home/spikeygg/.mythtv/lircrc
272008-12-12 16:46:41.775 Loading from: /usr/local/share/mythtv/themes/blootube-wide/base.xml
282008-12-12 16:46:42.157 Loading from: /usr/local/share/mythtv/themes/default-wide/base.xml
292008-12-12 16:46:42.172 Error, already have a global font called: basesmall
302008-12-12 16:46:42.172 Error, already have a global font called: basemedium
312008-12-12 16:46:42.172 Error, already have a global font called: baselarge
322008-12-12 16:46:42.172 Error, already have a global font called: baseextralarge
332008-12-12 16:46:42.172 Error, already have a global font called: basesmallgrey
342008-12-12 16:46:42.172 Error, already have a global font called: basesmallpurple
352008-12-12 16:46:42.172 Error, already have a global font called: basesmallblack
362008-12-12 16:46:42.172 Error, already have a global font called: basesmallyellow
372008-12-12 16:46:42.172 Error, already have a global font called: basesmallgreen
382008-12-12 16:46:42.172 Error, already have a global font called: basesmallblue
392008-12-12 16:46:42.172 Error, already have a global font called: basesmallred
402008-12-12 16:46:42.172 Error, already have a global font called: basemediumgrey
412008-12-12 16:46:42.172 Error, already have a global font called: basemediumgreen
422008-12-12 16:46:42.172 Error, already have a global font called: basemediumred
432008-12-12 16:46:42.173 Loading from: /usr/local/share/mythtv/themes/default/base.xml
442008-12-12 16:46:42.222 Using NV NPOT texture extension
452008-12-12 16:46:42.400 Connecting to backend server: 192.168.0.10:6543 (try 1 of 5)
462008-12-12 16:46:42.402 Using protocol version 42
472008-12-12 16:46:42.741 Registering Internal as a media playback plugin.
482008-12-12 16:46:43.486 MythMusic adding CD-Writer: ATA:0,0,0 -- DVD-E616A       
492008-12-12 16:46:43.506 MythMusic adding CD-Writer: ATAPI:0,0,0 -- DVD-E616A       
502008-12-12 16:46:43.645 MonitorRegisterExtensions(0x40, ogg,mp3,aac,flac)
512008-12-12 16:46:49.289 Loading from: /usr/local/share/mythtv/themes/blootube-wide/menu-ui.xml
522008-12-12 16:46:49.324 Found mainmenu.xml for theme 'blootube-wide'
532008-12-12 16:46:53.747 RingBuf(dvd://dev/dvd): OpenFile(dvd://dev/dvd, 12)
542008-12-12 16:46:53.747 OpenFile() trying DVD at /dev/dvd
55libdvdnav: Using dvdnav version 0.1.10-xine from http://xine.sf.net
56libdvdnav: DVD Title: WIT
57libdvdnav: DVD Serial Number: 2AC67E08
58libdvdnav: DVD Title (Alternative): WIT
59libdvdnav: Unable to find map file '/home/spikeygg/.dvdnav/WIT.map'
60libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
612008-12-12 16:46:54.928 Opened DVD device at /dev/dvd
62libdvdnav: Suspected RCE Region Protection!!!
632008-12-12 16:46:55.004 There are 4 titles on the disk
642008-12-12 16:46:55.005 Title 0 has 0 parts.
652008-12-12 16:46:55.005 Title 1 has 21 parts.
662008-12-12 16:46:55.005 Title 2 has 2 parts.
672008-12-12 16:46:55.005 Title 3 has 1 parts.
682008-12-12 16:46:55.031 RingBuf(/dev/dvd): CalcReadAheadThresh(4000 KB)
69                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
702008-12-12 16:46:55.174 TV: Attempting to change from None to WatchingPreRecorded
712008-12-12 16:46:55.174 RingBuf(dvd://dev/dvd): OpenFile(dvd://dev/dvd, 12)
722008-12-12 16:46:55.174 OpenFile() trying DVD at /dev/dvd
73libdvdnav: Using dvdnav version 0.1.10-xine from http://xine.sf.net
74libdvdnav: DVD Title: WIT
75libdvdnav: DVD Serial Number: 2AC67E08
76libdvdnav: DVD Title (Alternative): WIT
77libdvdnav: Unable to find map file '/home/spikeygg/.dvdnav/WIT.map'
78libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
792008-12-12 16:46:55.385 Opened DVD device at /dev/dvd
80libdvdnav: Suspected RCE Region Protection!!!
812008-12-12 16:46:55.487 There are 4 titles on the disk
822008-12-12 16:46:55.488 Title 0 has 0 parts.
832008-12-12 16:46:55.488 Title 1 has 21 parts.
842008-12-12 16:46:55.488 Title 2 has 2 parts.
852008-12-12 16:46:55.488 Title 3 has 1 parts.
862008-12-12 16:46:55.488 RingBuf(/dev/dvd): CalcReadAheadThresh(4000 KB)
87                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
882008-12-12 16:46:55.731 DVDNAV_HIGHLIGHT: display==1, palette==0, sx==0, sy==0, ex==0, ey==0, pts==0, buttonN==1
892008-12-12 16:46:55.731 DVDNAV_VTS_CHANGE: old_vtsN==0, new_vtsN==4, aspect: 3, perm: 1
902008-12-12 16:46:55.731 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 0, part == 0 titleParts 0
912008-12-12 16:46:55.731 DVDNAV_SPU_CLUT_CHANGE happened.
922008-12-12 16:46:55.731 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==0, current_track==0, total count 1
932008-12-12 16:46:55.731 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
942008-12-12 16:46:55.750 DVDNAV_HOP_CHANNEL happened.
952008-12-12 16:46:55.750 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 0, part == 0 titleParts 0
962008-12-12 16:46:55.750 DVDNAV_SPU_CLUT_CHANGE happened.
972008-12-12 16:46:55.750 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==0, current_track==0, total count 1
982008-12-12 16:46:55.750 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
992008-12-12 16:46:55.855 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
1002008-12-12 16:46:55.858 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
1012008-12-12 16:46:55.859 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
1022008-12-12 16:46:55.859 VDP: LoadBestPreferences(2048x2048, 0)
1032008-12-12 16:46:55.859 VDP: LoadBestPreferences(2048x2048, 60)
1042008-12-12 16:46:55.859 VDP: LoadBestPreferences(720x480, 60)
1052008-12-12 16:46:55.862 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
1062008-12-12 16:46:55.862 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
1072008-12-12 16:46:55.862 VDP: LoadBestPreferences(2048x2048, 0)
1082008-12-12 16:46:55.862 VDP: LoadBestPreferences(2048x2048, 60)
1092008-12-12 16:46:55.862 VDP: LoadBestPreferences(720x480, 60)
1102008-12-12 16:46:55.862 Using 1 CPUs for decoding
1112008-12-12 16:46:55.862 AFD: InitVideoCodec() 0x14aa8ed0 id(MPEG2VIDEO) type (Video).
1122008-12-12 16:46:55.862 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
1132008-12-12 16:46:55.862 AFD: Using ffmpeg for video decoding
1142008-12-12 16:46:55.862 AFD: Looking for decoder for MPEG2VIDEO
1152008-12-12 16:46:55.862 AFD: Opened codec 0x14aa8ed0, id(MPEG2VIDEO) type(Video)
1162008-12-12 16:46:55.863 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
117                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
1182008-12-12 16:46:55.863 NVP: Disabling Audio, params(-1,-1,-1)
1192008-12-12 16:46:55.863 No codec context. Returning false
1202008-12-12 16:46:55.863 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
1212008-12-12 16:46:55.863 Position map filled from DB to: 0
1222008-12-12 16:46:55.863 SyncPositionMap prerecorded, from DB: 1 entries
1232008-12-12 16:46:55.863 SyncPositionMap, new totframes: 0, new length: 0, posMap size: 1
1242008-12-12 16:46:55.863 AFD: Position map found
1252008-12-12 16:46:55.863 AFD: Successfully opened decoder for file: "/dev/dvd". novideo(0)
1262008-12-12 16:46:55.924 VideoOutput: Allowed renderers: directfb,opengl,xv-blit,xshm,xlib
1272008-12-12 16:46:55.924 VideoOutput: Allowed renderers (filt: ffmpeg): xlib,xshm,directfb,xv-blit,opengl
1282008-12-12 16:46:55.926 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
1292008-12-12 16:46:55.926 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
1302008-12-12 16:46:55.926 VDP: LoadBestPreferences(2048x2048, 0)
1312008-12-12 16:46:55.926 VDP: LoadBestPreferences(2048x2048, 60)
1322008-12-12 16:46:55.926 VDP: LoadBestPreferences(720x480, 60)
1332008-12-12 16:46:55.926 VideoOutput: Preferred renderer: xv-blit
1342008-12-12 16:46:55.926 VideoOutput: Trying video renderer: 'xv-blit'
1352008-12-12 16:46:55.937 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
1362008-12-12 16:46:55.938 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
1372008-12-12 16:46:55.938 VDP: LoadBestPreferences(2048x2048, 0)
1382008-12-12 16:46:55.938 VDP: LoadBestPreferences(2048x2048, 60)
1392008-12-12 16:46:55.938 VideoOutputXv: ctor
1402008-12-12 16:46:55.988 VideoOutputXv: Creating XJ_gc
1412008-12-12 16:46:55.989 VideoOutputXv: XJ_screen:     '0x1505b880'
1422008-12-12 16:46:55.989 VideoOutputXv: XJ_screen_num: '0'
1432008-12-12 16:46:55.989 VideoOutputXv: XJ_curwin:     '31457315'
1442008-12-12 16:46:55.989 VideoOutputXv: XJ_win:        '31457315'
1452008-12-12 16:46:55.989 VideoOutputXv: XJ_root:       '422'
1462008-12-12 16:46:55.989 VideoOutputXv: XJ_gc:         '0x14aa4d80'
1472008-12-12 16:46:56.008 XOff: 0, YOff: 0
1482008-12-12 16:46:56.008 VDP: LoadBestPreferences(720x480, 60)
1492008-12-12 16:46:56.008 Display Rect  left: 0, top: 60, width: 1920, height: 960, aspect: 1.33333
1502008-12-12 16:46:56.008 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.5
1512008-12-12 16:46:56.010 VideoOutputXv: Pixel dimensions: Screen 1920x1080, window 1920x1080
1522008-12-12 16:46:56.011 VideoOutputXv: Estimated display dimensions: 610x343 mm  Aspect: 1.77843
1532008-12-12 16:46:56.011 VideoOutputXv: Estimated window dimensions: 610x343 mm  Aspect: 1.77843
1542008-12-12 16:46:56.012 VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: opengl,xv-blit,xshm,xlib
1552008-12-12 16:46:56.014 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
1562008-12-12 16:46:56.014 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
1572008-12-12 16:46:56.014 VDP: LoadBestPreferences(2048x2048, 0)
1582008-12-12 16:46:56.014 VDP: LoadBestPreferences(2048x2048, 60)
1592008-12-12 16:46:56.014 VDP: LoadBestPreferences(720x480, 60)
1602008-12-12 16:46:56.014 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  10
1612008-12-12 16:46:56.014 VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask
1622008-12-12 16:46:56.014 VideoOutputXv: Has XVideo flags...
1632008-12-12 16:46:56.014 VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
1642008-12-12 16:46:56.014 VideoOutputXv: Adaptor#1: NV05 Video Blitter has flag[s]: XvInputMask XvImageMask
1652008-12-12 16:46:56.014 VideoOutputXv: Has XVideo flags...
1662008-12-12 16:46:56.015 VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
1672008-12-12 16:46:56.015 VideoOutputXv: @ j=1 Looking for flag[s]: XvInputMask XvImageMask  0
1682008-12-12 16:46:56.015 VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask
1692008-12-12 16:46:56.015 VideoOutputXv: Has XVideo flags...
1702008-12-12 16:46:56.015 VideoOutputXv: Here...
1712008-12-12 16:46:56.015 VideoOutputXv: Grabbed xv port 355
1722008-12-12 16:46:56.015 VideoOutputXv: XVideo surface found on port 355
1732008-12-12 16:46:56.015 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
1742008-12-12 16:46:56.015 VideoOutputXv: XVideo Format #0 is 'YUY2'
1752008-12-12 16:46:56.015 VideoOutputXv: XVideo Format #1 is 'YV12'
1762008-12-12 16:46:56.015 VideoOutputXv: XVideo Format #2 is 'UYVY'
1772008-12-12 16:46:56.015 VideoOutputXv: XVideo Format #3 is 'I420'
1782008-12-12 16:46:56.015 VideoOutputXv: Using XVideo Format 'YV12'
1792008-12-12 16:46:56.015 VideoOutputXv: CreateShmImages(32): video_dim: 720x480
1802008-12-12 16:46:56.038 VDP: SetVideoRenderer(xv-blit)
1812008-12-12 16:46:56.039 VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
1822008-12-12 16:46:56.039 VideoOutputXv: Chromakeying not possible with this XVideo port.
1832008-12-12 16:46:56.039 Display Rect  left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778
1842008-12-12 16:46:56.039 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.5
1852008-12-12 16:46:56.039 Over/underscan. V: 0, H: 0
1862008-12-12 16:46:56.039 Display Rect  left: 150, top: 0, width: 1620, height: 1080, aspect: 1.77778
1872008-12-12 16:46:56.039 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.5
1882008-12-12 16:46:56.039 VDP: LoadBestPreferences(720x480, 29.97)
1892008-12-12 16:46:56.040 NVP: LoadFilters(''..) -> 0x0
1902008-12-12 16:46:56.041 OSD Theme Dimensions W: 640 H: 480
1912008-12-12 16:46:56.572 NVP: ClearAfterSeek(1)
1922008-12-12 16:46:56.572 VideoOutputXv: ClearAfterSeek()
1932008-12-12 16:46:56.572 TV: StartPlayer(): took 841 ms to start player.
1942008-12-12 16:46:56.572 TV: Changing from None to WatchingPreRecorded
1952008-12-12 16:46:56.572 VideoOutputXv: DiscardFrames(0)
1962008-12-12 16:46:56.587 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1972008-12-12 16:46:56.587 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
1982008-12-12 16:46:56.587 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
1992008-12-12 16:46:56.591 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
2002008-12-12 16:46:56.591 No codec context. Returning false
2012008-12-12 16:46:56.592 AFD: DVD Title Changed
2022008-12-12 16:46:56.592 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2032008-12-12 16:46:56.592 Position map filled from DB to: 0
2042008-12-12 16:46:56.592 SyncPositionMap prerecorded, from DB: 1 entries
2052008-12-12 16:46:56.592 SyncPositionMap, new totframes: 0, new length: 0, posMap size: 1
2062008-12-12 16:46:56.592 AFD: DVD Cell Changed. Update framesPlayed: 0
2072008-12-12 16:46:56.592 DVDNAV_HOP_CHANNEL happened.
2082008-12-12 16:46:56.592 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 0, part == 0 titleParts 0
2092008-12-12 16:46:56.592 DVDNAV_SPU_CLUT_CHANGE happened.
2102008-12-12 16:46:56.592 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==0, current_track==0, total count 1
2112008-12-12 16:46:56.592 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
2122008-12-12 16:46:56.593 FilterManager: GetFilterInfo(convert) returning: 0x0
2132008-12-12 16:46:56.593 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x1575cd30
214greedyhdeint: size changed from 0 x 0 -> 720 x 480
2152008-12-12 16:46:56.593 VideoOutputXv: InputChanged(720,480,1.33333) 'MPEG2'->'MPEG2'
2162008-12-12 16:46:56.593 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
2172008-12-12 16:46:56.595 FilterManager: GetFilterInfo(convert) returning: 0x0
2182008-12-12 16:46:56.595 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x7f3990a17af0
219greedyhdeint: size changed from 0 x 0 -> 720 x 480
2202008-12-12 16:46:56.595 Using deinterlace method greedyhdeint
2212008-12-12 16:46:56.596 Using deinterlace method greedyhdeint
2222008-12-12 16:46:56.597 VideoOutputXv: DiscardFrames(1)
2232008-12-12 16:46:56.597 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2242008-12-12 16:46:56.597 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2252008-12-12 16:46:56.597 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2262008-12-12 16:46:56.597 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2272008-12-12 16:46:56.603 Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
2282008-12-12 16:46:56.603 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
2292008-12-12 16:46:56.697 nVidiaVideoSync: VBlank ioctl did not work, unimplemented in this driver?
2302008-12-12 16:46:56.697 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2312008-12-12 16:46:56.697 OpenGLVideoSync()
2322008-12-12 16:46:56.704 OpenGLVideoSync: x,y -> 960, 540
2332008-12-12 16:46:56.729 Using OpenGLVideoSync
2342008-12-12 16:46:56.746 Using audio as timebase
2352008-12-12 16:46:56.746 Video timing method: SGI OpenGL
2362008-12-12 16:46:56.746 Refresh rate: 16666, frame interval: 33366
2372008-12-12 16:46:56.754 NVP: ClearAfterSeek(1)
2382008-12-12 16:46:56.754 VideoOutputXv: ClearAfterSeek()
2392008-12-12 16:46:56.754 VideoOutputXv: DiscardFrames(0)
2402008-12-12 16:46:56.754 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2412008-12-12 16:46:56.754 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2422008-12-12 16:46:56.754 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2432008-12-12 16:46:56.754 NVP: LoadFilters(''..) -> 0x0
2442008-12-12 16:46:56.754 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
2452008-12-12 16:46:56.755 Entering DVD Still Frame
2462008-12-12 16:46:56.755 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
2472008-12-12 16:46:56.755 AFD: Looking for decoder for MPEG2VIDEO
2482008-12-12 16:46:56.755 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
249                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
2502008-12-12 16:46:56.756 VideoOutputXv: InputChanged(720,480,1.33333) 'MPEG2'->'MPEG2'
2512008-12-12 16:46:56.756 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
2522008-12-12 16:46:56.757 FilterManager: GetFilterInfo(convert) returning: 0x0
2532008-12-12 16:46:56.757 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x166c0640
254greedyhdeint: size changed from 0 x 0 -> 720 x 480
2552008-12-12 16:46:56.759 Using deinterlace method greedyhdeint
2562008-12-12 16:46:56.759 VideoOutputXv: DiscardFrames(1)
2572008-12-12 16:46:56.759 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2582008-12-12 16:46:56.759 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2592008-12-12 16:46:56.759 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2602008-12-12 16:46:56.759 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2612008-12-12 16:46:56.763 NVP, Error: In DVD Menu: No video frames in queue
2622008-12-12 16:46:56.764 Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
2632008-12-12 16:46:56.764 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.33333
2642008-12-12 16:46:56.764 VDP: LoadBestPreferences(720x480, 29.97)
2652008-12-12 16:46:56.773 NVP, Error: In DVD Menu: No video frames in queue
2662008-12-12 16:46:56.784 NVP, Error: In DVD Menu: No video frames in queue
2672008-12-12 16:46:56.794 NVP, Error: In DVD Menu: No video frames in queue
2682008-12-12 16:46:56.805 NVP, Error: In DVD Menu: No video frames in queue
2692008-12-12 16:46:56.815 NVP, Error: In DVD Menu: No video frames in queue
2702008-12-12 16:46:56.826 NVP, Error: In DVD Menu: No video frames in queue
2712008-12-12 16:46:56.836 NVP, Error: In DVD Menu: No video frames in queue
2722008-12-12 16:46:56.847 NVP, Error: In DVD Menu: No video frames in queue
2732008-12-12 16:46:56.857 NVP, Error: In DVD Menu: No video frames in queue
2742008-12-12 16:46:56.867 NVP, Error: In DVD Menu: No video frames in queue
2752008-12-12 16:46:56.877 NVP, Error: In DVD Menu: No video frames in queue
2762008-12-12 16:46:56.887 NVP: ClearAfterSeek(1)
2772008-12-12 16:46:56.887 VideoOutputXv: ClearAfterSeek()
2782008-12-12 16:46:56.887 VideoOutputXv: DiscardFrames(0)
2792008-12-12 16:46:56.887 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2802008-12-12 16:46:56.887 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2812008-12-12 16:46:56.887 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2822008-12-12 16:46:56.887 NVP: LoadFilters(''..) -> 0x0
2832008-12-12 16:46:56.887 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
2842008-12-12 16:46:56.887 AFD: DVD Cell Changed. Update framesPlayed: 0
2852008-12-12 16:46:56.887 AFD: HandleGopStart: gopset not set, syncing positionMap
2862008-12-12 16:46:56.887 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
2872008-12-12 16:46:56.887 DVDNAV_HOP_CHANNEL happened.
2882008-12-12 16:46:56.887 NVP, Error: In DVD Menu: No video frames in queue
2892008-12-12 16:46:56.887 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 0, part == 0 titleParts 0
2902008-12-12 16:46:56.888 Leaving DVD Still Frame
2912008-12-12 16:46:56.888 DVDNAV_SPU_CLUT_CHANGE happened.
2922008-12-12 16:46:56.888 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==0, current_track==0, total count 1
2932008-12-12 16:46:56.888 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
2942008-12-12 16:46:56.889 AFD: HandleGopStart: gopset not set, syncing positionMap
2952008-12-12 16:46:56.889 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
2962008-12-12 16:46:56.889 Entering DVD Still Frame
2972008-12-12 16:46:56.896 AFD: DVD Cell Changed. Update framesPlayed: 0
2982008-12-12 16:46:56.897 No codec context. Returning false
2992008-12-12 16:46:56.897 DVDRB: Entering DVDNAV_WAIT
3002008-12-12 16:46:56.898 DVDRB: Exiting DVDNAV_WAIT status
3012008-12-12 16:46:56.931 VideoOutputXv: UpdatePauseFrame() uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3022008-12-12 16:47:06.888 DVDNAV_VTS_CHANGE: old_vtsN==4, new_vtsN==1, aspect: 3, perm: 1
3032008-12-12 16:47:06.888 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
3042008-12-12 16:47:06.888 Video Rect    left: 0, top: 0, width: 720, height: 480, aspect: 1.77778
3052008-12-12 16:47:06.888 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 3, part == 1 titleParts 1
3062008-12-12 16:47:06.888 Leaving DVD Still Frame
3072008-12-12 16:47:06.888 DVDNAV_SPU_CLUT_CHANGE happened.
3082008-12-12 16:47:06.888 DVDNAV_SPU_STREAM_CHANGE: physical_wide==-1, physical_letterbox==-1, physical_pan_scan==-1, current_track==-1, total count 0
3092008-12-12 16:47:06.888 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
3102008-12-12 16:47:06.890 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
3112008-12-12 16:47:06.890 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
3122008-12-12 16:47:06.891 FilterManager: GetFilterInfo(convert) returning: 0x0
3132008-12-12 16:47:06.891 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x1598d7f0
314greedyhdeint: size changed from 0 x 0 -> 720 x 480
3152008-12-12 16:47:06.891 Using deinterlace method greedyhdeint
3162008-12-12 16:47:06.891 VideoOutputXv: DiscardFrames(1)
3172008-12-12 16:47:06.891 VideoBuffers::DiscardFrames(1): uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3182008-12-12 16:47:06.892 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3192008-12-12 16:47:06.892 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3202008-12-12 16:47:06.892 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3212008-12-12 16:47:06.896 VDP: LoadBestPreferences(720x480, 29.97)
3222008-12-12 16:47:07.019 NVP: ClearAfterSeek(1)
3232008-12-12 16:47:07.019 VideoOutputXv: ClearAfterSeek()
3242008-12-12 16:47:07.019 VideoOutputXv: DiscardFrames(0)
3252008-12-12 16:47:07.020 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3262008-12-12 16:47:07.020 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3272008-12-12 16:47:07.020 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3282008-12-12 16:47:07.021 NVP: LoadFilters(''..) -> 0x0
3292008-12-12 16:47:07.021 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
3302008-12-12 16:47:07.021 Entering DVD Still Frame
3312008-12-12 16:47:07.024 AFD: DVD Title Changed
3322008-12-12 16:47:07.025 AFD: DVD Cell Changed. Update framesPlayed: 0
3332008-12-12 16:47:07.025 No codec context. Returning false
3342008-12-12 16:47:07.025 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
3352008-12-12 16:47:07.025 AFD: Looking for decoder for MPEG2VIDEO
3362008-12-12 16:47:07.025 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
337                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
3382008-12-12 16:47:07.025 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
3392008-12-12 16:47:07.025 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
3402008-12-12 16:47:07.026 FilterManager: GetFilterInfo(convert) returning: 0x0
3412008-12-12 16:47:07.027 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x1594c9a0
342greedyhdeint: size changed from 0 x 0 -> 720 x 480
3432008-12-12 16:47:07.027 Using deinterlace method greedyhdeint
3442008-12-12 16:47:07.027 VideoOutputXv: DiscardFrames(1)
3452008-12-12 16:47:07.027 VideoBuffers::DiscardFrames(1): AAuLAAAAAAAAAAAAAAAAAAAAAAAAAAA
3462008-12-12 16:47:07.027 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3472008-12-12 16:47:07.027 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3482008-12-12 16:47:07.027 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3492008-12-12 16:47:07.030 NVP, Error: In DVD Menu: No video frames in queue
3502008-12-12 16:47:07.033 VDP: LoadBestPreferences(720x480, 29.97)
3512008-12-12 16:47:07.040 NVP, Error: In DVD Menu: No video frames in queue
3522008-12-12 16:47:07.050 NVP, Error: In DVD Menu: No video frames in queue
3532008-12-12 16:47:07.061 NVP, Error: In DVD Menu: No video frames in queue
3542008-12-12 16:47:07.071 NVP, Error: In DVD Menu: No video frames in queue
3552008-12-12 16:47:07.082 NVP, Error: In DVD Menu: No video frames in queue
3562008-12-12 16:47:07.092 NVP, Error: In DVD Menu: No video frames in queue
3572008-12-12 16:47:07.102 NVP, Error: In DVD Menu: No video frames in queue
3582008-12-12 16:47:07.112 NVP, Error: In DVD Menu: No video frames in queue
3592008-12-12 16:47:07.122 NVP, Error: In DVD Menu: No video frames in queue
3602008-12-12 16:47:07.133 NVP, Error: In DVD Menu: No video frames in queue
3612008-12-12 16:47:07.143 NVP, Error: In DVD Menu: No video frames in queue
3622008-12-12 16:47:07.153 NVP, Error: In DVD Menu: No video frames in queue
3632008-12-12 16:47:07.158 NVP: ClearAfterSeek(1)
3642008-12-12 16:47:07.158 VideoOutputXv: ClearAfterSeek()
3652008-12-12 16:47:07.158 VideoOutputXv: DiscardFrames(0)
3662008-12-12 16:47:07.158 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3672008-12-12 16:47:07.158 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3682008-12-12 16:47:07.158 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3692008-12-12 16:47:07.158 NVP: LoadFilters(''..) -> 0x0
3702008-12-12 16:47:07.158 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
371libdvdnav: RANDOM or SHUFFLE titles are NOT handled yet.
3722008-12-12 16:47:07.158 DVDNAV_VTS_CHANGE: old_vtsN==1, new_vtsN==2, aspect: 3, perm: 2
3732008-12-12 16:47:07.158 DVDNAV_CELL_CHANGE: pg_length == 810000, pgc_length == 810000, cell_start == 0, pg_start == 0, title == 2, part == 1 titleParts 2
3742008-12-12 16:47:07.158 Leaving DVD Still Frame
3752008-12-12 16:47:07.158 DVDNAV_SPU_CLUT_CHANGE happened.
3762008-12-12 16:47:07.159 DVDNAV_SPU_STREAM_CHANGE: physical_wide==-1, physical_letterbox==-1, physical_pan_scan==-1, current_track==-1, total count 0
3772008-12-12 16:47:07.159 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
3782008-12-12 16:47:07.163 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
3792008-12-12 16:47:07.163 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3802008-12-12 16:47:07.164 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
3812008-12-12 16:47:07.165 FilterManager: GetFilterInfo(convert) returning: 0x0
3822008-12-12 16:47:07.165 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x1598ca60
383greedyhdeint: size changed from 0 x 0 -> 720 x 480
3842008-12-12 16:47:07.165 Using deinterlace method greedyhdeint
3852008-12-12 16:47:07.165 VideoOutputXv: DiscardFrames(1)
3862008-12-12 16:47:07.165 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3872008-12-12 16:47:07.165 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3882008-12-12 16:47:07.165 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3892008-12-12 16:47:07.165 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3902008-12-12 16:47:07.170 VDP: LoadBestPreferences(720x480, 29.97)
3912008-12-12 16:47:07.296 NVP: ClearAfterSeek(1)
3922008-12-12 16:47:07.296 VideoOutputXv: ClearAfterSeek()
3932008-12-12 16:47:07.296 VideoOutputXv: DiscardFrames(0)
3942008-12-12 16:47:07.296 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3952008-12-12 16:47:07.296 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3962008-12-12 16:47:07.296 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3972008-12-12 16:47:07.296 NVP: LoadFilters(''..) -> 0x0
3982008-12-12 16:47:07.296 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
3992008-12-12 16:47:07.296 Entering DVD Still Frame
400libdvdnav: RANDOM or SHUFFLE titles are NOT handled yet.
4012008-12-12 16:47:07.296 AFD: DVD Title Changed
4022008-12-12 16:47:07.296 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
4032008-12-12 16:47:07.296 Position map filled from DB to: 269
4042008-12-12 16:47:07.296 SyncPositionMap prerecorded, from DB: 1 entries
4052008-12-12 16:47:07.296 SyncPositionMap, new totframes: 269, new length: 9, posMap size: 1
4062008-12-12 16:47:07.296 AFD: DVD Cell Changed. Update framesPlayed: 0
4072008-12-12 16:47:07.297 Leaving DVD Still Frame
4082008-12-12 16:47:07.297 DVDNAV_HOP_CHANNEL happened.
4092008-12-12 16:47:07.297 DVDNAV_CELL_CHANGE: pg_length == 810000, pgc_length == 810000, cell_start == 0, pg_start == 0, title == 2, part == 1 titleParts 2
4102008-12-12 16:47:07.297 DVDNAV_SPU_CLUT_CHANGE happened.
4112008-12-12 16:47:07.297 DVDNAV_SPU_STREAM_CHANGE: physical_wide==-1, physical_letterbox==-1, physical_pan_scan==-1, current_track==-1, total count 0
4122008-12-12 16:47:07.297 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
4132008-12-12 16:47:07.297 AFD: DVD Cell Changed. Update framesPlayed: 0
4142008-12-12 16:47:07.297 AFD: HandleGopStart: gopset not set, syncing positionMap
4152008-12-12 16:47:07.297 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
4162008-12-12 16:47:07.297 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x14a97450
4172008-12-12 16:47:07.297 AFD: Looking for decoder for MPEG2VIDEO
4182008-12-12 16:47:07.297 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB)
419                         -> threshhold(64 KB) min read(32 KB) blk size(256 KB)
4202008-12-12 16:47:07.297 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
4212008-12-12 16:47:07.297 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
4222008-12-12 16:47:07.299 FilterManager: GetFilterInfo(convert) returning: 0x0
4232008-12-12 16:47:07.299 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x166c0870
424greedyhdeint: size changed from 0 x 0 -> 720 x 480
4252008-12-12 16:47:07.299 Using deinterlace method greedyhdeint
4262008-12-12 16:47:07.299 VideoOutputXv: DiscardFrames(1)
4272008-12-12 16:47:07.299 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4282008-12-12 16:47:07.299 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4292008-12-12 16:47:07.299 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4302008-12-12 16:47:07.299 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4312008-12-12 16:47:07.305 VDP: LoadBestPreferences(720x480, 29.97)
4322008-12-12 16:47:07.313 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4332008-12-12 16:47:07.429 NVP: ClearAfterSeek(1)
4342008-12-12 16:47:07.429 VideoOutputXv: ClearAfterSeek()
4352008-12-12 16:47:07.429 VideoOutputXv: DiscardFrames(0)
4362008-12-12 16:47:07.429 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4372008-12-12 16:47:07.429 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4382008-12-12 16:47:07.429 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4392008-12-12 16:47:07.429 NVP: LoadFilters(''..) -> 0x0
4402008-12-12 16:47:07.429 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
4412008-12-12 16:47:07.429 AFD: HandleGopStart: gopset not set, syncing positionMap
4422008-12-12 16:47:07.429 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
4432008-12-12 16:47:07.432 No codec context. Returning false
4442008-12-12 16:47:07.432 Dec: Trying to select track (w/lang)
4452008-12-12 16:47:07.432 Dec: Selecting first track
4462008-12-12 16:47:07.432 Dec: Selected track #1 in the Unknown language(0)
4472008-12-12 16:47:07.433 No codec context. Returning false
4482008-12-12 16:47:07.434 No codec context. Returning false
4492008-12-12 16:47:07.435 No codec context. Returning false
4502008-12-12 16:47:07.436 No codec context. Returning false
4512008-12-12 16:47:07.437 No codec context. Returning false
4522008-12-12 16:47:07.443 No codec context. Returning false
4532008-12-12 16:47:07.446 AFD: HandleGopStart: gopset not set, syncing positionMap
4542008-12-12 16:47:07.446 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
4552008-12-12 16:47:07.446 AFD: HandleGopStart: Initial key frame distance: 15.
4562008-12-12 16:47:07.448 No codec context. Returning false
4572008-12-12 16:47:07.448 AFD: HandleGopStart: Key frame distance changed from 8 to 1.
4582008-12-12 16:47:07.450 No codec context. Returning false
4592008-12-12 16:47:07.452 No codec context. Returning false
4602008-12-12 16:47:07.455 No codec context. Returning false
4612008-12-12 16:47:07.457 No codec context. Returning false
4622008-12-12 16:47:07.460 No codec context. Returning false
4632008-12-12 16:47:07.462 No codec context. Returning false
4642008-12-12 16:47:07.465 No codec context. Returning false
4652008-12-12 16:47:07.466 AFD: HandleStreamChange(): streams_changed 0x14a9d220 -- stream count 2
4662008-12-12 16:47:07.466 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 9800000 at 0x0x14a97450
4672008-12-12 16:47:07.466 NVP: progressive frame seen after 2 interlaced  frames
4682008-12-12 16:47:07.466 Disabled deinterlacing
4692008-12-12 16:47:07.468 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
4702008-12-12 16:47:07.468 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
4712008-12-12 16:47:07.468 VDP: LoadBestPreferences(2048x2048, 0)
4722008-12-12 16:47:07.468 VDP: LoadBestPreferences(2048x2048, 60)
4732008-12-12 16:47:07.468 VDP: LoadBestPreferences(720x480, 60)
4742008-12-12 16:47:07.470 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
4752008-12-12 16:47:07.470 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
4762008-12-12 16:47:07.470 VDP: LoadBestPreferences(2048x2048, 0)
4772008-12-12 16:47:07.470 VDP: LoadBestPreferences(2048x2048, 60)
4782008-12-12 16:47:07.470 VDP: LoadBestPreferences(720x480, 60)
4792008-12-12 16:47:07.470 Using 1 CPUs for decoding
4802008-12-12 16:47:07.470 AFD: Warning, video codec 0x14aa8ed0 id(MPEG2VIDEO) type (Video) already open.
4812008-12-12 16:47:07.470 AFD: InitVideoCodec() 0x14aa8ed0 id(MPEG2VIDEO) type (Video).
4822008-12-12 16:47:07.470 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
4832008-12-12 16:47:07.470 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
4842008-12-12 16:47:07.471 FilterManager: GetFilterInfo(convert) returning: 0x0
4852008-12-12 16:47:07.471 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x166c0670
486greedyhdeint: size changed from 0 x 0 -> 720 x 480
4872008-12-12 16:47:07.472 Using deinterlace method greedyhdeint
4882008-12-12 16:47:07.472 VideoOutputXv: DiscardFrames(1)
4892008-12-12 16:47:07.472 VideoBuffers::DiscardFrames(1): AAAAUUUUUUUUUUUUuUULAAAAAAAAAAA
4902008-12-12 16:47:07.472 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4912008-12-12 16:47:07.472 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4922008-12-12 16:47:07.472 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4932008-12-12 16:47:07.476 VDP: LoadBestPreferences(720x480, 29.97)
4942008-12-12 16:47:07.484 NVP: prebuffering pause
4952008-12-12 16:47:07.484 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4962008-12-12 16:47:07.601 NVP: ClearAfterSeek(1)
4972008-12-12 16:47:07.601 VideoOutputXv: ClearAfterSeek()
4982008-12-12 16:47:07.601 VideoOutputXv: DiscardFrames(0)
4992008-12-12 16:47:07.601 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5002008-12-12 16:47:07.601 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5012008-12-12 16:47:07.601 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5022008-12-12 16:47:07.601 NVP: LoadFilters(''..) -> 0x0
5032008-12-12 16:47:07.601 detectInterlace(Detect Scan, Progressive Scan, 29.97, 480) ->Interlaced Scan
5042008-12-12 16:47:07.602 Enabled deinterlacing
5052008-12-12 16:47:07.602 AFD: Using ffmpeg for video decoding
5062008-12-12 16:47:07.602 AFD: Looking for decoder for MPEG2VIDEO
5072008-12-12 16:47:07.602 AFD: Stream #1, has id 0x128 codec id AC3, type Audio, bitrate 0 at 0x0x15610d90
5082008-12-12 16:47:07.602 AFD: codec AC3 has 0 channels
5092008-12-12 16:47:07.602 AFD: Looking for decoder for AC3
5102008-12-12 16:47:07.602 AFD: Opened codec 0x1563d210, id(AC3) type(Audio)
5112008-12-12 16:47:07.602 RingBuf(/dev/dvd): CalcReadAheadThresh(9800 KB)
512                         -> threshhold(64 KB) min read(32 KB) blk size(256 KB)
5132008-12-12 16:47:07.605 Opening audio device 'default'. ch 2(2) sr 48000
5142008-12-12 16:47:07.605 Opening ALSA audio device 'default'.
5152008-12-12 16:47:07.629 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5162008-12-12 16:47:07.641 NVP: Enabling Audio
5172008-12-12 16:47:07.643 Opening audio device 'default'. ch 2(2) sr 48000
5182008-12-12 16:47:07.643 Opening ALSA audio device 'default'.
5192008-12-12 16:47:07.648 Dec: Trying to reselect track
5202008-12-12 16:47:07.648 Dec: Selected track #1 in the Unknown language(0)
5212008-12-12 16:47:07.679 NVP: progressive frame seen after 2 interlaced  frames
5222008-12-12 16:47:07.679 Disabled deinterlacing
5232008-12-12 16:47:07.730 NVP: Video is 3.54403 frames ahead of audio,
524                        doubling video frame interval to slow down.
5252008-12-12 16:47:07.791 GetNextFreeFrame() served a busy frame 3. Dropping. UUUUUUUUUUUUUUUUAuLUAAUUUUUUUUU
5262008-12-12 16:47:07.798 NVP: Video is 6.19454 frames ahead of audio,
527                        doubling video frame interval to slow down.
5282008-12-12 16:47:07.864 NVP: Video is 7.93517 frames ahead of audio,
529                        doubling video frame interval to slow down.
5302008-12-12 16:47:07.930 NVP: Video is 8.99338 frames ahead of audio,
531                        doubling video frame interval to slow down.
5322008-12-12 16:47:07.997 NVP: Video is 9.54726 frames ahead of audio,
533                        doubling video frame interval to slow down.
5342008-12-12 16:47:08.064 NVP: Video is 9.70794 frames ahead of audio,
535                        doubling video frame interval to slow down.
5362008-12-12 16:47:08.130 NVP: Video is 9.5737 frames ahead of audio,
537                        doubling video frame interval to slow down.
5382008-12-12 16:47:08.197 NVP: Video is 9.23326 frames ahead of audio,
539                        doubling video frame interval to slow down.
5402008-12-12 16:47:08.264 NVP: Video is 8.72316 frames ahead of audio,
541                        doubling video frame interval to slow down.
5422008-12-12 16:47:08.330 NVP: Video is 8.08584 frames ahead of audio,
543                        doubling video frame interval to slow down.
5442008-12-12 16:47:08.397 NVP: Video is 7.36061 frames ahead of audio,
545                        doubling video frame interval to slow down.
5462008-12-12 16:47:08.464 NVP: Video is 6.56941 frames ahead of audio,
547                        doubling video frame interval to slow down.
5482008-12-12 16:47:08.530 NVP: Video is 5.72127 frames ahead of audio,
549                        doubling video frame interval to slow down.
5502008-12-12 16:47:08.597 NVP: Video is 4.83792 frames ahead of audio,
551                        doubling video frame interval to slow down.
5522008-12-12 16:47:08.664 NVP: Video is 3.92813 frames ahead of audio,
553                        doubling video frame interval to slow down.
554'video_output' mean = '40295.15', std. dev. = '21205.01', fps = '24.82'
555'video_output' mean = '33334.17', std. dev. = '300.42', fps = '30.00'
5562008-12-12 16:47:15.380 DVDNAV_VTS_CHANGE: old_vtsN==2, new_vtsN==1, aspect: 3, perm: 1
5572008-12-12 16:47:15.381 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 3, part == 1 titleParts 1
5582008-12-12 16:47:15.381 DVDNAV_SPU_CLUT_CHANGE happened.
5592008-12-12 16:47:15.381 DVDNAV_SPU_STREAM_CHANGE: physical_wide==-1, physical_letterbox==-1, physical_pan_scan==-1, current_track==-1, total count 0
5602008-12-12 16:47:15.381 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
5612008-12-12 16:47:15.381 AFD: DVD Title Changed
5622008-12-12 16:47:15.382 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
5632008-12-12 16:47:15.382 Position map filled from DB to: 0
5642008-12-12 16:47:15.382 SyncPositionMap prerecorded, from DB: 1 entries
5652008-12-12 16:47:15.382 SyncPositionMap, new totframes: 0, new length: 0, posMap size: 1
5662008-12-12 16:47:15.382 AFD: DVD Cell Changed. Update framesPlayed: 0
5672008-12-12 16:47:15.382 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
5682008-12-12 16:47:15.382 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
5692008-12-12 16:47:15.383 FilterManager: GetFilterInfo(convert) returning: 0x0
5702008-12-12 16:47:15.383 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x15513b50
571greedyhdeint: size changed from 0 x 0 -> 720 x 480
5722008-12-12 16:47:15.384 Using deinterlace method greedyhdeint
5732008-12-12 16:47:15.384 VideoOutputXv: DiscardFrames(1)
5742008-12-12 16:47:15.384 VideoBuffers::DiscardFrames(1): UUAUUUUUUUUUUUUUUUULuUUuUUUUUUU
5752008-12-12 16:47:15.384 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5762008-12-12 16:47:15.384 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5772008-12-12 16:47:15.384 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5782008-12-12 16:47:15.417 NVP: prebuffering pause
5792008-12-12 16:47:15.417 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5802008-12-12 16:47:15.526 NVP: ClearAfterSeek(1)
5812008-12-12 16:47:15.526 VideoOutputXv: ClearAfterSeek()
5822008-12-12 16:47:15.526 VideoOutputXv: DiscardFrames(0)
5832008-12-12 16:47:15.526 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5842008-12-12 16:47:15.526 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5852008-12-12 16:47:15.526 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5862008-12-12 16:47:15.527 NVP: LoadFilters(''..) -> 0x0
5872008-12-12 16:47:15.527 detectInterlace(Detect Scan, Progressive Scan, 29.97, 480) ->Interlaced Scan
5882008-12-12 16:47:15.527 Enabled deinterlacing
5892008-12-12 16:47:15.527 Entering DVD Still Frame
5902008-12-12 16:47:15.527 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
5912008-12-12 16:47:15.527 AFD: Looking for decoder for MPEG2VIDEO
5922008-12-12 16:47:15.527 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
593                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
5942008-12-12 16:47:15.527 NVP: Disabling Audio, params(-1,-1,-1)
5952008-12-12 16:47:15.527 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
5962008-12-12 16:47:15.527 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
5972008-12-12 16:47:15.529 FilterManager: GetFilterInfo(convert) returning: 0x0
5982008-12-12 16:47:15.529 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x16831e30
599greedyhdeint: size changed from 0 x 0 -> 720 x 480
6002008-12-12 16:47:15.529 Using deinterlace method greedyhdeint
6012008-12-12 16:47:15.530 VideoOutputXv: DiscardFrames(1)
6022008-12-12 16:47:15.530 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6032008-12-12 16:47:15.530 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6042008-12-12 16:47:15.530 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6052008-12-12 16:47:15.530 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6062008-12-12 16:47:15.534 VDP: LoadBestPreferences(720x480, 29.97)
6072008-12-12 16:47:15.563 NVP, Error: In DVD Menu: No video frames in queue
6082008-12-12 16:47:15.573 NVP, Error: In DVD Menu: No video frames in queue
6092008-12-12 16:47:15.583 NVP, Error: In DVD Menu: No video frames in queue
6102008-12-12 16:47:15.593 NVP, Error: In DVD Menu: No video frames in queue
6112008-12-12 16:47:15.603 NVP, Error: In DVD Menu: No video frames in queue
6122008-12-12 16:47:15.614 NVP, Error: In DVD Menu: No video frames in queue
6132008-12-12 16:47:15.624 NVP, Error: In DVD Menu: No video frames in queue
6142008-12-12 16:47:15.634 NVP, Error: In DVD Menu: No video frames in queue
6152008-12-12 16:47:15.644 NVP, Error: In DVD Menu: No video frames in queue
6162008-12-12 16:47:15.654 NVP, Error: In DVD Menu: No video frames in queue
6172008-12-12 16:47:15.664 NVP, Error: In DVD Menu: No video frames in queue
6182008-12-12 16:47:15.667 NVP: ClearAfterSeek(1)
6192008-12-12 16:47:15.667 VideoOutputXv: ClearAfterSeek()
6202008-12-12 16:47:15.667 VideoOutputXv: DiscardFrames(0)
6212008-12-12 16:47:15.667 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6222008-12-12 16:47:15.667 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6232008-12-12 16:47:15.667 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6242008-12-12 16:47:15.667 NVP: LoadFilters(''..) -> 0x0
6252008-12-12 16:47:15.667 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
6262008-12-12 16:47:15.667 AFD: HandleGopStart: gopset not set, syncing positionMap
6272008-12-12 16:47:15.667 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
6282008-12-12 16:47:15.670 No codec context. Returning false
6292008-12-12 16:47:15.670 DVDNAV_HOP_CHANNEL happened.
6302008-12-12 16:47:15.670 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 3, part == 1 titleParts 1
6312008-12-12 16:47:15.670 Leaving DVD Still Frame
6322008-12-12 16:47:15.671 DVDNAV_SPU_CLUT_CHANGE happened.
6332008-12-12 16:47:15.671 DVDNAV_SPU_STREAM_CHANGE: physical_wide==-1, physical_letterbox==-1, physical_pan_scan==-1, current_track==-1, total count 0
6342008-12-12 16:47:15.671 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
6352008-12-12 16:47:15.671 AFD: HandleGopStart: gopset not set, syncing positionMap
6362008-12-12 16:47:15.671 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
6372008-12-12 16:47:15.671 AFD: HandleGopStart: Initial key frame distance: 15.
6382008-12-12 16:47:15.671 Entering DVD Still Frame
6392008-12-12 16:47:15.674 AFD: DVD Cell Changed. Update framesPlayed: 0
6402008-12-12 16:47:15.674 No codec context. Returning false
6412008-12-12 16:47:15.675 DVDNAV_VTS_CHANGE: old_vtsN==1, new_vtsN==4, aspect: 3, perm: 1
6422008-12-12 16:47:15.675 NVP: progressive frame seen after 2 interlaced  frames
6432008-12-12 16:47:15.675 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 0, part == 3 titleParts 0
6442008-12-12 16:47:15.675 Disabled deinterlacing
6452008-12-12 16:47:15.675 Leaving DVD Still Frame
6462008-12-12 16:47:15.675 DVDNAV_SPU_CLUT_CHANGE happened.
6472008-12-12 16:47:15.675 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==1, current_track==0, total count 1
6482008-12-12 16:47:15.675 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 0
6492008-12-12 16:47:15.756 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
6502008-12-12 16:47:15.756 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
6512008-12-12 16:47:15.757 FilterManager: GetFilterInfo(convert) returning: 0x0
6522008-12-12 16:47:15.757 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x16832430
653greedyhdeint: size changed from 0 x 0 -> 720 x 480
6542008-12-12 16:47:15.757 Using deinterlace method greedyhdeint
6552008-12-12 16:47:15.758 VideoOutputXv: DiscardFrames(1)
6562008-12-12 16:47:15.758 VideoBuffers::DiscardFrames(1): AAAAAAALAAAAAAAAAAAAAAAAuAAAAAA
6572008-12-12 16:47:15.758 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6582008-12-12 16:47:15.758 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6592008-12-12 16:47:15.758 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6602008-12-12 16:47:15.762 VDP: LoadBestPreferences(720x480, 29.97)
6612008-12-12 16:47:15.788 VideoOutputXv: UpdatePauseFrame() AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6622008-12-12 16:47:15.891 NVP: ClearAfterSeek(1)
6632008-12-12 16:47:15.891 VideoOutputXv: ClearAfterSeek()
6642008-12-12 16:47:15.891 VideoOutputXv: DiscardFrames(0)
6652008-12-12 16:47:15.891 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6662008-12-12 16:47:15.891 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6672008-12-12 16:47:15.891 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6682008-12-12 16:47:15.891 NVP: LoadFilters(''..) -> 0x0
6692008-12-12 16:47:15.891 detectInterlace(Detect Scan, Progressive Scan, 29.97, 480) ->Interlaced Scan
6702008-12-12 16:47:15.891 Enabled deinterlacing
6712008-12-12 16:47:15.891 Entering DVD Still Frame
6722008-12-12 16:47:15.896 NVP, Error: In DVD Menu: No video frames in queue
6732008-12-12 16:47:15.902 AFD: DVD Title Changed
6742008-12-12 16:47:15.903 AFD: DVD Cell Changed. Update framesPlayed: 0
6752008-12-12 16:47:15.903 No codec context. Returning false
6762008-12-12 16:47:15.903 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
6772008-12-12 16:47:15.903 AFD: Looking for decoder for MPEG2VIDEO
6782008-12-12 16:47:15.903 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
679                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
6802008-12-12 16:47:15.903 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
6812008-12-12 16:47:15.903 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
6822008-12-12 16:47:15.904 FilterManager: GetFilterInfo(convert) returning: 0x0
6832008-12-12 16:47:15.904 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x1594d1d0
684greedyhdeint: size changed from 0 x 0 -> 720 x 480
6852008-12-12 16:47:15.904 Using deinterlace method greedyhdeint
6862008-12-12 16:47:15.904 VideoOutputXv: DiscardFrames(1)
6872008-12-12 16:47:15.904 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAALAuA
6882008-12-12 16:47:15.904 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6892008-12-12 16:47:15.904 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6902008-12-12 16:47:15.905 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6912008-12-12 16:47:15.906 NVP, Error: In DVD Menu: No video frames in queue
6922008-12-12 16:47:15.909 VDP: LoadBestPreferences(720x480, 29.97)
6932008-12-12 16:47:15.916 NVP, Error: In DVD Menu: No video frames in queue
6942008-12-12 16:47:15.927 NVP, Error: In DVD Menu: No video frames in queue
6952008-12-12 16:47:15.937 NVP, Error: In DVD Menu: No video frames in queue
6962008-12-12 16:47:15.947 NVP, Error: In DVD Menu: No video frames in queue
6972008-12-12 16:47:15.957 NVP, Error: In DVD Menu: No video frames in queue
6982008-12-12 16:47:15.967 NVP, Error: In DVD Menu: No video frames in queue
6992008-12-12 16:47:15.977 NVP, Error: In DVD Menu: No video frames in queue
7002008-12-12 16:47:15.987 NVP, Error: In DVD Menu: No video frames in queue
7012008-12-12 16:47:15.998 NVP, Error: In DVD Menu: No video frames in queue
7022008-12-12 16:47:16.008 NVP, Error: In DVD Menu: No video frames in queue
7032008-12-12 16:47:16.018 NVP, Error: In DVD Menu: No video frames in queue
7042008-12-12 16:47:16.028 NVP, Error: In DVD Menu: No video frames in queue
7052008-12-12 16:47:16.036 NVP: ClearAfterSeek(1)
7062008-12-12 16:47:16.036 VideoOutputXv: ClearAfterSeek()
7072008-12-12 16:47:16.036 VideoOutputXv: DiscardFrames(0)
7082008-12-12 16:47:16.036 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7092008-12-12 16:47:16.036 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7102008-12-12 16:47:16.036 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7112008-12-12 16:47:16.036 NVP: LoadFilters(''..) -> 0x0
7122008-12-12 16:47:16.036 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
7132008-12-12 16:47:16.036 AFD: HandleStreamChange(): streams_changed 0x14a9d220 -- stream count 2
7142008-12-12 16:47:16.037 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
7152008-12-12 16:47:16.038 NVP, Error: In DVD Menu: No video frames in queue
7162008-12-12 16:47:16.039 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
7172008-12-12 16:47:16.039 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
7182008-12-12 16:47:16.039 VDP: LoadBestPreferences(2048x2048, 0)
7192008-12-12 16:47:16.039 VDP: LoadBestPreferences(2048x2048, 60)
7202008-12-12 16:47:16.039 VDP: LoadBestPreferences(720x480, 60)
7212008-12-12 16:47:16.041 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
7222008-12-12 16:47:16.041 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
7232008-12-12 16:47:16.041 VDP: LoadBestPreferences(2048x2048, 0)
7242008-12-12 16:47:16.041 VDP: LoadBestPreferences(2048x2048, 60)
7252008-12-12 16:47:16.041 VDP: LoadBestPreferences(720x480, 60)
7262008-12-12 16:47:16.041 Using 1 CPUs for decoding
7272008-12-12 16:47:16.041 AFD: Warning, video codec 0x14aa8ed0 id(MPEG2VIDEO) type (Video) already open.
7282008-12-12 16:47:16.041 AFD: InitVideoCodec() 0x14aa8ed0 id(MPEG2VIDEO) type (Video).
7292008-12-12 16:47:16.041 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
7302008-12-12 16:47:16.041 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
7312008-12-12 16:47:16.042 FilterManager: GetFilterInfo(convert) returning: 0x0
7322008-12-12 16:47:16.042 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x16a2df30
733greedyhdeint: size changed from 0 x 0 -> 720 x 480
7342008-12-12 16:47:16.043 Using deinterlace method greedyhdeint
7352008-12-12 16:47:16.043 VideoOutputXv: DiscardFrames(1)
7362008-12-12 16:47:16.043 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7372008-12-12 16:47:16.043 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7382008-12-12 16:47:16.043 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7392008-12-12 16:47:16.043 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7402008-12-12 16:47:16.048 VDP: LoadBestPreferences(720x480, 29.97)
7412008-12-12 16:47:16.048 NVP, Error: In DVD Menu: No video frames in queue
7422008-12-12 16:47:16.058 NVP, Error: In DVD Menu: No video frames in queue
7432008-12-12 16:47:16.069 NVP, Error: In DVD Menu: No video frames in queue
7442008-12-12 16:47:16.079 NVP, Error: In DVD Menu: No video frames in queue
7452008-12-12 16:47:16.089 NVP, Error: In DVD Menu: No video frames in queue
7462008-12-12 16:47:16.099 NVP, Error: In DVD Menu: No video frames in queue
7472008-12-12 16:47:16.109 NVP, Error: In DVD Menu: No video frames in queue
7482008-12-12 16:47:16.119 NVP, Error: In DVD Menu: No video frames in queue
7492008-12-12 16:47:16.130 NVP, Error: In DVD Menu: No video frames in queue
7502008-12-12 16:47:16.140 NVP, Error: In DVD Menu: No video frames in queue
7512008-12-12 16:47:16.150 NVP, Error: In DVD Menu: No video frames in queue
7522008-12-12 16:47:16.160 NVP, Error: In DVD Menu: No video frames in queue
7532008-12-12 16:47:16.170 NVP, Error: In DVD Menu: No video frames in queue
7542008-12-12 16:47:16.174 NVP: ClearAfterSeek(1)
7552008-12-12 16:47:16.174 VideoOutputXv: ClearAfterSeek()
7562008-12-12 16:47:16.174 VideoOutputXv: DiscardFrames(0)
7572008-12-12 16:47:16.174 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7582008-12-12 16:47:16.174 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
7592008-12-12 16:47:16.174 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
7602008-12-12 16:47:16.174 NVP: LoadFilters(''..) -> 0x0
7612008-12-12 16:47:16.174 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
7622008-12-12 16:47:16.174 AFD: Using ffmpeg for video decoding
7632008-12-12 16:47:16.174 AFD: Looking for decoder for MPEG2VIDEO
7642008-12-12 16:47:16.174 AFD: Stream #1, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x16e9d900
7652008-12-12 16:47:16.174 AFD: subtitle codec (Subtitle)
7662008-12-12 16:47:16.174 AFD: Looking for decoder for DVD_SUBTITLE
7672008-12-12 16:47:16.174 AFD: Opened codec 0x15fc17d0, id(DVD_SUBTITLE) type(Subtitle)
7682008-12-12 16:47:16.174 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
7692008-12-12 16:47:16.174 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
770                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
7712008-12-12 16:47:16.174 AFD: DVD Subtitle Track Map Stream id #32 track #-1
7722008-12-12 16:47:16.174 Leaving DVD Still Frame
7732008-12-12 16:47:16.175 DVDNAV_HOP_CHANNEL happened.
7742008-12-12 16:47:16.175 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1
7752008-12-12 16:47:16.175 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 0, part == 3 titleParts 0
7762008-12-12 16:47:16.175 DVDNAV_SPU_CLUT_CHANGE happened.
7772008-12-12 16:47:16.175 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==1, current_track==0, total count 1
7782008-12-12 16:47:16.175 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 0
7792008-12-12 16:47:16.177 Entering DVD Still Frame
7802008-12-12 16:47:16.177 AFD: DVD Cell Changed. Update framesPlayed: 0
7812008-12-12 16:47:16.180 NVP, Error: In DVD Menu: No video frames in queue
7822008-12-12 16:47:16.188 No codec context. Returning false
7832008-12-12 16:47:16.188 Leaving DVD Still Frame
7842008-12-12 16:47:16.188 DVDRB: Clearing Menu SPU Packet
7852008-12-12 16:47:16.188 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1
7862008-12-12 16:47:16.188 AFD: HandleStreamChange(): streams_changed 0x14a9d220 -- stream count 3
7872008-12-12 16:47:16.188 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
7882008-12-12 16:47:16.190 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
7892008-12-12 16:47:16.190 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
7902008-12-12 16:47:16.190 VDP: LoadBestPreferences(2048x2048, 0)
7912008-12-12 16:47:16.190 VDP: LoadBestPreferences(2048x2048, 60)
7922008-12-12 16:47:16.190 VDP: LoadBestPreferences(720x480, 60)
7932008-12-12 16:47:16.192 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,yadifdeint) filt()
7942008-12-12 16:47:16.192 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(greedyhdeint,linearblend) filt()
7952008-12-12 16:47:16.192 VDP: LoadBestPreferences(2048x2048, 0)
7962008-12-12 16:47:16.192 VDP: LoadBestPreferences(2048x2048, 60)
7972008-12-12 16:47:16.192 VDP: LoadBestPreferences(720x480, 60)
7982008-12-12 16:47:16.192 Using 1 CPUs for decoding
7992008-12-12 16:47:16.192 AFD: Warning, video codec 0x14aa8ed0 id(MPEG2VIDEO) type (Video) already open.
8002008-12-12 16:47:16.192 AFD: InitVideoCodec() 0x14aa8ed0 id(MPEG2VIDEO) type (Video).
8012008-12-12 16:47:16.192 AFD: Using ffmpeg for video decoding
8022008-12-12 16:47:16.192 AFD: Looking for decoder for MPEG2VIDEO
8032008-12-12 16:47:16.192 AFD: Stream #1, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x16e9d900
8042008-12-12 16:47:16.193 AFD: subtitle codec (Subtitle)
8052008-12-12 16:47:16.193 AFD: Looking for decoder for DVD_SUBTITLE
8062008-12-12 16:47:16.193 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
8072008-12-12 16:47:16.193 AFD: Stream #2, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x163727c0
8082008-12-12 16:47:16.193 AFD: subtitle codec (Subtitle)
8092008-12-12 16:47:16.193 AFD: Looking for decoder for DVD_SUBTITLE
8102008-12-12 16:47:16.193 AFD: Opened codec 0x1526a4f0, id(DVD_SUBTITLE) type(Subtitle)
8112008-12-12 16:47:16.193 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
8122008-12-12 16:47:16.193 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
813                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
8142008-12-12 16:47:16.193 AFD: DVD Subtitle Track Map Stream id #32 track #-1
8152008-12-12 16:47:16.193 AFD: DVD Subtitle Track Map Stream id #33 track #-1
8162008-12-12 16:47:16.193 DVDRB: Entering DVDNAV_WAIT
8172008-12-12 16:47:16.224 VideoOutputXv: UpdatePauseFrame() LAAAAAAAAAuAAAAAAAAAAAAAAAAAAAA
8182008-12-12 16:47:16.263 DVDRB: Exiting DVDNAV_WAIT status
8192008-12-12 16:47:16.270 Entering DVD Still Frame
8202008-12-12 16:47:24.485 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==2
8212008-12-12 16:47:25.298 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1
8222008-12-12 16:47:26.107 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==2
8232008-12-12 16:47:26.712 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==3
8242008-12-12 16:47:31.771 DVDNAV_HOP_CHANNEL happened.
8252008-12-12 16:47:31.771 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1
8262008-12-12 16:47:31.771 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 0, part == 3 titleParts 0
8272008-12-12 16:47:31.771 Leaving DVD Still Frame
8282008-12-12 16:47:31.771 DVDNAV_SPU_CLUT_CHANGE happened.
8292008-12-12 16:47:31.771 DVDNAV_SPU_STREAM_CHANGE: physical_wide==0, physical_letterbox==0, physical_pan_scan==1, current_track==0, total count 1
8302008-12-12 16:47:31.771 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 0
8312008-12-12 16:47:31.773 Entering DVD Still Frame
8322008-12-12 16:47:31.773 AFD: DVD Cell Changed. Update framesPlayed: 0
8332008-12-12 16:47:31.784 No codec context. Returning false
8342008-12-12 16:47:31.784 Leaving DVD Still Frame
8352008-12-12 16:47:31.784 DVDRB: Clearing Menu SPU Packet
8362008-12-12 16:47:31.785 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==1
8372008-12-12 16:47:31.785 Entering DVD Still Frame
8382008-12-12 16:47:31.829 NVP: progressive frame seen after 2 interlaced  frames
8392008-12-12 16:47:31.830 Disabled deinterlacing
8402008-12-12 16:47:31.880 VideoOutputXv: UpdatePauseFrame() AAAuAAAAAAAALAAAAAAAAAAAAAAAAAA
8412008-12-12 16:47:33.688 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==2
8422008-12-12 16:47:34.403 DVDNAV_HIGHLIGHT: display==1, palette==262212, sx==260, sy==35073, ex==63683, ey==0, pts==302037761, buttonN==3
8432008-12-12 16:47:37.332 TV: Attempting to change from WatchingPreRecorded to None
8442008-12-12 16:47:37.333 TV: StopStuff() -- begin
8452008-12-12 16:47:37.333 TV:  StopStuff() -- get dvd player out of still frame or wait status
8462008-12-12 16:47:37.333 TV: StopStuff(): stopping ring buffer[s]
8472008-12-12 16:47:37.333 TV: StopStuff(): stopping player[s] (1/2)
8482008-12-12 16:47:37.333 TV: StopStuff(): stopping player[s] (2/2)
8492008-12-12 16:47:37.341 DVDNAV_VTS_CHANGE: old_vtsN==4, new_vtsN==1, aspect: 3, perm: 1
8502008-12-12 16:47:37.342 DVDNAV_CELL_CHANGE: pg_length == 45000, pgc_length == 45000, cell_start == 0, pg_start == 0, title == 3, part == 1 titleParts 1
8512008-12-12 16:47:37.342 Leaving DVD Still Frame
8522008-12-12 16:47:37.342 DVDNAV_SPU_CLUT_CHANGE happened.
8532008-12-12 16:47:37.342 DVDNAV_SPU_STREAM_CHANGE: physical_wide==-1, physical_letterbox==-1, physical_pan_scan==-1, current_track==-1, total count 0
8542008-12-12 16:47:37.342 DVDNAV_AUDIO_STREAM_CHANGE: Current Active Stream 0 Track Count 1
8552008-12-12 16:47:37.342 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
8562008-12-12 16:47:37.342 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
8572008-12-12 16:47:37.343 FilterManager: GetFilterInfo(convert) returning: 0x0
8582008-12-12 16:47:37.343 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x1569b7e0
859greedyhdeint: size changed from 0 x 0 -> 720 x 480
8602008-12-12 16:47:37.343 Using deinterlace method greedyhdeint
8612008-12-12 16:47:37.343 VideoOutputXv: DiscardFrames(1)
8622008-12-12 16:47:37.344 VideoBuffers::DiscardFrames(1): AAAuAAAAAAAALAAAAAAAAAAAAAAAAAA
8632008-12-12 16:47:37.344 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
8642008-12-12 16:47:37.344 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
8652008-12-12 16:47:37.344 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
8662008-12-12 16:47:37.482 NVP: ClearAfterSeek(1)
8672008-12-12 16:47:37.482 VideoOutputXv: ClearAfterSeek()
8682008-12-12 16:47:37.482 VideoOutputXv: DiscardFrames(0)
8692008-12-12 16:47:37.482 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
8702008-12-12 16:47:37.482 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
8712008-12-12 16:47:37.482 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
8722008-12-12 16:47:37.484 NVP: LoadFilters(''..) -> 0x0
8732008-12-12 16:47:37.484 detectInterlace(Detect Scan, Progressive Scan, 29.97, 480) ->Interlaced Scan
8742008-12-12 16:47:37.484 Enabled deinterlacing
8752008-12-12 16:47:37.484 Entering DVD Still Frame
8762008-12-12 16:47:37.484 AFD: DVD Title Changed
8772008-12-12 16:47:37.484 AFD: DVD Cell Changed. Update framesPlayed: 0
8782008-12-12 16:47:37.487 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 4587200 at 0x0x14a97450
8792008-12-12 16:47:37.487 AFD: Looking for decoder for MPEG2VIDEO
8802008-12-12 16:47:37.487 AFD: Stream #1, has id 0x32 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x16e9d900
8812008-12-12 16:47:37.487 AFD: subtitle codec (Subtitle)
8822008-12-12 16:47:37.487 AFD: Looking for decoder for DVD_SUBTITLE
8832008-12-12 16:47:37.487 AFD: Subtitle track #1 is A/V stream #1 and is in the Undetermined language(7695972).
8842008-12-12 16:47:37.488 AFD: Stream #2, has id 0x33 codec id DVD_SUBTITLE, type Subtitle, bitrate 0 at 0x0x163727c0
8852008-12-12 16:47:37.488 AFD: subtitle codec (Subtitle)
8862008-12-12 16:47:37.488 AFD: Looking for decoder for DVD_SUBTITLE
8872008-12-12 16:47:37.488 AFD: Subtitle track #2 is A/V stream #2 and is in the Undetermined language(7695972).
8882008-12-12 16:47:37.488 RingBuf(/dev/dvd): CalcReadAheadThresh(4588 KB)
889                         -> threshhold(64 KB) min read(32 KB) blk size(64 KB)
8902008-12-12 16:47:37.488 AFD: DVD Subtitle Track Map Stream id #32 track #-1
8912008-12-12 16:47:37.488 AFD: DVD Subtitle Track Map Stream id #33 track #-1
8922008-12-12 16:47:37.488 VideoOutputXv: InputChanged(720,480,1.77778) 'MPEG2'->'MPEG2'
8932008-12-12 16:47:37.489 VDP: GetFilteredDeint() : xv-blit -> 'greedyhdeint'
8942008-12-12 16:47:37.490 FilterManager: GetFilterInfo(convert) returning: 0x0
8952008-12-12 16:47:37.490 FilterManager: GetFilterInfo(greedyhdeint) returning: 0x16a85d10
896greedyhdeint: size changed from 0 x 0 -> 720 x 480
8972008-12-12 16:47:37.490 Using deinterlace method greedyhdeint
8982008-12-12 16:47:37.491 VideoOutputXv: DiscardFrames(1)
8992008-12-12 16:47:37.491 VideoBuffers::DiscardFrames(1): AAAAuALAAAAAAAAAAAAAAAAAAAAAAAA
9002008-12-12 16:47:37.491 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9012008-12-12 16:47:37.491 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9022008-12-12 16:47:37.491 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9032008-12-12 16:47:37.496 VDP: LoadBestPreferences(720x480, 29.97)
9042008-12-12 16:47:37.496 NVP, Error: In DVD Menu: No video frames in queue
9052008-12-12 16:47:37.507 NVP, Error: In DVD Menu: No video frames in queue
9062008-12-12 16:47:37.517 NVP, Error: In DVD Menu: No video frames in queue
9072008-12-12 16:47:37.527 NVP, Error: In DVD Menu: No video frames in queue
9082008-12-12 16:47:37.537 NVP, Error: In DVD Menu: No video frames in queue
9092008-12-12 16:47:37.548 NVP, Error: In DVD Menu: No video frames in queue
9102008-12-12 16:47:37.558 NVP, Error: In DVD Menu: No video frames in queue
9112008-12-12 16:47:37.569 NVP, Error: In DVD Menu: No video frames in queue
9122008-12-12 16:47:37.579 NVP, Error: In DVD Menu: No video frames in queue
9132008-12-12 16:47:37.589 NVP, Error: In DVD Menu: No video frames in queue
9142008-12-12 16:47:37.599 NVP, Error: In DVD Menu: No video frames in queue
9152008-12-12 16:47:37.610 NVP, Error: In DVD Menu: No video frames in queue
9162008-12-12 16:47:37.620 NVP, Error: In DVD Menu: No video frames in queue
9172008-12-12 16:47:37.630 NVP, Error: In DVD Menu: No video frames in queue
9182008-12-12 16:47:37.638 NVP: ClearAfterSeek(1)
9192008-12-12 16:47:37.638 VideoOutputXv: ClearAfterSeek()
9202008-12-12 16:47:37.638 VideoOutputXv: DiscardFrames(0)
9212008-12-12 16:47:37.638 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
9222008-12-12 16:47:37.639 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9232008-12-12 16:47:37.639 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9242008-12-12 16:47:37.639 NVP: LoadFilters(''..) -> 0x0
9252008-12-12 16:47:37.639 detectInterlace(Ignore Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
9262008-12-12 16:47:37.639 NVP: Exited decoder loop.
9272008-12-12 16:47:37.640 ~OpenGLVideoSync() -- begin
9282008-12-12 16:47:37.640 ~OpenGLVideoSync() -- middle
9292008-12-12 16:47:37.641 ~OpenGLVideoSync() -- end
9302008-12-12 16:47:37.641 VideoOutputXv: dtor
9312008-12-12 16:47:37.641 VideoOutputXv: DiscardFrames(1)
9322008-12-12 16:47:37.641 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
9332008-12-12 16:47:37.641 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9342008-12-12 16:47:37.641 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9352008-12-12 16:47:37.641 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9362008-12-12 16:47:37.641 VideoOutputXv: DiscardFrames(1)
9372008-12-12 16:47:37.641 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
9382008-12-12 16:47:37.641 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9392008-12-12 16:47:37.641 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
9402008-12-12 16:47:37.641 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
9412008-12-12 16:47:37.642 VideoOutputXv: Closing XVideo port 355
9422008-12-12 16:47:37.697 DVDRB: Clearing Menu SPU Packet
9432008-12-12 16:47:37.697 TV: StopStuff() -- end
9442008-12-12 16:47:37.697 TV: Changing from WatchingPreRecorded to None
9452008-12-12 16:47:41.454 Deleting UPnP client...