Ticket #9780: mythfrontend_full.txt

File mythfrontend_full.txt, 28.4 KB (added by dave@…, 13 years ago)

mythfrontend log of attempted DVD playback with mythmote with -v playback

Line 
1Starting mythfrontend.real..
22011-05-16 21:29:47.016 mythfrontend version: fixes/0.24 [v0.24.1] www.mythtv.org
32011-05-16 21:29:47.016 Using runtime prefix = /usr
42011-05-16 21:29:47.016 Using configuration directory = /home/dave/.mythtv
52011-05-16 21:29:47.017 ThreadPool:HTTP: Initial 1, Max 25, Timeout 60000
62011-05-16 21:29:47.560 Empty LocalHostName.
72011-05-16 21:29:47.560 Using localhost value of edmund
82011-05-16 21:29:47.561 Testing network connectivity to '192.168.1.1'
92011-05-16 21:29:47.675 New DB connection, total: 1
102011-05-16 21:29:47.680 Connected to database 'mythconverg' at host: 192.168.1.1
112011-05-16 21:29:47.685 Closing DB connection named 'DBManager0'
122011-05-16 21:29:47.688 Connected to database 'mythconverg' at host: 192.168.1.1
132011-05-16 21:29:47.692 Current locale en_AU
142011-05-16 21:29:47.692 No locale defaults file for en_AU, skipping
152011-05-16 21:29:47.870 DPMS is active.
162011-05-16 21:29:47.915 Desktop video mode: 1920x1080 60.000 Hz
172011-05-16 21:29:47.951 max_width: 1920 max_height: 1200
182011-05-16 21:29:47.953 user: 1000 effective user: 1000 before privileged thread
192011-05-16 21:29:47.953 user: 1000 effective user: 1000 after privileged thread
202011-05-16 21:29:47.954 Enabled verbose msgs:  important general playback
212011-05-16 21:29:47.954 user: 1000 effective user: 1000 run_priv_thread
222011-05-16 21:29:48.003 Connecting to lcd server: 127.0.0.1:6545 (try 1 of 10)
232011-05-16 21:29:48.007 Loading en_gb translation for module mythfrontend
242011-05-16 21:29:48.007 New DB connection, total: 2
252011-05-16 21:29:48.011 Connected to database 'mythconverg' at host: 192.168.1.1
262011-05-16 21:29:48.029 LIRC, Error: Failed to connect to Unix socket '/var/run/lirc/lircd'
27                        eno: No such file or directory (2)
282011-05-16 21:29:48.030 JoystickMenuThread: Joystick disabled - Failed to read /home/dave/.mythtv/joystickmenurc
292011-05-16 21:29:48.220 Using the OpenGL painter
302011-05-16 21:29:48.402 OpenGL: OpenGL vendor  : NVIDIA Corporation
312011-05-16 21:29:48.402 OpenGL: OpenGL renderer: GeForce 9800M GTX/PCI/SSE2
322011-05-16 21:29:48.402 OpenGL: OpenGL version : 3.3.0 NVIDIA 270.41.06
332011-05-16 21:29:48.402 OpenGL: Max texture size: 8192 x 8192
342011-05-16 21:29:48.402 OpenGL: Max texture units: 4
352011-05-16 21:29:48.402 OpenGL: Direct rendering: Yes
362011-05-16 21:29:48.402 OpenGL: Initialised MythRenderOpenGL
372011-05-16 21:29:48.513 New DB connection, total: 3
382011-05-16 21:29:48.523 Connected to database 'mythconverg' at host: 192.168.1.1
392011-05-16 21:29:48.527 Current MythTV Schema Version (DBSchemaVer): 1264
402011-05-16 21:29:48.528 VDP: decoder<->render support: ffmpeg      null xlib xshm xv-blit opengl vdpau
412011-05-16 21:29:48.528 VDP: decoder<->render support: vdpau       vdpau
422011-05-16 21:29:48.528 VDP: decoder<->render support: libmpeg2    null xlib xshm xv-blit opengl vdpau
432011-05-16 21:29:48.533 VDP: Ignoring profile item 91 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
442011-05-16 21:29:48.533 VDP: Ignoring profile item 93 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
452011-05-16 21:29:48.535 VDP: Ignoring profile item 89 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
462011-05-16 21:29:48.539 VDP: Ignoring profile item 95 (decoder ivtv is not supported (supported: ffmpeg,vdpau,libmpeg2))
472011-05-16 21:29:48.539 VDP: Ignoring profile item 96 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
482011-05-16 21:29:48.539 VDP: Ignoring profile item 97 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
492011-05-16 21:29:48.539 VDP: Ignoring profile item 98 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
502011-05-16 21:29:48.541 VDP: Ignoring profile item 102 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
512011-05-16 21:29:48.541 VDP: Ignoring profile item 103 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
522011-05-16 21:29:48.544 VDP: Ignoring profile item 106 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
532011-05-16 21:29:48.544 VDP: Ignoring profile item 107 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
542011-05-16 21:29:48.546 VDP: Ignoring profile item 110 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
552011-05-16 21:29:48.546 VDP: Ignoring profile item 111 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
562011-05-16 21:29:49.159 ThemeInfo, Warning: Unable to open themeinfo.xml for /usr/share/mythtv/themes/BlackCurves-OSD/themeinfo.xml
572011-05-16 21:29:49.160 ThemeInfo, Error: The theme (/usr/share/mythtv/themes/BlackCurves-OSD) is missing a themeinfo.xml file.
582011-05-16 21:29:49.162 ThemeInfo, Warning: Unable to open themeinfo.xml for /usr/share/mythtv/themes/Gray-OSD/themeinfo.xml
592011-05-16 21:29:49.163 ThemeInfo, Error: The theme (/usr/share/mythtv/themes/Gray-OSD) is missing a themeinfo.xml file.
602011-05-16 21:29:49.683 Registering Internal as a media playback plugin.
612011-05-16 21:29:49.757 MediaMonitorUnix::AddDevice() - empty device path.
622011-05-16 21:29:49.758 MediaMonitorUnix::AddDevice() - empty device path.
632011-05-16 21:29:49.758 MediaMonitorUnix::AddDevice() - empty device path.
642011-05-16 21:29:49.760 MonitorRegisterExtensions(0x100, gif,jpg,png)
652011-05-16 21:29:49.760 Loading en_gb translation for module mythgallery
662011-05-16 21:29:49.774 Current MythMusic Schema Version (MusicDBSchemaVer): 1017
672011-05-16 21:29:49.863 MonitorRegisterExtensions(0x40, mp3,mp2,ogg,oga,flac,wma,wav,ac3,oma,omg,atp,ra,dts,aac,m4a,aa3,tta,mka,aiff,swa,wv)
682011-05-16 21:29:49.874 Loading en_gb translation for module mythmusic
692011-05-16 21:29:49.893 Current MythVideo Schema Version (mythvideo.DBSchemaVer): 1038
702011-05-16 21:29:49.950 Loading en_gb translation for module mythvideo
712011-05-16 21:29:49.954 NetworkControl: Listening for remote connections on port 6546
722011-05-16 21:29:50.020 Found mainmenu.xml for theme 'Mythbuntu'
732011-05-16 21:29:50.129 MythCoreContext: Connecting to backend server: 192.168.1.1:6543 (try 1 of 1)
742011-05-16 21:29:50.130 Using protocol version 63
752011-05-16 21:29:53.050 NetworkControl: New connection established.
762011-05-16 21:30:11.853 RingBuf(dvd:/mnt/movies/Planet of the Apes.iso): OpenFile(dvd:/mnt/movies/Planet of the Apes.iso, 2000 ms)
772011-05-16 21:30:11.853 OpenFile() trying DVD at /mnt/movies/Planet of the Apes.iso
78libdvdnav: Using dvdnav version svnR1215
79libdvdread: Using libdvdcss version 1.2.10 for DVD access
80libdvdnav: DVD Title: PLANET_OF_THE_APES_DISC1
81libdvdnav: DVD Serial Number: 2C3D6BBD
82libdvdnav: DVD Title (Alternative): PLANET_OF_THE_APES_DISC1
83libdvdnav: Unable to find map file '/home/dave/.dvdnav/PLANET_OF_THE_APES_DISC1.map'
84libdvdnav: DVD disk reports itself with Region mask 0x00f50000. Regions: 2 4
85
86libdvdread: Attempting to retrieve all CSS keys
87libdvdread: This can take a _long_ time, please be patient
88
89libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x00016b80
90libdvdread: Elapsed time 0
91libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x00016ed9
92libdvdread: Elapsed time 0
93libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x00050788
94libdvdread: Elapsed time 0
95libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0006d1d4
96libdvdread: Elapsed time 0
97libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x003626e8
98libdvdread: Elapsed time 0
99libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x00364d3f
100libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_04_1.VOB (0x00364d3f)!!
101libdvdread: Elapsed time 0
102libdvdread: Found 4 VTS's
103libdvdread: Elapsed time 0
1042011-05-16 21:30:11.859 Opened DVD device at /mnt/movies/Planet of the Apes.iso
1052011-05-16 21:30:11.859 There are 13 titles on the disk
1062011-05-16 21:30:11.859 DVDRB: Title 1 has 36 parts.
1072011-05-16 21:30:11.859 DVDRB: Title 2 has 36 parts.
1082011-05-16 21:30:11.859 DVDRB: Title 3 has 1 parts.
1092011-05-16 21:30:11.860 DVDRB: Title 4 has 1 parts.
1102011-05-16 21:30:11.860 DVDRB: Title 5 has 1 parts.
1112011-05-16 21:30:11.860 DVDRB: Title 6 has 1 parts.
1122011-05-16 21:30:11.860 DVDRB: Title 7 has 1 parts.
1132011-05-16 21:30:11.860 DVDRB: Title 8 has 1 parts.
1142011-05-16 21:30:11.860 DVDRB: Title 9 has 1 parts.
1152011-05-16 21:30:11.860 DVDRB: Title 10 has 1 parts.
1162011-05-16 21:30:11.860 DVDRB: Title 11 has 1 parts.
1172011-05-16 21:30:11.860 DVDRB: Title 12 has 1 parts.
1182011-05-16 21:30:11.860 DVDRB: Title 13 has 1 parts.
119libdvdnav: Language 'en' not found, using 'ᅵᅵ' instead
120libdvdnav: Menu Languages available: ᅵᅵ
1212011-05-16 21:30:11.863 DVD Serial Number 2C3D6BBD
1222011-05-16 21:30:11.930 TV: StartTV() -- begin
1232011-05-16 21:30:11.931 TV: ctor -- begin
1242011-05-16 21:30:11.945 TV: ctor -- end
1252011-05-16 21:30:11.945 TV: Init -- begin
1262011-05-16 21:30:11.955 TV: DrawUnusedRects() -- begin
1272011-05-16 21:30:11.955 TV: DrawUnusedRects() -- end
1282011-05-16 21:30:11.971 TV: Init -- end
1292011-05-16 21:30:11.972 TV: tv->Playback() -- begin
1302011-05-16 21:30:12.039 TV: HandleStateChange(0) -- begin
1312011-05-16 21:30:12.039 TV: Attempting to change from None to WatchingDVD
1322011-05-16 21:30:12.039 RingBuf(dvd:/mnt/movies/Planet of the Apes.iso): OpenFile(dvd:/mnt/movies/Planet of the Apes.iso, 2000 ms)
1332011-05-16 21:30:12.040 OpenFile() trying DVD at /mnt/movies/Planet of the Apes.iso
134libdvdnav: Using dvdnav version svnR1215
135libdvdread: Using libdvdcss version 1.2.10 for DVD access
136libdvdnav: DVD Title: PLANET_OF_THE_APES_DISC1
137libdvdnav: DVD Serial Number: 2C3D6BBD
138libdvdnav: DVD Title (Alternative): PLANET_OF_THE_APES_DISC1
139libdvdnav: Unable to find map file '/home/dave/.dvdnav/PLANET_OF_THE_APES_DISC1.map'
140libdvdnav: DVD disk reports itself with Region mask 0x00f50000. Regions: 2 4
141
142libdvdread: Attempting to retrieve all CSS keys
143libdvdread: This can take a _long_ time, please be patient
144
145libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x00016b80
146libdvdread: Elapsed time 0
147libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x00016ed9
148libdvdread: Elapsed time 0
149libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x00050788
150libdvdread: Elapsed time 0
151libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0006d1d4
152libdvdread: Elapsed time 0
153libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x003626e8
154libdvdread: Elapsed time 0
155libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x00364d3f
156libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_04_1.VOB (0x00364d3f)!!
157libdvdread: Elapsed time 0
158libdvdread: Found 4 VTS's
159libdvdread: Elapsed time 0
1602011-05-16 21:30:12.043 Opened DVD device at /mnt/movies/Planet of the Apes.iso
1612011-05-16 21:30:12.043 There are 13 titles on the disk
1622011-05-16 21:30:12.044 DVDRB: Title 1 has 36 parts.
1632011-05-16 21:30:12.044 DVDRB: Title 2 has 36 parts.
1642011-05-16 21:30:12.044 DVDRB: Title 3 has 1 parts.
1652011-05-16 21:30:12.044 DVDRB: Title 4 has 1 parts.
1662011-05-16 21:30:12.044 DVDRB: Title 5 has 1 parts.
1672011-05-16 21:30:12.044 DVDRB: Title 6 has 1 parts.
1682011-05-16 21:30:12.044 DVDRB: Title 7 has 1 parts.
1692011-05-16 21:30:12.044 DVDRB: Title 8 has 1 parts.
1702011-05-16 21:30:12.044 DVDRB: Title 9 has 1 parts.
1712011-05-16 21:30:12.044 DVDRB: Title 10 has 1 parts.
1722011-05-16 21:30:12.044 DVDRB: Title 11 has 1 parts.
1732011-05-16 21:30:12.045 DVDRB: Title 12 has 1 parts.
1742011-05-16 21:30:12.045 DVDRB: Title 13 has 1 parts.
175libdvdnav: Language 'en' not found, using 'ᅵᅵ' instead
176libdvdnav: Menu Languages available: ᅵᅵ
1772011-05-16 21:30:12.046 DVD Serial Number 2C3D6BBD
1782011-05-16 21:30:12.046 TV: StartPlayer(0, WatchingDVD, main) -- begin
1792011-05-16 21:30:12.046 TV: Elapsed time since TV constructor was called: 115 ms
1802011-05-16 21:30:12.143 DVDRB: DVDNAV_HOP_CHANNEL
1812011-05-16 21:30:12.143 DVDRB: DVDNAV_HIGHLIGHT: display 1, palette 0, sx 0, sy 0, ex 0, ey 0, pts 0, buttonN 1
1822011-05-16 21:30:12.143 DVDRB: DVDNAV_VTS_CHANGE: old_vtsN 0, new_vtsN 2, aspect 3, perm 2
1832011-05-16 21:30:12.143 DVDRB: ---- DVDNAV_CELL_CHANGE - Cell #1 Menu No Length 187.4
1842011-05-16 21:30:12.143 DVDRB: Title #1: Length: 6901.8 seconds Part 1 of 36
1852011-05-16 21:30:12.143 DVDRB: DVDNAV_SPU_CLUT_CHANGE
1862011-05-16 21:30:12.143 DVDRB: DVDNAV_SPU_STREAM_CHANGE: physicalwide 132, physicalletterbox 132, physicalpanscan 128, currenttrack -124
1872011-05-16 21:30:12.143 DVDRB: DVDNAV_AUDIO_STREAM_CHANGE: old 0 new 0
1882011-05-16 21:30:12.144 DVDRB: DVDNAV_HOP_CHANNEL
1892011-05-16 21:30:12.144 DVDRB: ---- DVDNAV_CELL_CHANGE - Cell #1 Menu No Length 187.4
1902011-05-16 21:30:12.144 DVDRB: Title #1: Length: 6901.8 seconds Part 1 of 36
1912011-05-16 21:30:12.144 DVDRB: DVDNAV_SPU_CLUT_CHANGE
1922011-05-16 21:30:12.144 DVDRB: DVDNAV_SPU_STREAM_CHANGE: physicalwide 132, physicalletterbox 132, physicalpanscan 128, currenttrack -124
1932011-05-16 21:30:12.144 DVDRB: DVDNAV_AUDIO_STREAM_CHANGE: old 0 new 0
1942011-05-16 21:30:12.145 DVDRB: DVDNAV_HOP_CHANNEL
1952011-05-16 21:30:12.145 DVDRB: ---- DVDNAV_CELL_CHANGE - Cell #1 Menu No Length 187.4
1962011-05-16 21:30:12.145 DVDRB: Title #1: Length: 6901.8 seconds Part 1 of 36
1972011-05-16 21:30:12.145 DVDRB: DVDNAV_SPU_CLUT_CHANGE
1982011-05-16 21:30:12.145 DVDRB: DVDNAV_SPU_STREAM_CHANGE: physicalwide 132, physicalletterbox 132, physicalpanscan 128, currenttrack -124
1992011-05-16 21:30:12.145 DVDRB: DVDNAV_AUDIO_STREAM_CHANGE: old 0 new 0
2002011-05-16 21:30:12.161 DVDRB: DVDNAV_HOP_CHANNEL
2012011-05-16 21:30:12.162 DVDRB: ---- DVDNAV_CELL_CHANGE - Cell #1 Menu No Length 187.4
2022011-05-16 21:30:12.162 DVDRB: Title #1: Length: 6901.8 seconds Part 1 of 36
2032011-05-16 21:30:12.162 DVDRB: DVDNAV_SPU_CLUT_CHANGE
2042011-05-16 21:30:12.162 DVDRB: DVDNAV_SPU_STREAM_CHANGE: physicalwide 132, physicalletterbox 132, physicalpanscan 128, currenttrack -124
2052011-05-16 21:30:12.162 DVDRB: DVDNAV_AUDIO_STREAM_CHANGE: old 0 new 0
2062011-05-16 21:30:12.183 DVDRB: Resetting DVD device.
207libdvdnav: DVD disk reports itself with Region mask 0x00f50000. Regions: 2 4
208libdvdnav: Language 'en' not found, using 'ᅵᅵ' instead
209libdvdnav: Menu Languages available: ᅵᅵ
2102011-05-16 21:30:12.183 AFD: Stream #0, has id 0x1e0 codec id MPEG2VIDEO, type Video, bitrate 6000000 at 0x33498a0
2112011-05-16 21:30:12.188 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt()
2122011-05-16 21:30:12.188 VDP: LoadBestPreferences(2048x2048, 0)
2132011-05-16 21:30:12.188 VDP: LoadBestPreferences(2048x2048, 60)
2142011-05-16 21:30:12.188 VDP: LoadBestPreferences(720x576, 60)
2152011-05-16 21:30:12.191 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt()
2162011-05-16 21:30:12.191 VDP: LoadBestPreferences(2048x2048, 0)
2172011-05-16 21:30:12.191 VDP: LoadBestPreferences(2048x2048, 60)
2182011-05-16 21:30:12.191 VDP: LoadBestPreferences(720x576, 60)
2192011-05-16 21:30:12.191 AFD: Using 1 CPUs for decoding
2202011-05-16 21:30:12.191 AFD: InitVideoCodec() 0x3348070 id(MPEG2VIDEO) type (Video).
2212011-05-16 21:30:12.191 AFD: Selected FPS is 25 (avg 25 stream 25 container 90000 estimated 25)
2222011-05-16 21:30:12.191 Player(0): detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2232011-05-16 21:30:12.191 AFD Warning: ScanATSCCaptionStreams() called with no PMT
2242011-05-16 21:30:12.191 AFD: Using vdpau for video decoding
2252011-05-16 21:30:12.191 AFD: Looking for decoder for MPEG2VIDEO
2262011-05-16 21:30:12.191 AFD: Opened codec 0x3348070, id(MPEG2VIDEO) type(Video)
2272011-05-16 21:30:12.191 AFD: Stream #1, has id 0x89 codec id DTS, type Audio, bitrate 768000 at 0x32fcee0
2282011-05-16 21:30:12.191 AFD: codec DTS has 6 channels
2292011-05-16 21:30:12.191 AFD: Looking for decoder for DTS
2302011-05-16 21:30:12.192 AFD: Opened codec 0x2cd4df0, id(DTS) type(Audio)
2312011-05-16 21:30:12.192 DVDRB: StreamID: 0; lang: 65535
2322011-05-16 21:30:12.192 DVDRB: code: 65535; iso639: und
2332011-05-16 21:30:12.192 AFD: Stream #2, has id 0x80 codec id AC3, type Audio, bitrate 384000 at 0x32fd100
2342011-05-16 21:30:12.192 AFD: codec AC3 has 6 channels
2352011-05-16 21:30:12.192 AFD: Looking for decoder for AC3
2362011-05-16 21:30:12.192 AFD: Opened codec 0x22a0430, id(AC3) type(Audio)
2372011-05-16 21:30:12.192 DVDRB: StreamID: 0; lang: 65535
2382011-05-16 21:30:12.192 DVDRB: code: 65535; iso639: und
2392011-05-16 21:30:12.192 AFD: Stream #3, has id 0x82 codec id AC3, type Audio, bitrate 192000 at 0x3b954c0
2402011-05-16 21:30:12.192 AFD: codec AC3 has 2 channels
2412011-05-16 21:30:12.192 AFD: Looking for decoder for AC3
2422011-05-16 21:30:12.192 AFD: Opened codec 0x3b956e0, id(AC3) type(Audio)
2432011-05-16 21:30:12.193 DVDRB: StreamID: 0; lang: 65535
2442011-05-16 21:30:12.193 DVDRB: code: 65535; iso639: und
2452011-05-16 21:30:12.193 AFD: Stream #4, has id 0x83 codec id AC3, type Audio, bitrate 96000 at 0x32cff20
2462011-05-16 21:30:12.193 AFD: codec AC3 has 2 channels
2472011-05-16 21:30:12.193 AFD: Looking for decoder for AC3
2482011-05-16 21:30:12.193 AFD: Opened codec 0x3281fc0, id(AC3) type(Audio)
2492011-05-16 21:30:12.193 DVDRB: StreamID: 0; lang: 65535
2502011-05-16 21:30:12.193 DVDRB: code: 65535; iso639: und
2512011-05-16 21:30:12.193 AFD: DVD Audio Track Map Stream id #0, MPEG stream 137
2522011-05-16 21:30:12.193 AFD: DVD Audio Track Map Stream id #0, MPEG stream 128
2532011-05-16 21:30:12.193 AFD: DVD Audio Track Map Stream id #0, MPEG stream 130
2542011-05-16 21:30:12.193 AFD: DVD Audio Track Map Stream id #0, MPEG stream 131
2552011-05-16 21:30:12.215 AO: Opening audio device 'default' ch 2(6) sr 48000 sf 32 bit floating point reenc 0
2562011-05-16 21:30:12.217 AudioOutput Warning: mmap not available, attempting to fall back to slow writes
2572011-05-16 21:30:12.248 ALSA, Error: no playback control PCM found on mixer device default
2582011-05-16 21:30:12.248 ALSA, Error: Unable to open audio mixer. Volume control disabled
2592011-05-16 21:30:12.248 AudioPlayer: Enabling Audio
2602011-05-16 21:30:12.248 Dec: Selected track #1 in the Unknown language(0)
2612011-05-16 21:30:12.249 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2622011-05-16 21:30:12.249 DVDRB: DVD Frame Rate 25
2632011-05-16 21:30:12.249 Dec: Position map filled from DB to: 172525
2642011-05-16 21:30:12.249 Dec: SyncPositionMap prerecorded, from DB: 1 entries
2652011-05-16 21:30:12.249 Dec: SyncPositionMap, new totframes: 172525, new length: 6901, posMap size: 1
2662011-05-16 21:30:12.249 AFD: Position map found
2672011-05-16 21:30:12.249 AFD: Successfully opened decoder for file: "/mnt/movies/Planet of the Apes.iso". novideo(0)
2682011-05-16 21:30:12.327 VideoOutput: Allowed renderers: vdpau
2692011-05-16 21:30:12.328 VideoOutput: Allowed renderers (filt: vdpau): vdpau
2702011-05-16 21:30:12.335 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt()
2712011-05-16 21:30:12.335 VDP: LoadBestPreferences(2048x2048, 0)
2722011-05-16 21:30:12.335 VDP: LoadBestPreferences(2048x2048, 60)
2732011-05-16 21:30:12.335 VDP: LoadBestPreferences(720x576, 60)
2742011-05-16 21:30:12.336 VideoOutput: Preferred renderer: vdpau
2752011-05-16 21:30:12.336 VideoOutput: Trying video renderer: 'vdpau'
2762011-05-16 21:30:12.377 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(disabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt()
2772011-05-16 21:30:12.377 VDP: LoadBestPreferences(2048x2048, 0)
2782011-05-16 21:30:12.377 VDP: LoadBestPreferences(2048x2048, 60)
2792011-05-16 21:30:12.377 VideoOutWindow::SetPIPState. pip_state: 0]
2802011-05-16 21:30:12.378 VDP: LoadBestPreferences(2048x2048, 25)
2812011-05-16 21:30:12.378 Clearing OpenGL painter cache.
2822011-05-16 21:30:12.381 Display Rect  left: 0, top: 45, width: 640, height: 270, aspect: 1.33333
2832011-05-16 21:30:12.381 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
2842011-05-16 21:30:12.381 VDP: LoadBestPreferences(720x576, 25)
2852011-05-16 21:30:12.381 Display Rect  left: 0, top: 45, width: 640, height: 270, aspect: 1.33333
2862011-05-16 21:30:12.382 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
2872011-05-16 21:30:12.382 VDP: SetVideoRenderer(vdpau)
2882011-05-16 21:30:12.382 VDP: SetVideoRender(vdpau) == GetVideoRenderer()
2892011-05-16 21:30:12.383 VideoOutput: Pixel dimensions: Screen 1920x1080, window 640x360
2902011-05-16 21:30:12.383 VideoOutput: Actual display dimensions: 508x285 mm  Aspect: 1.78246
2912011-05-16 21:30:12.383 VideoOutput: Estimated window dimensions: 169x95 mm  Aspect: 1.77895
2922011-05-16 21:30:12.476 VDPAU: Created 2 output surfaces.
2932011-05-16 21:30:12.476 VDPAU: Set colorkey to 0x20202
2942011-05-16 21:30:12.476 VDPAU: Version 1
2952011-05-16 21:30:12.476 VDPAU: Information NVIDIA VDPAU Driver Shared Library  270.41.06  Mon Apr 18 15:13:22 PDT 2011
2962011-05-16 21:30:12.476 VDPAU: HQ Scaling not supported.
2972011-05-16 21:30:12.476 VDPAU: MPEG4 hardware acceleration not supported.
2982011-05-16 21:30:12.476 VDPAU: Created VDPAU render device 640x360
2992011-05-16 21:30:12.476 VidOutVDPAU: Created VDPAU osd (640x360)
3002011-05-16 21:30:12.493 Display Rect  left: 0, top: 0, width: 640, height: 360, aspect: 1.77778
3012011-05-16 21:30:12.493 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
3022011-05-16 21:30:12.493 VidOutVDPAU: Created VDPAU context (GPU decode)
3032011-05-16 21:30:12.497 Over/underscan. V: 0, H: 0
3042011-05-16 21:30:12.497 Display Rect  left: 0, top: 0, width: 640, height: 360, aspect: 1.77778
3052011-05-16 21:30:12.497 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
3062011-05-16 21:30:12.497 Player(0): Forcing decode extra audio option on (Video method requires it).
3072011-05-16 21:30:12.497 Player(0): LoadFilters(''..) -> 0x0
3082011-05-16 21:30:12.506 Player(0): Decoder thread starting.
3092011-05-16 21:30:12.506 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
3102011-05-16 21:30:12.506 DVDRB: DVD Frame Rate 25
3112011-05-16 21:30:12.506 Dec: Position map filled from DB to: 172525
3122011-05-16 21:30:12.506 Dec: SyncPositionMap prerecorded, from DB: 1 entries
3132011-05-16 21:30:12.507 Dec: SyncPositionMap, new totframes: 172525, new length: 6901, posMap size: 1
3142011-05-16 21:30:12.509 OSD: Loaded window osd_message
3152011-05-16 21:30:12.512 OSD: Loaded window osd_input
3162011-05-16 21:30:12.514 VidOutVDPAU: Created VDPAU decoder (2 ref frames)
3172011-05-16 21:30:12.515 [mpegvideo_vdpau @ 0x7ff68a073580]warning: first frame is no keyframe
3182011-05-16 21:30:12.516 [mpegvideo_vdpau @ 0x7ff68a073580]warning: first frame is no keyframe
3192011-05-16 21:30:12.522 OSD: Loaded window program_info
3202011-05-16 21:30:12.525 OSD: Loaded window browse_info
3212011-05-16 21:30:12.529 OSD: Loaded window osd_status
3222011-05-16 21:30:12.533 OSD: Loaded window osd_program_editor
3232011-05-16 21:30:12.533 OSD: Loaded OSD: size 640x360 offset 0+0
3242011-05-16 21:30:12.538 Player(0): ClearAfterSeek(0)
3252011-05-16 21:30:12.540 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
3262011-05-16 21:30:12.550 VidOutVDPAU: Enabled deinterlacing.
3272011-05-16 21:30:12.550 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
3282011-05-16 21:30:12.550 VSYNC: RTCVideoSync: Could not open /dev/rtc, Permission denied.
3292011-05-16 21:30:12.551 Player(0): Video timing method: USleep with busy wait
3302011-05-16 21:30:12.551 Player(0): Display Refresh Rate: 60.002 Video Frame Rate: 25.000
3312011-05-16 21:30:12.551 playCtx: StartPlaying(): took 0 ms to start player.
3322011-05-16 21:30:12.551 TV: StartPlayer(0, WatchingDVD, main) -- end ok
3332011-05-16 21:30:12.552 TV: Changing from None to WatchingDVD
3342011-05-16 21:30:12.578 AFD: HandleGopStart: Key frame distance changed from 12 to 15.
3352011-05-16 21:30:12.584 TV: DrawUnusedRects() -- begin
3362011-05-16 21:30:12.584 TV: DrawUnusedRects() -- end
3372011-05-16 21:30:12.584 TV: HandleStateChange(0) -- end
3382011-05-16 21:30:12.594 TV: tv->Playback() -- end
3392011-05-16 21:30:12.594 TV: StartTV -- process events begin
3402011-05-16 21:30:12.597 ScreenSaverX11Private: DPMS Deactivated 1
3412011-05-16 21:30:12.597 ScreenSaverX11Private: DPMS Deactivated 1
3422011-05-16 21:30:12.598 ScreenSaverX11Private: DPMS Deactivated 1
3432011-05-16 21:30:12.598 ScreenSaverX11Private: DPMS Deactivated 1
3442011-05-16 21:30:12.599 ScreenSaverX11Private: DPMS Deactivated 1
3452011-05-16 21:30:12.599 Player(0): progressive frame seen after 2 interlaced  frames
3462011-05-16 21:30:12.600 Player(0): Disabled deinterlacing
3472011-05-16 21:30:12.603 VDPAU: Added 2 output surfaces (total 4, max 4)
3482011-05-16 21:30:12.609 DVDRB: DVDNAV_HOP_CHANNEL
3492011-05-16 21:30:12.609 DVDRB: Waiting for player's buffers to drain
3502011-05-16 21:30:12.999 VidOutVDPAU: UpdatePauseFrame() AAAAAAAAAAAAUUuuL
3512011-05-16 21:30:13.040 VidOutVDPAU: UpdatePauseFrame() AAAAAAAAAAAAAUuuL
3522011-05-16 21:30:13.083 VidOutVDPAU: UpdatePauseFrame() AAAAAAAAAAAAAAuuL
3532011-05-16 21:30:13.118 TV: ProcessNetworkControlCommand(NETWORK_CONTROL QUERY POSITION) ignoreKeys: 0
3542011-05-16 21:30:14.638 DVDRB, Error: Player wait state was not cleared
3552011-05-16 21:30:14.638 DVDRB: DVDNAV_HIGHLIGHT: display 1, palette 1310788, sx 260, sy 35073, ex 63683, ey 0, pts 3959939073, buttonN 1
3562011-05-16 21:30:14.638 Display Rect  left: 0, top: 0, width: 640, height: 360, aspect: 1.77778
3572011-05-16 21:30:14.638 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
3582011-05-16 21:30:14.638 DVDRB: DVDNAV_VTS_CHANGE: old_vtsN 0, new_vtsN -1, aspect 3, perm 1
359libdvdnav: Language 'en' not found, using 'ᅵᅵ' instead
360libdvdnav: Menu Languages available: ᅵᅵ
3612011-05-16 21:30:14.639 DVDRB: ---- DVDNAV_CELL_CHANGE - Cell #1 Menu Yes Length 0.5
3622011-05-16 21:30:14.639 DVDRB: Menu #0 Stillframe: 3 seconds
3632011-05-16 21:30:14.639 DVDRB: Waiting for player's buffers to drain
3642011-05-16 21:30:16.667 DVDRB, Error: Player wait state was not cleared
3652011-05-16 21:30:16.667 DVDRB: DVDNAV_SPU_CLUT_CHANGE
3662011-05-16 21:30:16.667 DVDRB: DVDNAV_SPU_STREAM_CHANGE: physicalwide 0, physicalletterbox 0, physicalpanscan 0, currenttrack 0
3672011-05-16 21:30:16.667 DVDRB: DVDNAV_AUDIO_STREAM_CHANGE: old 0 new 0
3682011-05-16 21:30:16.668 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
3692011-05-16 21:30:16.668 DVDRB: DVD Frame Rate 25
3702011-05-16 21:30:16.668 Dec: Position map filled from DB to: 25
3712011-05-16 21:30:16.668 Dec: SyncPositionMap prerecorded, from DB: 1 entries
3722011-05-16 21:30:16.668 Dec: SyncPositionMap, new totframes: 25, new length: 1, posMap size: 1
3732011-05-16 21:30:16.668 AFD: Stream #0, has id 0x1e0 codec id MPEG2VIDEO, type Video, bitrate 6000000 at 0x33498a0
3742011-05-16 21:30:16.669 AFD: Looking for decoder for MPEG2VIDEO
3752011-05-16 21:30:16.669 AudioPlayer: Disabling Audio, params(0,-1,-1)
3762011-05-16 21:30:16.670 ScreenSaverX11Private: DPMS Reactivated 1
3772011-05-16 21:30:16.705 AudioPlayer: Disabling Audio, reason is: Aborting Audio Reconfigure. Invalid audio parameters ch -1 fmt 0 @ -1Hz
3782011-05-16 21:30:16.707 VidOutVDPAU: InputChanged(720,576,1.77778) 'MPEG2 VDPAU'->'MPEG2 VDPAU'
3792011-05-16 21:30:16.707 Player(0): detectInterlace(Ignore Scan, Progressive Scan, 25, 576) ->Progressive Scan
3802011-05-16 21:30:16.707 AFD: No codec context. Returning false
3812011-05-16 21:30:16.707 AFD: No codec context. Returning false
3822011-05-16 21:30:16.710 VidOutVDPAU: UpdatePauseFrame() AULAAAAAAAAAAAFUL
3832011-05-16 21:30:16.713 VidOutVDPAU: UpdatePauseFrame() AULLAAAAAAAAAAFUA
3842011-05-16 21:30:16.723 AFD: No codec context. Returning false
3852011-05-16 21:30:16.726 AFD: No codec context. Returning false
3862011-05-16 21:30:16.736 AFD: No codec context. Returning false
3872011-05-16 21:30:16.748 AFD: No codec context. Returning false
3882011-05-16 21:30:16.755 AFD: No codec context. Returning false
3892011-05-16 21:30:16.758 VidOutVDPAU: InputChanged(720,576,1.77778) 'MPEG2 VDPAU'->'MPEG2 VDPAU'
3902011-05-16 21:30:16.758 Player(0): detectInterlace(Detect Scan, Progressive Scan, 25, 576) ->Interlaced Scan
3912011-05-16 21:30:16.759 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
3922011-05-16 21:30:16.761 VidOutVDPAU: Enabled deinterlacing.
3932011-05-16 21:30:16.761 Player(0): Enabled deinterlacing
3942011-05-16 21:30:16.762 DVDRB: New sequence
3952011-05-16 21:30:16.768 AFD: No codec context. Returning false
3962011-05-16 21:30:16.834 Player(0): progressive frame seen after 2 interlaced  frames
3972011-05-16 21:30:16.837 Player(0): Disabled deinterlacing
3982011-05-16 21:30:16.914 VidOutVDPAU: UpdatePauseFrame() AAAAAAAUUAAUuLAAA
3992011-05-16 21:30:16.954 VidOutVDPAU: UpdatePauseFrame() AAAAAAAAUAAUuLAAA
4002011-05-16 21:30:16.993 VidOutVDPAU: UpdatePauseFrame() AAAAAAAAAAAUuLAAA
4012011-05-16 21:30:17.033 DVDPlayer: Clearing DVD wait state
4022011-05-16 21:30:17.034 DVDRB: Exiting DVDNAV_WAIT status
4032011-05-16 21:30:17.074 VidOutVDPAU: UpdatePauseFrame() AAAAAAAAAAAAuLAAA
4042011-05-16 21:30:18.124 TV: ProcessNetworkControlCommand(NETWORK_CONTROL QUERY POSITION) ignoreKeys: 0