Ticket #9774: frontend_verbose_playback.txt

File frontend_verbose_playback.txt, 24.1 KB (added by bbruen@…, 13 years ago)

verbose log of frontend playback using ffmpeg and opengl on HD 5450

Line 
12011-05-14 19:18:12.609 mythfrontend version: fixes/0.24 [v0.24-250-g56c54fa] www.mythtv.org
22011-05-14 19:18:12.610 Using runtime prefix = /usr
32011-05-14 19:18:12.610 Using configuration directory = /home/berman/.mythtv
42011-05-14 19:18:12.611 ThreadPool:HTTP: Initial 1, Max 25, Timeout 60000
52011-05-14 19:18:13.451 Empty LocalHostName.
62011-05-14 19:18:13.452 Using localhost value of mythfrontend
72011-05-14 19:18:13.452 Testing network connectivity to '192.168.2.192'
82011-05-14 19:18:13.568 New DB connection, total: 1
92011-05-14 19:18:13.571 Connected to database 'mythconverg' at host: 192.168.2.192
102011-05-14 19:18:13.577 Closing DB connection named 'DBManager0'
112011-05-14 19:18:13.579 Connected to database 'mythconverg' at host: 192.168.2.192
122011-05-14 19:18:13.583 Current locale en_US
132011-05-14 19:18:13.584 Reading locale defaults from /usr/share/mythtv//locales/en_us.xml
142011-05-14 19:18:13.756 ScreenSaverX11Private: Gnome screen saver support enabled
152011-05-14 19:18:13.759 DPMS is active.
162011-05-14 19:18:13.808 Desktop video mode: 1920x1080 60.000 Hz
172011-05-14 19:18:13.903 The NV-CONTROL X extension is not available on screen 0 of ':0'.
182011-05-14 19:18:13.904 max_width: 1920 max_height: 1080
192011-05-14 19:18:13.910 user: 1000 effective user: 1000 before privileged thread
202011-05-14 19:18:13.911 user: 1000 effective user: 1000 after privileged thread
212011-05-14 19:18:13.911 user: 1000 effective user: 1000 run_priv_thread
222011-05-14 19:18:13.911 Enabled verbose msgs:  important general playback
232011-05-14 19:18:13.926 Loading en_us translation for module mythfrontend
242011-05-14 19:18:13.969 LIRC, Error: Failed to connect to Unix socket '/var/run/lirc/lircd'
25                        eno: No such file or directory (2)
262011-05-14 19:18:13.969 JoystickMenuThread: Joystick disabled - Failed to read /home/berman/.mythtv/joystickmenurc
272011-05-14 19:18:14.142 Using Frameless Window
282011-05-14 19:18:14.143 Using Full Screen Window
292011-05-14 19:18:14.245 Using the Qt painter
302011-05-14 19:18:14.534 Current MythTV Schema Version (DBSchemaVer): 1264
312011-05-14 19:18:14.536 VDP: decoder<->render support: ffmpeg      null xlib xshm xv-blit opengl vdpau
322011-05-14 19:18:14.536 VDP: decoder<->render support: vdpau       vdpau
332011-05-14 19:18:14.536 VDP: decoder<->render support: libmpeg2    null xlib xshm xv-blit opengl vdpau
342011-05-14 19:18:14.542 VDP: Ignoring profile item 32 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
352011-05-14 19:18:14.542 VDP: Ignoring profile item 34 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
362011-05-14 19:18:14.545 VDP: Ignoring profile item 30 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
372011-05-14 19:18:14.548 VDP: Ignoring profile item 36 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
382011-05-14 19:18:14.548 VDP: Ignoring profile item 37 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
392011-05-14 19:18:14.548 VDP: Ignoring profile item 38 (decoder xvmc is not supported (supported: ffmpeg,vdpau,libmpeg2))
402011-05-14 19:18:14.551 VDP: Ignoring profile item 42 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
412011-05-14 19:18:14.551 VDP: Ignoring profile item 43 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
422011-05-14 19:18:14.554 VDP: Ignoring profile item 46 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
432011-05-14 19:18:14.554 VDP: Ignoring profile item 47 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
442011-05-14 19:18:14.560 VDP: Ignoring profile item 50 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
452011-05-14 19:18:14.560 VDP: Ignoring profile item 51 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
462011-05-14 19:18:14.814 ThemeInfo, Warning: Unable to open themeinfo.xml for /usr/share/mythtv/themes/BlackCurves-OSD/themeinfo.xml
472011-05-14 19:18:14.814 ThemeInfo, Error: The theme (/usr/share/mythtv/themes/BlackCurves-OSD) is missing a themeinfo.xml file.
482011-05-14 19:18:14.816 ThemeInfo, Warning: Unable to open themeinfo.xml for /usr/share/mythtv/themes/Gray-OSD/themeinfo.xml
492011-05-14 19:18:14.816 ThemeInfo, Error: The theme (/usr/share/mythtv/themes/Gray-OSD) is missing a themeinfo.xml file.
502011-05-14 19:18:15.712 Registering Internal as a media playback plugin.
512011-05-14 19:18:15.746 Current MythVideo Schema Version (mythvideo.DBSchemaVer): 1038
522011-05-14 19:18:15.860 Loading en_us translation for module mythvideo
532011-05-14 19:18:15.948 Found mainmenu.xml for theme 'Arclight'
542011-05-14 19:18:15.985 MythCoreContext: Connecting to backend server: 192.168.2.192:6543 (try 1 of 1)
552011-05-14 19:18:15.987 Using protocol version 63
562011-05-14 19:18:19.080 New DB connection, total: 2
572011-05-14 19:18:19.083 Connected to database 'mythconverg' at host: 192.168.2.192
582011-05-14 19:18:21.310 TV: StartTV() -- begin
592011-05-14 19:18:21.310 TV: ctor -- begin
602011-05-14 19:18:21.323 TV: ctor -- end
612011-05-14 19:18:21.323 TV: Init -- begin
622011-05-14 19:18:21.344 TV: DrawUnusedRects() -- begin
632011-05-14 19:18:21.344 TV: DrawUnusedRects() -- end
642011-05-14 19:18:21.345 TV: DrawUnusedRects() -- begin
652011-05-14 19:18:21.345 TV: DrawUnusedRects() -- end
662011-05-14 19:18:21.421 TV: DrawUnusedRects() -- begin
672011-05-14 19:18:21.422 TV: DrawUnusedRects() -- end
682011-05-14 19:18:21.465 TV: Init -- end
692011-05-14 19:18:21.467 TV: tv->Playback() -- begin
702011-05-14 19:18:21.488 TV: HandleStateChange(0) -- begin
712011-05-14 19:18:21.488 TV: Attempting to change from None to WatchingPreRecorded
722011-05-14 19:18:21.504 RingBuf(myth://192.168.2.192:6543/1061_20110513220000.mpg): OpenFile(myth://192.168.2.192:6543/1061_20110513220000.mpg, 2000 ms)
732011-05-14 19:18:21.656 TV: StartPlayer(0, WatchingPreRecorded, main) -- begin
742011-05-14 19:18:21.656 TV: Elapsed time since TV constructor was called: 346 ms
752011-05-14 19:18:21.802 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
762011-05-14 19:18:21.802 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
772011-05-14 19:18:21.803 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
782011-05-14 19:18:21.803 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
792011-05-14 19:18:21.803 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
802011-05-14 19:18:21.803 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
812011-05-14 19:18:21.803 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
822011-05-14 19:18:21.817 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
832011-05-14 19:18:21.818 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
842011-05-14 19:18:21.818 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
852011-05-14 19:18:21.829 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
862011-05-14 19:18:21.830 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
872011-05-14 19:18:21.840 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
882011-05-14 19:18:21.852 [mpeg2video @ 0x7f22d7487600]mpeg_decode_postinit() failure
892011-05-14 19:18:22.410 AFD: Stream #0, has id 0xca codec id MPEG2VIDEO, type Video, bitrate 38810400 at 0x7f22ace040d0
902011-05-14 19:18:22.419 VDP: Ignoring profile item 46 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
912011-05-14 19:18:22.419 VDP: Ignoring profile item 47 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
922011-05-14 19:18:22.420 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl) osd(opengl2) osdfade(disabled) deint(none,none) filt()
932011-05-14 19:18:22.420 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
942011-05-14 19:18:22.420 VDP: LoadBestPreferences(2048x2048, 0)
952011-05-14 19:18:22.420 VDP: LoadBestPreferences(2048x2048, 60)
962011-05-14 19:18:22.421 VDP: LoadBestPreferences(1920x1080, 60)
972011-05-14 19:18:22.427 VDP: Ignoring profile item 46 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
982011-05-14 19:18:22.427 VDP: Ignoring profile item 47 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
992011-05-14 19:18:22.427 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl) osd(opengl2) osdfade(disabled) deint(none,none) filt()
1002011-05-14 19:18:22.427 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
1012011-05-14 19:18:22.428 VDP: LoadBestPreferences(2048x2048, 0)
1022011-05-14 19:18:22.428 VDP: LoadBestPreferences(2048x2048, 60)
1032011-05-14 19:18:22.428 VDP: LoadBestPreferences(1920x1080, 60)
1042011-05-14 19:18:22.428 AFD: Using 2 CPUs for decoding
1052011-05-14 19:18:22.428 AFD: InitVideoCodec() 0x7f22ace08610 id(MPEG2VIDEO) type (Video).
1062011-05-14 19:18:22.429 AFD: Selected FPS is 29.97 (avg 34.83 stream 29.97 container 90000 estimated 29.97)
1072011-05-14 19:18:22.429 Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan
1082011-05-14 19:18:22.430 AFD: EIA-708 caption service #1 is in the English language.
1092011-05-14 19:18:22.430 AFD: Using ffmpeg for video decoding
1102011-05-14 19:18:22.430 AFD: Looking for decoder for MPEG2VIDEO
1112011-05-14 19:18:22.430 AFD: Opened codec 0x7f22ace08610, id(MPEG2VIDEO) type(Video)
1122011-05-14 19:18:22.430 AFD: Stream #1, has id 0xcb codec id AC3, type Audio, bitrate 384000 at 0x7f22acd095d0
1132011-05-14 19:18:22.430 AFD: codec AC3 has 6 channels
1142011-05-14 19:18:22.430 AFD: Looking for decoder for AC3
1152011-05-14 19:18:22.431 AFD: Opened codec 0x7f22acde4970, id(AC3) type(Audio)
1162011-05-14 19:18:22.432 AFD: Stream #2, has id 0xcc codec id AC3, type Audio, bitrate 192000 at 0x7f22accfc3f0
1172011-05-14 19:18:22.432 AFD: codec AC3 has 2 channels
1182011-05-14 19:18:22.432 AFD: Looking for decoder for AC3
1192011-05-14 19:18:22.433 AFD: Opened codec 0x7f22acccd960, id(AC3) type(Audio)
1202011-05-14 19:18:22.433 AFD: Stream #3, has id 0x110 codec id DVB_VBI, type Data, bitrate 0 at 0x7f22acccfb10
1212011-05-14 19:18:22.433 AFD: data codec (Data)
1222011-05-14 19:18:22.670 AO: Opening audio device 'default' ch 2(6) sr 48000 sf 32 bit floating point reenc 0
1232011-05-14 19:18:22.672 AudioOutput Warning: mmap not available, attempting to fall back to slow writes
1242011-05-14 19:18:22.712 ALSA, Error: no playback control PCM found on mixer device default
1252011-05-14 19:18:22.712 ALSA, Error: Unable to open audio mixer. Volume control disabled
1262011-05-14 19:18:22.712 AudioPlayer: Enabling Audio
1272011-05-14 19:18:22.712 Dec: Selected track #1 in the Unknown language(0)
1282011-05-14 19:18:22.712 Dec: Selected track #1 in the English language(6647399)
1292011-05-14 19:18:22.712 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
1302011-05-14 19:18:22.740 Dec: Position map filled from DB to: 107758
1312011-05-14 19:18:22.741 Dec: SyncPositionMap prerecorded, from DB: 7226 entries
1322011-05-14 19:18:22.741 Dec: SyncPositionMap, new totframes: 107758, new length: 3595, posMap size: 7226
1332011-05-14 19:18:22.741 AFD: Position map found
1342011-05-14 19:18:22.741 AFD: Successfully opened decoder for file: "myth://192.168.2.192:6543/1061_20110513220000.mpg". novideo(0)
1352011-05-14 19:18:22.748 DelMap: Tracker next CUT_START: 0
1362011-05-14 19:18:22.750 DelMap: Tracker next CUT_START: 0
1372011-05-14 19:18:22.750 DelMap: Tracker wants to jump to: 161
1382011-05-14 19:18:22.754 VideoOutput: Allowed renderers: xv-blit,xshm,xlib,opengl,vdpau
1392011-05-14 19:18:22.754 VideoOutput: Allowed renderers (filt: ffmpeg): xlib,xshm,xv-blit,opengl,vdpau
1402011-05-14 19:18:22.760 VDP: Ignoring profile item 46 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
1412011-05-14 19:18:22.760 VDP: Ignoring profile item 47 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
1422011-05-14 19:18:22.761 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl) osd(opengl2) osdfade(disabled) deint(none,none) filt()
1432011-05-14 19:18:22.761 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
1442011-05-14 19:18:22.761 VDP: LoadBestPreferences(2048x2048, 0)
1452011-05-14 19:18:22.761 VDP: LoadBestPreferences(2048x2048, 60)
1462011-05-14 19:18:22.761 VDP: LoadBestPreferences(1920x1080, 60)
1472011-05-14 19:18:22.761 VideoOutput: Preferred renderer: opengl
1482011-05-14 19:18:22.761 VideoOutput: Trying video renderer: 'opengl'
1492011-05-14 19:18:22.821 VDP: Ignoring profile item 46 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
1502011-05-14 19:18:22.821 VDP: Ignoring profile item 47 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,vdpau))
1512011-05-14 19:18:22.821 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl) osd(opengl2) osdfade(disabled) deint(none,none) filt()
1522011-05-14 19:18:22.821 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(none,none) filt()
1532011-05-14 19:18:22.822 VDP: LoadBestPreferences(2048x2048, 0)
1542011-05-14 19:18:22.822 VDP: LoadBestPreferences(2048x2048, 60)
1552011-05-14 19:18:22.822 VideoOutWindow::SetPIPState. pip_state: 0]
1562011-05-14 19:18:22.822 VDP: LoadBestPreferences(2048x2048, 29.97)
1572011-05-14 19:18:22.822 Snapping width to avoid scaling: width: 1920, left: 0
1582011-05-14 19:18:22.822 Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
1592011-05-14 19:18:22.822 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1602011-05-14 19:18:22.822 VDP: LoadBestPreferences(1920x1088, 29.97)
1612011-05-14 19:18:22.822 Snapping width to avoid scaling: width: 1920, left: 0
1622011-05-14 19:18:22.822 Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
1632011-05-14 19:18:22.822 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1642011-05-14 19:18:22.822 VDP: SetVideoRenderer(opengl)
1652011-05-14 19:18:22.823 VDP: SetVideoRender(opengl) == GetVideoRenderer()
1662011-05-14 19:18:22.964 OpenGL: OpenGL vendor  : ATI Technologies Inc.
1672011-05-14 19:18:22.964 OpenGL: OpenGL renderer: ATI Radeon HD 5450
1682011-05-14 19:18:22.964 OpenGL: OpenGL version : 4.1.10665 Compatibility Profile Context
1692011-05-14 19:18:22.964 OpenGL: Max texture size: 16384 x 16384
1702011-05-14 19:18:22.964 OpenGL: Max texture units: 8
1712011-05-14 19:18:22.964 OpenGL: Direct rendering: Yes
1722011-05-14 19:18:22.964 OpenGL: Initialised MythRenderOpenGL
1732011-05-14 19:18:22.965 VidOutGL: Created MythRenderOpenGL device.
1742011-05-14 19:18:22.966 VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
1752011-05-14 19:18:22.966 VideoOutput: Actual display dimensions: 508x285 mm  Aspect: 1.78246
1762011-05-14 19:18:22.966 VideoOutput: Estimated window dimensions: 508x285 mm  Aspect: 1.78246
1772011-05-14 19:18:23.044 GLVid: Viewport: 1920x1080
1782011-05-14 19:18:23.066 GLVid: Creating master filter.
1792011-05-14 19:18:23.067 GLVid: Created master fragment program
1802011-05-14 19:18:23.069 GLVid: Using packed textures with mmx and with PBOs
1812011-05-14 19:18:23.069 VDP: GetFilteredDeint() : opengl -> 'none'
1822011-05-14 19:18:23.070 VideoOutput, Error: Couldn't load deinterlace filter none
1832011-05-14 19:18:23.070 VideoOutput: Using deinterlace method
1842011-05-14 19:18:23.070 OpenGL painter using existing OpenGL context.
1852011-05-14 19:18:23.070 OpenGL painter using existing QGLWidget.
1862011-05-14 19:18:23.070 Snapping height to avoid scaling: height: 1080, top: 0
1872011-05-14 19:18:23.070 Snapping width to avoid scaling: width: 1920, left: 0
1882011-05-14 19:18:23.070 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1892011-05-14 19:18:23.070 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1902011-05-14 19:18:23.080 Over/underscan. V: 0, H: 0
1912011-05-14 19:18:23.080 Snapping height to avoid scaling: height: 1080, top: 0
1922011-05-14 19:18:23.080 Snapping width to avoid scaling: width: 1920, left: 0
1932011-05-14 19:18:23.080 Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1942011-05-14 19:18:23.080 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1952011-05-14 19:18:23.080 Player(0): LoadFilters(''..) -> 0x0
1962011-05-14 19:18:23.085 Player(0): Decoder thread starting.
1972011-05-14 19:18:23.086 AFD: DoFastForward(160 (0), do discard frames)
1982011-05-14 19:18:23.086 Dec: DoFastForward(160 (0), do discard frames)
1992011-05-14 19:18:23.086 Dec: FindPosition(160, search not adjusted) -->
200                        [10:150(8763056),11:165(9739528)]
2012011-05-14 19:18:23.087 AFD: SeekReset(165, 0, do flush, do discard)
2022011-05-14 19:18:23.087 AFD: SeekReset() flushing
2032011-05-14 19:18:23.087 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2042011-05-14 19:18:23.088 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2052011-05-14 19:18:23.088 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2062011-05-14 19:18:23.089 Player(0): ClearAfterSeek(0)
2072011-05-14 19:18:23.089 DelMap: Tracker next CUT_START: 16370
2082011-05-14 19:18:23.317 OSD: Loaded window osd_message
2092011-05-14 19:18:23.325 OSD: Loaded window osd_input
2102011-05-14 19:18:23.326 AFD: EIA-708 caption service #1 is in the English language.
2112011-05-14 19:18:23.326 AFD: EIA-608 caption service #1 is in the Undetermined language.
2122011-05-14 19:18:23.326 AFD: EIA-608 caption service #2 is in the Undetermined language.
2132011-05-14 19:18:23.326 AFD: EIA-608 caption service #3 is in the Undetermined language.
2142011-05-14 19:18:23.326 AFD: EIA-608 caption service #4 is in the Undetermined language.
2152011-05-14 19:18:23.326 Detect Letterbox: YV12 frame format detected
2162011-05-14 19:18:23.326 Detect Letterbox: The source is already in widescreen (aspect: 1.77778)
2172011-05-14 19:18:23.331 Dec: Trying to select track (w/lang)
2182011-05-14 19:18:23.331 Dec: Selecting first track
2192011-05-14 19:18:23.331 Dec: Selected track #1 in the Undetermined language(7695972)
2202011-05-14 19:18:23.362 OSD: Loaded window program_info
2212011-05-14 19:18:23.382 OSD: Loaded window browse_info
2222011-05-14 19:18:23.397 OSD: Loaded window osd_status
2232011-05-14 19:18:23.400 OSD: Loaded window osd_program_editor
2242011-05-14 19:18:23.400 OSD: Loaded OSD: size 1920x1080 offset 0+0
2252011-05-14 19:18:23.412 Player(0): ClearAfterSeek(0)
2262011-05-14 19:18:23.412 DelMap: Tracker next CUT_START: 16370
2272011-05-14 19:18:23.417 VDP: GetFilteredDeint() : opengl -> 'none'
2282011-05-14 19:18:23.417 VDP: GetFilteredDeint() : opengl -> 'none'
2292011-05-14 19:18:23.418 VideoOutput, Error: Couldn't load deinterlace filter none
2302011-05-14 19:18:23.418 VideoOutput: Using deinterlace method
2312011-05-14 19:18:23.418 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2322011-05-14 19:18:23.418 VSYNC: RTCVideoSync: Could not open /dev/rtc, Permission denied.
2332011-05-14 19:18:23.419 Player(0): Video timing method: USleep with busy wait
2342011-05-14 19:18:23.419 Player(0): Display Refresh Rate: 60.002 Video Frame Rate: 29.971
2352011-05-14 19:18:23.419 playCtx: StartPlaying(): took 0 ms to start player.
2362011-05-14 19:18:23.419 TV: StartPlayer(0, WatchingPreRecorded, main) -- end ok
2372011-05-14 19:18:23.420 TV: Changing from None to WatchingPreRecorded
2382011-05-14 19:18:23.430 TV: DrawUnusedRects() -- begin
2392011-05-14 19:18:23.430 TV: DrawUnusedRects() -- end
2402011-05-14 19:18:23.430 TV: HandleStateChange(0) -- end
2412011-05-14 19:18:23.430 TV: tv->Playback() -- end
2422011-05-14 19:18:23.430 TV: StartTV -- process events begin
2432011-05-14 19:18:23.441 PreviewQueue: Requesting preview for '1061_20110513220000.mpg_0x0_-1s'
2442011-05-14 19:18:23.441 PreviewQueue: Requested preview for '1061_20110513220000.mpg_0x0_-1s'
2452011-05-14 19:18:23.444 PreviewQueue: Requesting preview for '1061_20110513220000.mpg_0x0_-1s'
2462011-05-14 19:18:23.444 PreviewQueue: Requested preview for '1061_20110513220000.mpg_0x0_-1s'
2472011-05-14 19:18:23.447 ScreenSaverX11Private: DPMS Deactivated 1
2482011-05-14 19:18:23.448 ScreenSaverX11Private: ResetTimer -- begin
2492011-05-14 19:18:23.448 ScreenSaverX11Private: StopTimer
2502011-05-14 19:18:23.449 PreviewQueue: Requesting preview for '1061_20110513220000.mpg_0x0_-1s'
2512011-05-14 19:18:23.449 PreviewQueue: Requested preview for '1061_20110513220000.mpg_0x0_-1s'
2522011-05-14 19:18:23.449 ScreenSaverX11Private: StartTimer
2532011-05-14 19:18:23.449 ScreenSaverX11Private: ResetTimer -- end
2542011-05-14 19:18:23.449 TV: DrawUnusedRects() -- begin
2552011-05-14 19:18:23.449 TV: DrawUnusedRects() -- end
2562011-05-14 19:18:23.450 VDP: GetFilteredDeint() : opengl -> 'none'
2572011-05-14 19:18:23.450 VDP: GetFilteredDeint() : opengl -> 'none'
2582011-05-14 19:18:23.450 VideoOutput, Error: Couldn't load deinterlace filter none
2592011-05-14 19:18:23.451 VideoOutput: Using deinterlace method
2602011-05-14 19:18:23.451 Player(0): Failed to enable deinterlacing
2612011-05-14 19:18:23.567 Player(0): Video is 3.07619 frames behind audio (too slow), dropping frame to catch up.
2622011-05-14 19:18:23.580 Player(0): Video is 3.33363 frames behind audio (too slow), dropping frame to catch up.
2632011-05-14 19:18:23.589 Player(0): Video is 3.37685 frames behind audio (too slow), dropping frame to catch up.
2642011-05-14 19:18:23.598 Player(0): Video is 3.22196 frames behind audio (too slow), dropping frame to catch up.
2652011-05-14 19:18:23.890 PreviewQueue: Requesting preview for '1061_20110513220000.mpg_0x0_-1s'
2662011-05-14 19:18:23.890 PreviewQueue: Requested preview for '1061_20110513220000.mpg_0x0_-1s'
267'video_output' mean = '31168.14', std. dev. = '6835.89', fps = '32.08'
268'video_output' mean = '33364.42', std. dev. = '186.19', fps = '29.97'
2692011-05-14 19:18:31.321 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2702011-05-14 19:18:31.321 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2712011-05-14 19:18:31.355 TV: HandleStateChange(0) -- begin
2722011-05-14 19:18:31.355 TV: Attempting to change from WatchingPreRecorded to None
2732011-05-14 19:18:31.355 TV: StopStuff() for player ctx 0 -- begin
2742011-05-14 19:18:31.355 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2752011-05-14 19:18:31.355 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2762011-05-14 19:18:31.355 Player(0): StopPlaying - begin
2772011-05-14 19:18:31.361 Player(0): Decoder thread exiting.
2782011-05-14 19:18:31.362 Player(0): Exited decoder loop.
2792011-05-14 19:18:31.362 VideoBuffers::DiscardFrames(1): UUuUuUULUUUUUUUUUUUUUUUUUUUUUUU
2802011-05-14 19:18:31.362 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2812011-05-14 19:18:31.362 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2822011-05-14 19:18:31.363 GLVid: Removing master filter
2832011-05-14 19:18:31.363 Clearing OpenGL painter cache.
2842011-05-14 19:18:31.363 MythPainter: 43 images not yet de-allocated.
2852011-05-14 19:18:31.364 OpenGL: Deleting OpenGL Resources
2862011-05-14 19:18:31.390 Player(0): StopPlaying - end
2872011-05-14 19:18:31.391 TV: StopStuff(): stopping ring buffer
2882011-05-14 19:18:31.441 TV: StopStuff(): stopping player
2892011-05-14 19:18:31.441 TV: StopStuff() -- end
2902011-05-14 19:18:31.441 TV: Changing from WatchingPreRecorded to None
2912011-05-14 19:18:31.441 TV: HandleStateChange(0) -- end
2922011-05-14 19:18:31.441 TV: StartTV -- process events end
2932011-05-14 19:18:31.441 TV: StartTV -- process events 2 begin
2942011-05-14 19:18:31.442 ScreenSaverX11Private: DPMS Reactivated 1
2952011-05-14 19:18:31.443 ScreenSaverX11Private: StopTimer
2962011-05-14 19:18:31.443 TV: StartTV -- process events 2 end
2972011-05-14 19:18:31.443 TV::~TV() -- begin
2982011-05-14 19:18:31.443 TV: DrawUnusedRects() -- begin
2992011-05-14 19:18:31.443 TV: DrawUnusedRects() -- end
3002011-05-14 19:18:31.443 TV: DrawUnusedRects() -- begin
3012011-05-14 19:18:31.443 TV: DrawUnusedRects() -- end
3022011-05-14 19:18:31.454 TV::~TV() -- lock
3032011-05-14 19:18:31.454 Player(0): StopPlaying - begin
3042011-05-14 19:18:31.454 Player(0): Exited decoder loop.
3052011-05-14 19:18:31.454 Player(0): StopPlaying - end
3062011-05-14 19:18:31.470 TV::~TV() -- end
3072011-05-14 19:18:31.472 TV: StartTV -- end
3082011-05-14 19:18:43.295 Deleting UPnP client...