2012-12-25 21:45:21.628989 C  mythfrontend version: fixes/0.25 [v0.25.3-7-gfe9f6fa] www.mythtv.org
2012-12-25 21:45:21.629026 C  Qt version: compile: 4.7.3, runtime: 4.7.3
2012-12-25 21:45:21.629033 N  Enabled verbose msgs:  general playback
2012-12-25 21:45:21.629070 N  Setting Log Level to LOG_INFO
2012-12-25 21:45:21.629143 I  Added logging to the console
2012-12-25 21:45:21.629154 I  Added database logging to table logging
2012-12-25 21:45:21.629267 N  Setting up SIGHUP handler
2012-12-25 21:45:21.629403 N  Using runtime prefix = /usr
2012-12-25 21:45:21.629423 N  Using configuration directory = /home/mythtv/.mythtv
2012-12-25 21:45:21.629620 I  Assumed character encoding: en_US.utf-8
2012-12-25 21:45:21.630488 N  Empty LocalHostName.
2012-12-25 21:45:21.630502 I  Using localhost value of LinHES
2012-12-25 21:45:21.652099 N  Setting QT default locale to EN_US
2012-12-25 21:45:21.652118 I  Current locale EN_US
2012-12-25 21:45:21.652183 N  Reading locale defaults from /usr/share/mythtv//locales/en_us.xml
2012-12-25 21:45:21.661692 I  Starting process manager
2012-12-25 21:45:21.663377 I  Starting IO manager (write)
2012-12-25 21:45:21.668106 I  Starting IO manager (read)
2012-12-25 21:45:21.668215 I  Starting process signal handler
2012-12-25 21:45:21.773066 I  ScreenSaverX11Private: DPMS is disabled.
2012-12-25 21:45:21.851784 N  Desktop video mode: 1280x720 60.073 Hz
2012-12-25 21:45:21.906991 I  max_width: 1280 max_height: 720
2012-12-25 21:45:21.914629 I  Listening on TCP 127.0.0.1:6547
2012-12-25 21:45:21.914714 I  Listening on TCP 192.168.1.210:6547
2012-12-25 21:45:21.914807 I  Listening on TCP [0:0:0:0:0:0:0:1]:6547
2012-12-25 21:45:21.914897 I  Listening on TCP [fe80:0:0:0:21a:92ff:fecb:5342%eth0]:6547
2012-12-25 21:45:22.640067 E  RAOP Conn: Failed to read key from: /home/mythtv/.mythtv/RAOPKey.rsa
2012-12-25 21:45:22.640098 E  RAOP Device: Aborting startup - no key found.
2012-12-25 21:45:22.646619 I  Loading en_us translation for module mythfrontend
2012-12-25 21:45:22.659832 I  LIRC: Successfully initialized '/var/run/lirc/lircd' using '/home/mythtv/.mythtv/lircrc' config
2012-12-25 21:45:22.660032 E  JoystickMenuThread: Joystick disabled - Failed to read /home/mythtv/.mythtv/joystickmenurc
2012-12-25 21:45:22.732540 E  CECAdapter: Failed to find any CEC devices.
2012-12-25 21:45:22.732884 I  CECAdapter: Closing down CEC.
2012-12-25 21:45:22.734913 E  Failed binding to UDP 127.0.0.1:6948 - Error 8: The bound address is already in use
2012-12-25 21:45:22.735077 E  Failed binding to UDP 192.168.1.210:6948 - Error 8: The bound address is already in use
2012-12-25 21:45:22.735249 E  Failed binding to UDP [0:0:0:0:0:0:0:1]:6948 - Error 8: The bound address is already in use
2012-12-25 21:45:22.735414 E  Failed binding to UDP [fe80:0:0:0:21a:92ff:fecb:5342%eth0]:6948 - Error 8: The bound address is already in use
2012-12-25 21:45:22.735566 E  Failed binding to UDP 192.168.1.255:6948 - Error 8: The bound address is already in use
2012-12-25 21:45:22.785919 I  Using Frameless Window
2012-12-25 21:45:22.786041 I  Using Full Screen Window
2012-12-25 21:45:22.960883 I  Trying the OpenGL painter
2012-12-25 21:45:22.963398 I  OpenGL: Sync to VBlank is enabled (good!)
2012-12-25 21:45:23.070183 I  OpenGL1: Fragment program support available
2012-12-25 21:45:23.070280 I  OpenGL: OpenGL vendor  : NVIDIA Corporation
2012-12-25 21:45:23.070290 I  OpenGL: OpenGL renderer: GeForce 6150/PCI/SSE2/3DNOW!
2012-12-25 21:45:23.070297 I  OpenGL: OpenGL version : 2.1.0 NVIDIA 96.43.19
2012-12-25 21:45:23.070316 I  OpenGL: Max texture size: 4096 x 4096
2012-12-25 21:45:23.070325 I  OpenGL: Max texture units: 4
2012-12-25 21:45:23.070337 I  OpenGL: Direct rendering: Yes
2012-12-25 21:45:23.070346 I  OpenGL: PixelBufferObject support available
2012-12-25 21:45:23.070357 I  OpenGL: Initialised MythRenderOpenGL
2012-12-25 21:45:23.193646 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 26
			Name: 'basemedium'	Type: 'fontdef'
2012-12-25 21:45:23.193780 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 30
			Name: 'basemediumbold'	Type: 'fontdef'
2012-12-25 21:45:23.208801 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 35
			Name: 'baselarge'	Type: 'fontdef'
2012-12-25 21:45:23.225492 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 43
			Name: 'baselargenormal'	Type: 'fontdef'
2012-12-25 21:45:23.240295 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 47
			Name: 'baseextralarge'	Type: 'fontdef'
2012-12-25 21:45:23.241425 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 111
			Name: 'basemedium_normal'	Type: 'fontdef'
2012-12-25 21:45:23.241500 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 114
			Name: 'basemedium_normal_selected'	Type: 'fontdef'
2012-12-25 21:45:23.241572 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 117
			Name: 'basemedium_disabled'	Type: 'fontdef'
2012-12-25 21:45:23.241646 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 120
			Name: 'basemedium_highlight'	Type: 'fontdef'
2012-12-25 21:45:23.241719 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 123
			Name: 'basemedium_normal_button'	Type: 'fontdef'
2012-12-25 21:45:23.241793 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 126
			Name: 'basemedium_selected_button'	Type: 'fontdef'
2012-12-25 21:45:23.241866 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 129
			Name: 'basemedium_disabled_button'	Type: 'fontdef'
2012-12-25 21:45:23.258271 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 134
			Name: 'deleterecordings_filesize_font'	Type: 'fontdef'
2012-12-25 21:45:23.474355 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 1073
			Name: 'large'	Type: 'fontdef'
2012-12-25 21:45:23.474501 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/base.xml @ 1079
			Name: 'clock'	Type: 'fontdef'
2012-12-25 21:45:23.519041 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/default-wide/base.xml @ 60
			Name: 'basemediumgrey'	Type: 'fontdef'
2012-12-25 21:45:23.519129 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/default-wide/base.xml @ 64
			Name: 'basemediumgreen'	Type: 'fontdef'
2012-12-25 21:45:23.519203 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/default-wide/base.xml @ 68
			Name: 'basemediumred'	Type: 'fontdef'
2012-12-25 21:45:23.519276 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/default-wide/base.xml @ 72
			Name: 'basemediumpurple'	Type: 'fontdef'
2012-12-25 21:45:23.565783 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/default/base.xml @ 80
			Name: 'basemediumyellow'	Type: 'fontdef'
2012-12-25 21:45:23.587107 I  Current MythTV Schema Version (DBSchemaVer): 1299
2012-12-25 21:45:23.587702 I  VDP: decoder<->render support: ffmpeg      null xlib xshm xv-blit opengl opengl-lite vdpau nullvdpau nullvaapi openglvaapi
2012-12-25 21:45:23.587715 I  VDP: decoder<->render support: vdpau       vdpau nullvdpau
2012-12-25 21:45:23.587724 I  VDP: decoder<->render support: vaapi       nullvaapi openglvaapi
2012-12-25 21:45:23.587735 I  VDP: decoder<->render support: crystalhd   null xlib xshm xv-blit opengl opengl-lite vdpau nullvdpau nullvaapi
2012-12-25 21:45:23.590454 N  VDP: Ignoring profile item 15 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2012-12-25 21:45:23.590517 N  VDP: Ignoring profile item 16 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2012-12-25 21:45:23.591249 N  VDP: Ignoring profile item 19 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2012-12-25 21:45:23.591302 N  VDP: Ignoring profile item 20 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2012-12-25 21:45:23.593629 N  VDP: Ignoring profile item 23 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2012-12-25 21:45:23.593684 N  VDP: Ignoring profile item 24 (renderer quartz-blit is not supported w/decoder ffmpeg (supported: null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2012-12-25 21:45:23.833890 N  Registering Internal as a media playback plugin.
2012-12-25 21:45:23.912921 I  Loading en_us translation for module mytharchive
2012-12-25 21:45:23.917180 N  Registering WebBrowser as a media playback plugin.
2012-12-25 21:45:23.917317 I  Loading en_us translation for module mythbrowser
2012-12-25 21:45:23.935032 I  Loading en_us translation for module mythgallery
2012-12-25 21:45:23.940265 I  Loading en_us translation for module mythgame
2012-12-25 21:45:23.949542 I  Current MythMusic Schema Version (MusicDBSchemaVer): 1019
2012-12-25 21:45:23.962584 I  Loading en_us translation for module mythmusic
2012-12-25 21:45:23.964917 I  Loading en_us translation for module mythnetvision
2012-12-25 21:45:23.968501 I  Loading en_us translation for module mythnews
2012-12-25 21:45:23.969194 !  MythPlugin::init() dlerror: libmythdb-0.24.so.0: cannot open shared object file: No such file or directory
2012-12-25 21:45:23.969222 E  Unable to initialize plugin 'mythsmolt'.
2012-12-25 21:45:23.978406 !  Plugin mythstream (0.24.20110505-1) binary version does not match libraries (0.25.20120506-1)
2012-12-25 21:45:23.978444 E  Unable to initialize plugin 'mythstream'.
2012-12-25 21:45:23.983473 I  Loading en_us translation for module mythweather
2012-12-25 21:45:23.985232 I  Listening on TCP 127.0.0.1:6546
2012-12-25 21:45:23.985326 I  Listening on TCP 192.168.1.210:6546
2012-12-25 21:45:23.985433 I  Listening on TCP [0:0:0:0:0:0:0:1]:6546
2012-12-25 21:45:23.985530 I  Listening on TCP [fe80:0:0:0:21a:92ff:fecb:5342%eth0]:6546
2012-12-25 21:45:23.992364 E  MythFontProperties: Failed to load 'Liberation Sans', got 'DejaVu Sans' instead
			Location: /usr/share/mythtv/themes/MythCenter-wide/menu-ui.xml @ 8
			Name: 'menufont'	Type: 'fontdef'
2012-12-25 21:45:24.113310 N  Found mainmenu.xml for theme 'MythCenter-wide'
2012-12-25 21:45:24.316843 I  MythCoreContext: Connecting to backend server: 192.168.1.210:6543 (try 1 of 1)
2012-12-25 21:45:24.317811 I  Using protocol version 72
2012-12-25 21:45:24.333321 I  Bonjour: Service registration complete: name 'Mythfrontend on LinHES' type '_mythfrontend._tcp.' domain: 'local.'
2012-12-25 21:45:35.415799 I  TV: Creating TV object
2012-12-25 21:45:35.471705 I  TV: Finished creating TV object
2012-12-25 21:45:35.471827 I  TV: StartTV() -- begin
2012-12-25 21:45:35.472093 N  Resuming idle timer
2012-12-25 21:45:35.472139 N  Suspending idle timer
2012-12-25 21:45:35.472163 I  TV: Init -- begin
2012-12-25 21:45:35.478640 I  TV: Created TvPlayWindow.
2012-12-25 21:45:35.479279 I  TV: DrawUnusedRects() -- begin
2012-12-25 21:45:35.479306 I  TV: DrawUnusedRects() -- end
2012-12-25 21:45:35.483337 I  TV: Init -- end
2012-12-25 21:45:35.498507 I  TV: tv->LiveTV() -- begin
2012-12-25 21:45:35.511552 I  TV: HandleStateChange(0) -- begin
2012-12-25 21:45:35.511597 I  TV: Attempting to change from None to WatchingLiveTV
2012-12-25 21:45:35.511664 I  MythCoreContext: Connecting to backend server: 192.168.1.210:6543 (try 1 of 1)
2012-12-25 21:45:35.512859 I  Using protocol version 72
2012-12-25 21:45:35.561742 I  MythCoreContext: Connecting to backend server: 192.168.1.210:6543 (try 1 of 1)
2012-12-25 21:45:35.562621 I  Using protocol version 72
2012-12-25 21:45:35.563447 N  TV: Spawning LiveTV Recorder -- begin
2012-12-25 21:45:35.664070 N  TV: Spawning LiveTV Recorder -- end
2012-12-25 21:45:35.665656 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): ReloadAll(): Added new recording
2012-12-25 21:45:35.665743 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): LiveTVChain has 1 entries
*  DUMMY: 3939 (21:45:35 to 23:28:00)

2012-12-25 21:45:35.678249 I  TV: playbackURL(myth://192.168.1.210:6543/3939_20121225214535.mpg) cardtype(DUMMY)
2012-12-25 21:45:35.680670 I  TV: StartRecorder(): took 0 ms to start recorder.
2012-12-25 21:45:35.680720 I  TV: StartPlayer(0, WatchingLiveTV, main) -- begin
2012-12-25 21:45:35.680750 I  TV: Elapsed time since TV constructor was called: 265 ms
2012-12-25 21:45:35.899855 N  AudioPlayer: Enabling Audio
2012-12-25 21:45:35.899994 I  Player(0): SetFrameInterval ps:1 scan:3
2012-12-25 21:45:35.900050 I  Player(0): detectInterlace(Ignore Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2012-12-25 21:45:35.903809 I  Player(0): Stretch Factor 1, allow passthru 
2012-12-25 21:45:35.905498 I  VideoOutput: Allowed renderers: xv-blit,xshm,xlib,opengl,opengl-lite,vdpau,openglvaapi
2012-12-25 21:45:35.905570 I  VideoOutput: Allowed renderers (filt: dummy): xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,openglvaapi
2012-12-25 21:45:35.908743 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:35.908826 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:35.908870 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:35.908925 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:35.908990 I  VDP: LoadBestPreferences(720x576, 60)
2012-12-25 21:45:35.909052 I  VideoOutput: Preferred renderer: xv-blit
2012-12-25 21:45:35.909093 I  VideoOutput: Trying video renderer: 'xv-blit'
2012-12-25 21:45:35.926740 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:35.926825 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:35.926858 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:35.926908 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:35.926974 I  VideoOutputXv: ctor
2012-12-25 21:45:35.927035 I  VideoOutWindow::SetPIPState. pip_state: 0]
2012-12-25 21:45:35.927058 I  VDP: LoadBestPreferences(2048x2048, 25)
2012-12-25 21:45:35.928833 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.33333
2012-12-25 21:45:35.928871 I  Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2012-12-25 21:45:35.928896 I  VDP: LoadBestPreferences(720x576, 25)
2012-12-25 21:45:35.928991 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.33333
2012-12-25 21:45:35.929020 I  Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2012-12-25 21:45:35.931100 I  VideoOutput: Pixel dimensions: Screen 1280x720, window 1280x720
2012-12-25 21:45:35.931149 I  VideoOutput: Actual display dimensions: 325x183 mm  Aspect: 1.77596
2012-12-25 21:45:35.931175 I  VideoOutput: Estimated window dimensions: 325x183 mm  Aspect: 1.77596
2012-12-25 21:45:35.931999 I  VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib
2012-12-25 21:45:35.934339 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:35.934422 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:35.934453 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:35.934501 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:35.934540 I  VDP: LoadBestPreferences(720x576, 60)
2012-12-25 21:45:35.934835 I  VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  2
2012-12-25 21:45:35.934862 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:35.934875 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:35.935038 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:35.935077 I  VideoOutputXv: Adaptor#1: NV05 Video Blitter has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:35.935093 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:35.935204 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:35.935230 I  VideoOutputXv: @ j=1 Looking for flag[s]: XvInputMask XvImageMask  0
2012-12-25 21:45:35.935260 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:35.935275 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:35.935399 I  VideoOutputXv: Grabbed xv port 281
2012-12-25 21:45:35.935538 I  VideoOutputXv: XVideo surface found on port 281
2012-12-25 21:45:35.935552 I  VideoOutputXv: XV_SET_DEFAULTS is supported on this port
2012-12-25 21:45:35.935833 I  VideoOutputXv: XV_SYNC_TO_VBLANK supported
2012-12-25 21:45:35.935860 I  VideoOutputXv: XVideo Sync to VBlank set
2012-12-25 21:45:35.935902 I  VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2012-12-25 21:45:35.936062 I  VideoOutputXv: XVideo Format #0 is 'YUY2'
2012-12-25 21:45:35.936099 I  VideoOutputXv: XVideo Format #1 is 'YV12'
2012-12-25 21:45:35.936125 I  VideoOutputXv: XVideo Format #2 is 'UYVY'
2012-12-25 21:45:35.936173 I  VideoOutputXv: XVideo Format #3 is 'I420'
2012-12-25 21:45:35.936198 I  VideoOutputXv: Using XVideo Format 'YV12'
2012-12-25 21:45:35.936239 I  VideoOutputXv: CreateShmImages(32): video_dim: 720x576
2012-12-25 21:45:36.012850 I  VDP: SetVideoRenderer(xv-blit)
2012-12-25 21:45:36.012890 I  VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2012-12-25 21:45:36.013751 I  ColourSpace: PictureAttributes: 
2012-12-25 21:45:36.014031 I  VideoOutputXv: Chromakeying not possible with this XVideo port.
2012-12-25 21:45:36.014158 I  Display Rect  left: 160, top: 0, width: 960, height: 720, aspect: 1.77778
2012-12-25 21:45:36.014201 I  Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2012-12-25 21:45:36.017806 I  Over/underscan. V: 0.02, H: 0.02
2012-12-25 21:45:36.017919 I  Display Rect  left: 160, top: 0, width: 960, height: 720, aspect: 1.77778
2012-12-25 21:45:36.017977 I  Video Rect    left: 14, top: 12, width: 691, height: 553, aspect: 1.33333
2012-12-25 21:45:36.018035 I  Player(0): LoadFilters(''..) -> 0x0
2012-12-25 21:45:36.020529 I  OSD: Base theme size: 1280x720
2012-12-25 21:45:36.020577 I  OSD: Scaling factors: 0.540625x0.769444
2012-12-25 21:45:36.024443 I  Player(0): Decoder thread starting.
2012-12-25 21:45:36.095388 I  OSD: Loaded window osd_message
2012-12-25 21:45:36.104352 I  OSD: Loaded window osd_input
2012-12-25 21:45:36.208255 I  OSD: Loaded window program_info
2012-12-25 21:45:36.213606 I  OSD: Loaded window browse_info
2012-12-25 21:45:36.219145 I  OSD: Loaded window osd_status
2012-12-25 21:45:36.224071 I  OSD: Loaded window osd_program_editor
2012-12-25 21:45:36.266907 I  OSD: Loaded window osd_debug
2012-12-25 21:45:36.266965 I  OSD: Loaded OSD: size 692x554 offset 14+11
2012-12-25 21:45:36.267024 I  OSD: Base theme size: 1280x720
2012-12-25 21:45:36.267041 I  OSD: Scaling factors: 0.540625x0.769444
2012-12-25 21:45:36.268928 I  OSD: Created window aa_OSD_SUBTITLES
2012-12-25 21:45:36.269009 I  Player(0): ClearAfterSeek(0)
2012-12-25 21:45:36.270276 I  VDP: GetFilteredDeint() : xv-blit -> 'greedyhdoubleprocessdeint'
2012-12-25 21:45:36.271274 I  FilterManager: GetFilterInfo(convert) returning: 0x0
2012-12-25 21:45:36.271302 I  FilterManager: GetFilterInfo(greedyhdoubleprocessdeint) returning: 0xffffffffa5972ce8
2012-12-25 21:45:36.273805 I  VideoOutput: Using deinterlace method greedyhdoubleprocessdeint
2012-12-25 21:45:36.273899 I  VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2012-12-25 21:45:36.273964 E  VSYNC: RTCVideoSync: Could not set RTC frequency: 
			eno: Permission denied (13)
2012-12-25 21:45:36.275228 I  Player(0): Video timing method: USleep with busy wait
2012-12-25 21:45:36.275252 I  Player(0): Display Refresh Rate: 60.074 Video Frame Rate: 25.000
2012-12-25 21:45:36.275274 I  Player(0): SetFrameInterval ps:1 scan:1
2012-12-25 21:45:36.275485 I  playCtx: StartPlaying(): took 0 ms to start player.
2012-12-25 21:45:36.275517 I  TV: Created player.
2012-12-25 21:45:36.275547 I  TV: StartPlayer(0, WatchingLiveTV, main) -- end ok
2012-12-25 21:45:36.275570 I  TV: Changing from None to WatchingLiveTV
2012-12-25 21:45:36.275581 I  TV: State is LiveTV & mctx == ctx
2012-12-25 21:45:36.276898 I  TV: UpdateOSDInput done
2012-12-25 21:45:36.276923 I  TV: UpdateLCD done
2012-12-25 21:45:36.277215 I  TV: ITVRestart done
2012-12-25 21:45:36.300365 I  TV: DrawUnusedRects() -- begin
2012-12-25 21:45:36.300385 I  TV: DrawUnusedRects() -- end
2012-12-25 21:45:36.300464 I  TV: Main UI disabled.
2012-12-25 21:45:36.300476 I  TV: HandleStateChange(0) -- end
2012-12-25 21:45:36.301039 I  TV: tv->LiveTV() -- end
2012-12-25 21:45:36.301048 I  TV: Entering main playback loop.
2012-12-25 21:45:36.378159 I  VideoOutput: Created YV12 OSD.
2012-12-25 21:45:36.773519 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): ReloadAll(): Added new recording
2012-12-25 21:45:36.773617 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): LiveTVChain has 2 entries
*  DUMMY: 3939 (21:45:35 to 21:45:36)
  HDHOMERUN: 3939 (21:45:36 to 23:28:00) discontinuous

2012-12-25 21:45:36.775011 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): SwitchTo(1)
2012-12-25 21:45:36.775073 I  Player(0): JumpToProgram - start
2012-12-25 21:45:36.783998 I  Player(0): LoadFilters(''..) -> 0x0
2012-12-25 21:45:36.784925 I  Player(0): Play speed: rate: 25 speed: 0 skip: 0 => new interval 40000
2012-12-25 21:45:36.785757 I  VDP: GetFilteredDeint(linearblend) : xv-blit -> 'linearblend'
2012-12-25 21:45:36.787706 I  FilterManager: GetFilterInfo(convert) returning: 0x0
2012-12-25 21:45:36.787743 I  FilterManager: GetFilterInfo(linearblend) returning: 0x9de2890
2012-12-25 21:45:36.787809 I  VideoOutput: Using deinterlace method linearblend
2012-12-25 21:45:36.790528 I  FileRingBuf(myth://192.168.1.210:6543/3939_20121225214535.mpg): OpenFile(myth://192.168.1.210:6543/3939_20121225214536.mpg, 10000 ms)
2012-12-25 21:45:36.792046 I  Using protocol version 72
2012-12-25 21:45:36.793635 I  Using protocol version 72
2012-12-25 21:45:38.338166 I  Player(0): Stretch Factor 1, allow passthru 
2012-12-25 21:45:38.338905 I  AFD: Buffer size: 32768, streamed 1
2012-12-25 21:45:39.045784 I  AFD: Stream #0, has id 0x840 codec id MPEG2VIDEO, type Video, bitrate 20000000 at 0x9de0400
2012-12-25 21:45:39.048435 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:39.048521 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:39.048554 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:39.048605 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:39.048644 I  VDP: LoadBestPreferences(1920x1080, 60)
2012-12-25 21:45:39.048740 I  AFD: Using 2 CPUs for decoding
2012-12-25 21:45:39.048770 I  AFD: InitVideoCodec() 0xa7ca460 id(MPEG2VIDEO) type (Video).
2012-12-25 21:45:39.048873 I  AFD: Selected FPS is 29.97 (avg 29.97 codec 29.97 container 90000 estimated 29.97)
2012-12-25 21:45:39.048901 I  Player(0): SetFrameInterval ps:0 scan:3
2012-12-25 21:45:39.051345 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:39.051429 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:39.051457 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:39.051503 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:39.051562 I  VDP: LoadBestPreferences(1920x1080, 60)
2012-12-25 21:45:39.051653 I  VDP: LoadBestPreferences(720x576, 29.97)
2012-12-25 21:45:39.051720 I  VideoOutputXv: InputChanged(1920,1080,1.33333) 'None'->'MPEG2'
2012-12-25 21:45:39.051746 I  VDP: LoadBestPreferences(1920x1088, 29.97)
2012-12-25 21:45:39.051891 I  VDP: GetFilteredDeint() : xv-blit -> 'bobdeint'
2012-12-25 21:45:39.053813 I  FilterManager: GetFilterInfo(convert) returning: 0x0
2012-12-25 21:45:39.053849 I  FilterManager: GetFilterInfo(bobdeint) returning: 0x9dbd258
2012-12-25 21:45:39.053911 I  VideoOutput: Using deinterlace method bobdeint
2012-12-25 21:45:39.053928 I  VideoOutputXv: DiscardFrames(1)
2012-12-25 21:45:39.054056 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:39.054138 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:45:39.054202 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:45:39.054216 I  VideoOutputXv: DiscardFrames(1)
2012-12-25 21:45:39.054274 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:39.054335 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:45:39.054393 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:45:39.059114 I  VideoOutputXv: Closing XVideo port 281
2012-12-25 21:45:39.067508 I  VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib
2012-12-25 21:45:39.070242 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:39.070330 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:39.070362 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:39.070411 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:39.070450 I  VDP: LoadBestPreferences(1920x1088, 60)
2012-12-25 21:45:39.070717 I  VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  2
2012-12-25 21:45:39.070740 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:39.070753 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:39.070857 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:39.070877 I  VideoOutputXv: Adaptor#1: NV05 Video Blitter has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:39.070889 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:39.071097 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:39.071155 I  VideoOutputXv: @ j=1 Looking for flag[s]: XvInputMask XvImageMask  0
2012-12-25 21:45:39.071184 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:39.071197 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:39.071353 I  VideoOutputXv: Grabbed xv port 281
2012-12-25 21:45:39.071623 I  VideoOutputXv: XVideo surface found on port 281
2012-12-25 21:45:39.071640 I  VideoOutputXv: XV_SET_DEFAULTS is supported on this port
2012-12-25 21:45:39.071852 I  VideoOutputXv: XV_SYNC_TO_VBLANK supported
2012-12-25 21:45:39.071868 I  VideoOutputXv: XVideo Sync to VBlank set
2012-12-25 21:45:39.071913 I  VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2012-12-25 21:45:39.072084 I  VideoOutputXv: XVideo Format #0 is 'YUY2'
2012-12-25 21:45:39.072105 I  VideoOutputXv: XVideo Format #1 is 'YV12'
2012-12-25 21:45:39.072124 I  VideoOutputXv: XVideo Format #2 is 'UYVY'
2012-12-25 21:45:39.072142 I  VideoOutputXv: XVideo Format #3 is 'I420'
2012-12-25 21:45:39.072160 I  VideoOutputXv: Using XVideo Format 'YV12'
2012-12-25 21:45:39.072180 I  VideoOutputXv: CreateShmImages(32): video_dim: 1920x1088
2012-12-25 21:45:39.360086 I  VDP: SetVideoRenderer(xv-blit)
2012-12-25 21:45:39.360113 I  VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2012-12-25 21:45:39.360513 I  ColourSpace: PictureAttributes: 
2012-12-25 21:45:39.360630 I  VideoOutputXv: Chromakeying not possible with this XVideo port.
2012-12-25 21:45:39.360673 I  Display Rect  left: 160, top: 0, width: 960, height: 720, aspect: 1.77778
2012-12-25 21:45:39.360688 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.33333
2012-12-25 21:45:39.362937 I  OSD: Base theme size: 1280x720
2012-12-25 21:45:39.362982 I  OSD: Scaling factors: 1.44062x1.44167
2012-12-25 21:45:39.397169 I  OSD: Loaded window osd_message
2012-12-25 21:45:39.401716 I  OSD: Loaded window osd_input
2012-12-25 21:45:39.525908 I  OSD: Loaded window program_info
2012-12-25 21:45:39.532572 I  OSD: Loaded window browse_info
2012-12-25 21:45:39.545982 I  OSD: Loaded window osd_status
2012-12-25 21:45:39.557294 I  OSD: Loaded window osd_program_editor
2012-12-25 21:45:39.605735 I  OSD: Loaded window osd_debug
2012-12-25 21:45:39.605766 I  OSD: Loaded OSD: size 1844x1038 offset 38+21
2012-12-25 21:45:39.605814 I  EnableCaptions(0) msg:  On
2012-12-25 21:45:39.605829 I  Player(0): ClearAfterSeek(1)
2012-12-25 21:45:39.605836 I  VideoOutputXv: ClearAfterSeek()
2012-12-25 21:45:39.605844 I  VideoOutputXv: DiscardFrames(0)
2012-12-25 21:45:39.605882 I  VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:39.605915 I  VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:45:39.605968 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:45:39.605991 I  Player(0): LoadFilters(''..) -> 0x0
2012-12-25 21:45:39.606018 I  Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan
2012-12-25 21:45:39.606033 I  Player(0): Enabled deinterlacing
2012-12-25 21:45:39.606102 I  AFD: Using ffmpeg for video decoding
2012-12-25 21:45:39.606112 I  AFD: Looking for decoder for MPEG2VIDEO
2012-12-25 21:45:39.610602 I  AFD: Opened codec 0xa7ca460, id(MPEG2VIDEO) type(Video)
2012-12-25 21:45:39.610638 I  AFD: Stream #1, has id 0x841 codec id AC3, type Audio, bitrate 384000 at 0xa113bc0
2012-12-25 21:45:39.610650 I  AFD: codec AC3 has 6 channels
2012-12-25 21:45:39.610658 I  AFD: Looking for decoder for AC3
2012-12-25 21:45:39.611165 I  AFD: Opened codec 0x9e194c0, id(AC3) type(Audio)
2012-12-25 21:45:39.611217 I  AFD: Stream #2, has id 0x842 codec id AC3, type Audio, bitrate 384000 at 0xa51c820
2012-12-25 21:45:39.611226 I  AFD: codec AC3 has 2 channels
2012-12-25 21:45:39.611233 I  AFD: Looking for decoder for AC3
2012-12-25 21:45:39.611727 I  AFD: Opened codec 0xa4c4b20, id(AC3) type(Audio)
2012-12-25 21:45:39.618866 I  AO: Opening audio device 'iec958:CARD=NVidia,DEV=0' ch 2(6) sr 48000 sf signed 16 bit reenc 0
2012-12-25 21:45:39.621158 E  ALSA: Setting hardware audio buffer size to 128
2012-12-25 21:45:39.621278 E  ALSA: Error opening /proc/asound/card0/pcm1p/sub0/prealloc: Permission denied. 
2012-12-25 21:45:39.621291 E  ALSA: Try to manually increase audio buffer with: echo 128 | sudo tee /proc/asound/card0/pcm1p/sub0/prealloc
2012-12-25 21:45:39.621314 E  ALSA: Unable to sufficiently increase ALSA hardware buffer size - underruns are likely
2012-12-25 21:45:39.630243 I  Dec: Selected track #1 in the Unknown language(0)
2012-12-25 21:45:39.630297 I  Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
2012-12-25 21:45:39.631173 I  Dec: Position map filled from DB to: 0
2012-12-25 21:45:39.631186 I  Dec: SyncPositionMap watchingrecording, from DB: 1 entries
2012-12-25 21:45:39.631205 I  Player(0): Filling position map from 1 to end
2012-12-25 21:45:39.631696 I  Dec: Position map filled from Encoder to: 36
2012-12-25 21:45:39.631715 I  Dec: SyncPositionMap watchingrecording total: 2 entries
2012-12-25 21:45:39.631731 I  Dec: SyncPositionMap, new totframes: 36, new length: 1, posMap size: 2
2012-12-25 21:45:39.633193 I  AFD: Partial position map found
2012-12-25 21:45:39.633209 I  AFD: Successfully opened decoder for file: "myth://192.168.1.210:6543/3939_20121225214536.mpg". novideo(0)
2012-12-25 21:45:39.637470 N  AFD: Resetting byte context eof (livetv 1 was eof 0)
2012-12-25 21:45:40.065503 I  Player(0): Play(  1.0, normal 1, unpause audio 1)
2012-12-25 21:45:40.065909 I  Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
2012-12-25 21:45:40.066035 I  Player(0): Play speed: rate: 29.97 speed: 1 skip: 1 => new interval 33366
2012-12-25 21:45:40.066098 I  Player(0): Stretch Factor 1, allow passthru 
2012-12-25 21:45:40.066119 I  Player(0): JumpToProgram - end
2012-12-25 21:45:40.066154 I  Player(0): Waiting for video buffers...
2012-12-25 21:45:40.067969 I  Dec: Position map filled from DB to: 0
2012-12-25 21:45:40.067996 I  Dec: SyncPositionMap watchingrecording, from DB: 1 entries
2012-12-25 21:45:40.068024 I  Player(0): Filling position map from 1 to end
2012-12-25 21:45:40.068868 I  Dec: Position map filled from Encoder to: 36
2012-12-25 21:45:40.068898 I  Dec: SyncPositionMap watchingrecording total: 2 entries
2012-12-25 21:45:40.105652 I  Detect Letterbox: YV12 frame format detected
2012-12-25 21:45:40.118790 I  Detect Letterbox: YV12 frame format detected
2012-12-25 21:45:40.167762 N  Player(0): Waited 101ms for video buffers UuUULAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:40.272367 N  Player(0): Waited 206ms for video buffers UuUULAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:40.376240 N  Player(0): Waited 310ms for video buffers UuUULAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:40.480182 N  Player(0): Waited 414ms for video buffers UuUULAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:40.585441 N  Player(0): Waited 519ms for video buffers UuUULAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:40.689610 N  Player(0): Waited 623ms for video buffers UuUULAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:40.792969 N  Player(0): Waited 726ms for video buffers UUUULUULAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:40.887742 I  Player(0): Video Aspect ratio changed from 1.33333 to 1.77778
2012-12-25 21:45:40.887808 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.77778
2012-12-25 21:45:40.887841 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.77778
2012-12-25 21:45:40.890097 I  OSD: Base theme size: 1280x720
2012-12-25 21:45:40.890153 I  OSD: Scaling factors: 1.44062x1.44167
2012-12-25 21:45:40.903660 I  OSD: Loaded window osd_message
2012-12-25 21:45:40.908091 I  Detect Letterbox: The source is already in widescreen (aspect: 1.77778)
2012-12-25 21:45:40.913712 I  OSD: Loaded window osd_input
2012-12-25 21:45:40.951288 I  OSD: Loaded window program_info
2012-12-25 21:45:40.967078 I  OSD: Loaded window browse_info
2012-12-25 21:45:40.983858 I  OSD: Loaded window osd_status
2012-12-25 21:45:40.996253 I  OSD: Loaded window osd_program_editor
2012-12-25 21:45:41.034105 I  OSD: Loaded window osd_debug
2012-12-25 21:45:41.034135 I  OSD: Loaded OSD: size 1844x1038 offset 38+21
2012-12-25 21:45:41.034186 I  EnableCaptions(0) msg:  On
2012-12-25 21:45:41.034205 I  Player(0): Enabled deinterlacing
2012-12-25 21:45:41.034222 I  VideoOutput: OSD size changed.
2012-12-25 21:45:41.120446 I  VideoOutput: Created YV12 OSD.
2012-12-25 21:45:41.166930 I  Player(0): Video is 3.91117 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.170627 I  Player(0): Video is 6.61976 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.174586 I  Player(0): Video is 8.7561 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.180360 I  Player(0): Video is 10.1036 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.184395 I  Player(0): Video is 10.6122 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.188269 I  Player(0): Video is 10.7464 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.192248 I  Player(0): Video is 10.5773 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.196335 I  Player(0): Video is 10.2033 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.199904 I  Player(0): Video is 9.66796 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.203146 I  Player(0): Video is 9.01921 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.206495 I  Player(0): Video is 8.27792 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.209718 I  Player(0): Video is 7.46718 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.213089 I  Player(0): Video is 6.61188 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.216703 I  Player(0): Video is 5.72316 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.220534 I  Player(0): Video is 4.80186 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.224058 I  Player(0): Video is 3.8936 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:41.748746 I  TV: Pausing player: 0
2012-12-25 21:45:41.815069 I  Display Rect  left: 940, top: 50, width: 300, height: 170, aspect: 1.77778
2012-12-25 21:45:41.815099 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.77778
2012-12-25 21:45:41.815118 I  Display Rect  left: 940, top: 50, width: 300, height: 170, aspect: 1.77778
2012-12-25 21:45:41.815135 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.77778
2012-12-25 21:45:41.815566 I  TV: DrawUnusedRects() -- begin
2012-12-25 21:45:41.815579 I  TV: DrawUnusedRects() -- end
2012-12-25 21:45:41.847919 I  TV: DrawUnusedRects() -- begin
2012-12-25 21:45:41.847935 I  TV: DrawUnusedRects() -- end
2012-12-25 21:45:41.847999 I  TV: DrawUnusedRects() -- begin
2012-12-25 21:45:41.848006 I  TV: DrawUnusedRects() -- end
2012-12-25 21:45:42.068862 I  Player(0): Video is 3.38093 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.074151 I  Player(0): Video is 3.73452 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.078090 I  Player(0): Video is 3.75244 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.084139 I  Player(0): Video is 3.51115 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.090274 I  Player(0): Video is 3.0829 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.378881 I  Player(0): Video is 3.52437 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.385199 I  Player(0): Video is 3.75217 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.391604 I  Player(0): Video is 3.66829 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:42.397857 I  Player(0): Video is 3.35812 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:43.590646 I  Player(0): Video is 3.00719 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:43.849247 I  Player(0): Video is 3.23773 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:43.853399 I  Player(0): Video is 3.80693 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:43.862770 I  Player(0): Video is 3.98657 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:43.868692 I  Player(0): Video is 3.86657 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:43.874498 I  Player(0): Video is 3.61173 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:43.879270 I  Player(0): Video is 3.21828 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:44.089593 I  Player(0): FPS:   34.18 Mean: 29252 Std.Dev: 25651 CPUs: 297% 54% 
2012-12-25 21:45:47.486188 I  Player(0): FPS:   29.45 Mean: 33955 Std.Dev:  5002 CPUs: 85% 86% 
2012-12-25 21:45:49.173413 I  Player(0): Video is 3.02149 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.178891 I  Player(0): Video is 3.12776 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.214483 I  Player(0): Video is 3.19247 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.921894 I  Player(0): Video is 3.20914 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.927892 I  Player(0): Video is 3.66562 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.952917 I  Player(0): Video is 3.80567 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.964012 I  Player(0): Video is 3.84328 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.972485 I  Player(0): Video is 3.66918 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:49.975575 I  Player(0): Video is 3.35129 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:50.916468 I  Player(0): FPS:   29.16 Mean: 34291 Std.Dev: 14311 CPUs: 79% 90% 
2012-12-25 21:45:51.172263 I  Player(0): Video is 3.15276 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:51.178142 I  Player(0): Video is 3.33112 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:51.183913 I  Player(0): Video is 3.21762 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:52.157890 I  Player(0): Video is 3.21621 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:52.178649 I  Player(0): Video is 3.35623 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:52.185285 I  Player(0): Video is 3.68603 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:52.211178 I  Player(0): Video is 3.4014 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:53.362195 I  Player(0): Video is 3.03848 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:45:53.576404 I  AFD: EIA-708 caption service #1 is in the Undetermined language.
2012-12-25 21:45:53.594722 I  Dec: Selected track #1 in the Undetermined language(7695972)
2012-12-25 21:45:53.838136 I  AFD: EIA-708 caption service #1 is in the Undetermined language.
2012-12-25 21:45:53.838160 I  AFD: EIA-608 caption service #1 is in the Undetermined language.
2012-12-25 21:45:53.860715 I  Dec: Selected track #1 in the Undetermined language(7695972)
2012-12-25 21:45:54.195557 I  Player(0): 400 interlaced frames seen.
2012-12-25 21:45:54.329908 I  Player(0): FPS:   29.31 Mean: 34123 Std.Dev: 14552 CPUs: 67% 74% 
2012-12-25 21:45:54.530271 I  Player(0): progressive frame seen after 409 interlaced frames
2012-12-25 21:45:54.597090 I  Player(0): Disabled deinterlacing
2012-12-25 21:45:56.696036 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.77778
2012-12-25 21:45:56.696087 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.77778
2012-12-25 21:45:56.696120 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.77778
2012-12-25 21:45:56.696148 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.77778
2012-12-25 21:45:56.696194 I  Clearing OpenGL painter cache.
2012-12-25 21:45:56.891377 I  TV: DrawUnusedRects() -- begin
2012-12-25 21:45:56.891407 I  TV: DrawUnusedRects() -- end
2012-12-25 21:45:56.891604 I  TV: CommitQueuedInput() livetv(1) qchannum(31.1) qchanid(2161)
2012-12-25 21:45:57.007604 I  Player(0): StopPlaying - begin
2012-12-25 21:45:57.009283 I  Player(0): Decoder thread exiting.
2012-12-25 21:45:57.009673 I  Player(0): Exited decoder loop.
2012-12-25 21:45:57.010767 I  VideoOutputXv: dtor
2012-12-25 21:45:57.010798 I  VideoOutputXv: DiscardFrames(1)
2012-12-25 21:45:57.010878 I  VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUuUUUUuUULUUUUUUUUUP
2012-12-25 21:45:57.011022 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:45:57.011092 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:45:57.021376 I  VideoOutputXv: Closing XVideo port 281
2012-12-25 21:45:57.073821 W  MythPainter: 16 images not yet de-allocated.
2012-12-25 21:45:57.086157 I  Player(0): StopPlaying - end
2012-12-25 21:45:57.163918 I  Player(0): StopPlaying - begin
2012-12-25 21:45:57.163986 I  Player(0): Exited decoder loop.
2012-12-25 21:45:57.164006 I  Player(0): StopPlaying - end
2012-12-25 21:45:57.169277 I  MythCoreContext: Connecting to backend server: 192.168.1.210:6543 (try 1 of 1)
2012-12-25 21:45:57.170505 I  Using protocol version 72
2012-12-25 21:45:57.279408 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): ReloadAll(): Added new recording
2012-12-25 21:45:57.279554 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): LiveTVChain has 3 entries
   DUMMY: 3939 (21:45:35 to 21:45:36)
* HDHOMERUN: 3939 (21:45:36 to 21:45:57) discontinuous
   DUMMY: 2161 (21:45:57 to 22:00:00) discontinuous

2012-12-25 21:45:57.320578 I  TV: StartRecorder(): took 26 ms to start recorder.
2012-12-25 21:45:57.501520 N  AudioPlayer: Enabling Audio
2012-12-25 21:45:57.501620 I  Player(1): SetFrameInterval ps:1 scan:3
2012-12-25 21:45:57.501670 I  Player(1): detectInterlace(Ignore Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2012-12-25 21:45:57.501815 I  Player(1): Stretch Factor 1, allow passthru 
2012-12-25 21:45:57.503535 I  VideoOutput: Allowed renderers: xv-blit,xshm,xlib,opengl,opengl-lite,vdpau,openglvaapi
2012-12-25 21:45:57.503605 I  VideoOutput: Allowed renderers (filt: dummy): xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,openglvaapi
2012-12-25 21:45:57.506374 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:57.506468 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:57.506505 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:57.506556 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:57.506702 I  VDP: LoadBestPreferences(720x576, 60)
2012-12-25 21:45:57.506748 I  VideoOutput: Preferred renderer: xv-blit
2012-12-25 21:45:57.506784 I  VideoOutput: Trying video renderer: 'xv-blit'
2012-12-25 21:45:57.510971 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:57.511071 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:57.511124 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:57.511177 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:57.511209 I  VideoOutputXv: ctor
2012-12-25 21:45:57.511244 I  VideoOutWindow::SetPIPState. pip_state: 0]
2012-12-25 21:45:57.511267 I  VDP: LoadBestPreferences(2048x2048, 25)
2012-12-25 21:45:57.512999 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.33333
2012-12-25 21:45:57.513038 I  Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2012-12-25 21:45:57.513063 I  VDP: LoadBestPreferences(720x576, 25)
2012-12-25 21:45:57.513136 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.33333
2012-12-25 21:45:57.513167 I  Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2012-12-25 21:45:57.515179 I  VideoOutput: Pixel dimensions: Screen 1280x720, window 1280x720
2012-12-25 21:45:57.515230 I  VideoOutput: Actual display dimensions: 325x183 mm  Aspect: 1.77596
2012-12-25 21:45:57.515257 I  VideoOutput: Estimated window dimensions: 325x183 mm  Aspect: 1.77596
2012-12-25 21:45:57.516059 I  VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib
2012-12-25 21:45:57.518586 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:57.518673 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:57.518709 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:57.518762 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:57.518804 I  VDP: LoadBestPreferences(720x576, 60)
2012-12-25 21:45:57.519112 I  VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  2
2012-12-25 21:45:57.519140 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:57.519153 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:57.519270 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:57.519292 I  VideoOutputXv: Adaptor#1: NV05 Video Blitter has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:57.519303 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:57.519406 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:57.519431 I  VideoOutputXv: @ j=1 Looking for flag[s]: XvInputMask XvImageMask  0
2012-12-25 21:45:57.519452 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:57.519463 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:57.519568 I  VideoOutputXv: Grabbed xv port 281
2012-12-25 21:45:57.519677 I  VideoOutputXv: XVideo surface found on port 281
2012-12-25 21:45:57.519695 I  VideoOutputXv: XV_SET_DEFAULTS is supported on this port
2012-12-25 21:45:57.519972 I  VideoOutputXv: XV_SYNC_TO_VBLANK supported
2012-12-25 21:45:57.519991 I  VideoOutputXv: XVideo Sync to VBlank set
2012-12-25 21:45:57.520031 I  VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2012-12-25 21:45:57.520160 I  VideoOutputXv: XVideo Format #0 is 'YUY2'
2012-12-25 21:45:57.520190 I  VideoOutputXv: XVideo Format #1 is 'YV12'
2012-12-25 21:45:57.520210 I  VideoOutputXv: XVideo Format #2 is 'UYVY'
2012-12-25 21:45:57.520231 I  VideoOutputXv: XVideo Format #3 is 'I420'
2012-12-25 21:45:57.520250 I  VideoOutputXv: Using XVideo Format 'YV12'
2012-12-25 21:45:57.520276 I  VideoOutputXv: CreateShmImages(32): video_dim: 720x576
2012-12-25 21:45:57.599106 I  VDP: SetVideoRenderer(xv-blit)
2012-12-25 21:45:57.599149 I  VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2012-12-25 21:45:57.599972 I  ColourSpace: PictureAttributes: 
2012-12-25 21:45:57.600164 I  VideoOutputXv: Chromakeying not possible with this XVideo port.
2012-12-25 21:45:57.600234 I  Display Rect  left: 160, top: 0, width: 960, height: 720, aspect: 1.77778
2012-12-25 21:45:57.600265 I  Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.33333
2012-12-25 21:45:57.600327 I  Over/underscan. V: 0.02, H: 0.02
2012-12-25 21:45:57.600357 I  Display Rect  left: 160, top: 0, width: 960, height: 720, aspect: 1.77778
2012-12-25 21:45:57.600384 I  Video Rect    left: 14, top: 12, width: 691, height: 553, aspect: 1.33333
2012-12-25 21:45:57.600422 I  Player(1): LoadFilters(''..) -> 0x0
2012-12-25 21:45:57.603027 I  OSD: Base theme size: 1280x720
2012-12-25 21:45:57.603067 I  Player(1): Decoder thread starting.
2012-12-25 21:45:57.603103 I  OSD: Scaling factors: 0.540625x0.769444
2012-12-25 21:45:57.612851 I  OSD: Loaded window osd_message
2012-12-25 21:45:57.621323 I  OSD: Loaded window osd_input
2012-12-25 21:45:57.636104 I  OSD: Loaded window program_info
2012-12-25 21:45:57.646216 I  OSD: Loaded window browse_info
2012-12-25 21:45:57.656880 I  OSD: Loaded window osd_status
2012-12-25 21:45:57.667625 I  OSD: Loaded window osd_program_editor
2012-12-25 21:45:57.692313 I  OSD: Loaded window osd_debug
2012-12-25 21:45:57.692402 I  OSD: Loaded OSD: size 692x554 offset 14+11
2012-12-25 21:45:57.692486 I  OSD: Base theme size: 1280x720
2012-12-25 21:45:57.692519 I  OSD: Scaling factors: 0.540625x0.769444
2012-12-25 21:45:57.692590 I  OSD: Created window aa_OSD_SUBTITLES
2012-12-25 21:45:57.692659 I  Player(1): ClearAfterSeek(0)
2012-12-25 21:45:57.695075 I  VDP: GetFilteredDeint() : xv-blit -> 'greedyhdoubleprocessdeint'
2012-12-25 21:45:57.697090 I  FilterManager: GetFilterInfo(convert) returning: 0x0
2012-12-25 21:45:57.697132 I  FilterManager: GetFilterInfo(greedyhdoubleprocessdeint) returning: 0xa7cb640
2012-12-25 21:45:57.701822 I  VideoOutput: Using deinterlace method greedyhdoubleprocessdeint
2012-12-25 21:45:57.701971 I  VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2012-12-25 21:45:57.702050 E  VSYNC: RTCVideoSync: Could not set RTC frequency: 
			eno: Permission denied (13)
2012-12-25 21:45:57.706439 I  Player(1): Video timing method: USleep with busy wait
2012-12-25 21:45:57.706467 I  Player(1): Display Refresh Rate: 60.074 Video Frame Rate: 25.000
2012-12-25 21:45:57.706479 I  Player(1): SetFrameInterval ps:1 scan:1
2012-12-25 21:45:57.707005 I  playCtx: StartPlaying(): took 0 ms to start player.
2012-12-25 21:45:57.708782 I  TV: UnpauseLiveTV() player ctx 0
2012-12-25 21:45:57.712117 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): SwitchTo(-1)
2012-12-25 21:45:57.712129 E  LiveTVChain(live-LinHES-2012-12-25T21:45:35): SwitchTo() not switching to current
2012-12-25 21:45:57.712151 I  Player(1): Play(  1.0, normal 1, unpause audio 0)
2012-12-25 21:45:57.739574 I  TV: DrawUnusedRects() -- begin
2012-12-25 21:45:57.739595 I  TV: DrawUnusedRects() -- end
2012-12-25 21:45:57.797045 I  VideoOutput: Created YV12 OSD.
2012-12-25 21:45:57.966921 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): ReloadAll(): Added new recording
2012-12-25 21:45:57.967038 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): LiveTVChain has 4 entries
   DUMMY: 3939 (21:45:35 to 21:45:36)
  HDHOMERUN: 3939 (21:45:36 to 21:45:57) discontinuous
*  DUMMY: 2161 (21:45:57 to 21:45:57) discontinuous
  HDHOMERUN: 2161 (21:45:58 to 22:00:00) discontinuous

2012-12-25 21:45:57.967786 I  LiveTVChain(live-LinHES-2012-12-25T21:45:35): SwitchTo(3)
2012-12-25 21:45:57.967806 I  Player(1): JumpToProgram - start
2012-12-25 21:45:57.973297 I  Player(1): LoadFilters(''..) -> 0x0
2012-12-25 21:45:57.974417 I  Player(1): Play speed: rate: 25 speed: 0 skip: 0 => new interval 40000
2012-12-25 21:45:57.974885 I  VDP: GetFilteredDeint(linearblend) : xv-blit -> 'linearblend'
2012-12-25 21:45:57.976054 I  FilterManager: GetFilterInfo(convert) returning: 0x0
2012-12-25 21:45:57.976081 I  FilterManager: GetFilterInfo(linearblend) returning: 0xa2c69e8
2012-12-25 21:45:57.976123 I  VideoOutput: Using deinterlace method linearblend
2012-12-25 21:45:57.976829 I  FileRingBuf(myth://192.168.1.210:6543/2161_20121225214557.mpg): OpenFile(myth://192.168.1.210:6543/2161_20121225214558.mpg, 10000 ms)
2012-12-25 21:45:57.977515 I  Using protocol version 72
2012-12-25 21:45:57.978358 I  Using protocol version 72
2012-12-25 21:45:58.577209 I  Player(1): Stretch Factor 1, allow passthru 
2012-12-25 21:45:58.578053 I  AFD: Buffer size: 32768, streamed 1
2012-12-25 21:45:59.234131 I  AFD: Stream #0, has id 0x800 codec id MPEG2VIDEO, type Video, bitrate 20000000 at 0xa113bc0
2012-12-25 21:45:59.237760 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:59.237869 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:59.237902 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:59.237974 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:59.238013 I  VDP: LoadBestPreferences(1920x1080, 60)
2012-12-25 21:45:59.238087 I  AFD: Using 2 CPUs for decoding
2012-12-25 21:45:59.238111 I  AFD: InitVideoCodec() 0xad06e50 id(MPEG2VIDEO) type (Video).
2012-12-25 21:45:59.238202 I  AFD: Selected FPS is 29.97 (avg 81.3472 codec 29.97 container 90000 estimated 29.97)
2012-12-25 21:45:59.238255 I  Player(1): SetFrameInterval ps:0 scan:3
2012-12-25 21:45:59.240435 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:59.240516 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:59.240540 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:59.240580 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:59.240616 I  VDP: LoadBestPreferences(1920x1080, 60)
2012-12-25 21:45:59.240685 I  VDP: LoadBestPreferences(720x576, 29.97)
2012-12-25 21:45:59.240744 I  VideoOutputXv: InputChanged(1920,1080,1.33333) 'None'->'MPEG2'
2012-12-25 21:45:59.240771 I  VDP: LoadBestPreferences(1920x1088, 29.97)
2012-12-25 21:45:59.240927 I  VDP: GetFilteredDeint() : xv-blit -> 'bobdeint'
2012-12-25 21:45:59.243103 I  FilterManager: GetFilterInfo(convert) returning: 0x0
2012-12-25 21:45:59.243143 I  FilterManager: GetFilterInfo(bobdeint) returning: 0xa51c658
2012-12-25 21:45:59.243209 I  VideoOutput: Using deinterlace method bobdeint
2012-12-25 21:45:59.243228 I  VideoOutputXv: DiscardFrames(1)
2012-12-25 21:45:59.243316 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:59.243387 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:45:59.243466 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:45:59.243482 I  VideoOutputXv: DiscardFrames(1)
2012-12-25 21:45:59.243538 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:59.243597 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:45:59.243654 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:45:59.248071 I  VideoOutputXv: Closing XVideo port 281
2012-12-25 21:45:59.256349 I  VideoOutputXv: InitSetupBuffers() render: xv-blit, allowed: xv-blit,xshm,xlib
2012-12-25 21:45:59.259399 I  VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(bobdeint,onefield) filt()
2012-12-25 21:45:59.259489 I  VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(0) skiploop(enabled) rend(xv-blit) osd(softblend) osdfade(enabled) deint(greedyhdoubleprocessdeint,linearblend) filt()
2012-12-25 21:45:59.259523 I  VDP: LoadBestPreferences(2048x2048, 0)
2012-12-25 21:45:59.259573 I  VDP: LoadBestPreferences(2048x2048, 60)
2012-12-25 21:45:59.259612 I  VDP: LoadBestPreferences(1920x1088, 60)
2012-12-25 21:45:59.259938 I  VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask XvImageMask  2
2012-12-25 21:45:59.259985 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:59.259998 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:59.260110 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:59.260130 I  VideoOutputXv: Adaptor#1: NV05 Video Blitter has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:59.260141 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:59.260239 E  VideoOutputXv: Missing XV_BRIGHTNESS, rejecting.
2012-12-25 21:45:59.260259 I  VideoOutputXv: @ j=1 Looking for flag[s]: XvInputMask XvImageMask  0
2012-12-25 21:45:59.260279 I  VideoOutputXv: Adaptor#0: NV17 Video Texture has flag[s]: XvInputMask XvImageMask 
2012-12-25 21:45:59.260289 I  VideoOutputXv: Has XVideo flags...
2012-12-25 21:45:59.260391 I  VideoOutputXv: Grabbed xv port 281
2012-12-25 21:45:59.260499 I  VideoOutputXv: XVideo surface found on port 281
2012-12-25 21:45:59.260512 I  VideoOutputXv: XV_SET_DEFAULTS is supported on this port
2012-12-25 21:45:59.260691 I  VideoOutputXv: XV_SYNC_TO_VBLANK supported
2012-12-25 21:45:59.260707 I  VideoOutputXv: XVideo Sync to VBlank set
2012-12-25 21:45:59.260750 I  VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2012-12-25 21:45:59.260878 I  VideoOutputXv: XVideo Format #0 is 'YUY2'
2012-12-25 21:45:59.260910 I  VideoOutputXv: XVideo Format #1 is 'YV12'
2012-12-25 21:45:59.260930 I  VideoOutputXv: XVideo Format #2 is 'UYVY'
2012-12-25 21:45:59.260969 I  VideoOutputXv: XVideo Format #3 is 'I420'
2012-12-25 21:45:59.260988 I  VideoOutputXv: Using XVideo Format 'YV12'
2012-12-25 21:45:59.261010 I  VideoOutputXv: CreateShmImages(32): video_dim: 1920x1088
2012-12-25 21:45:59.554446 I  VDP: SetVideoRenderer(xv-blit)
2012-12-25 21:45:59.554469 I  VDP: SetVideoRender(xv-blit) == GetVideoRenderer()
2012-12-25 21:45:59.554818 I  ColourSpace: PictureAttributes: 
2012-12-25 21:45:59.554924 I  VideoOutputXv: Chromakeying not possible with this XVideo port.
2012-12-25 21:45:59.554978 I  Display Rect  left: 160, top: 0, width: 960, height: 720, aspect: 1.77778
2012-12-25 21:45:59.554994 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.33333
2012-12-25 21:45:59.556645 I  OSD: Base theme size: 1280x720
2012-12-25 21:45:59.556673 I  OSD: Scaling factors: 1.44062x1.44167
2012-12-25 21:45:59.561059 I  OSD: Loaded window osd_message
2012-12-25 21:45:59.565173 I  OSD: Loaded window osd_input
2012-12-25 21:45:59.572210 I  OSD: Loaded window program_info
2012-12-25 21:45:59.577790 I  OSD: Loaded window browse_info
2012-12-25 21:45:59.582805 I  OSD: Loaded window osd_status
2012-12-25 21:45:59.587787 I  OSD: Loaded window osd_program_editor
2012-12-25 21:45:59.599656 I  OSD: Loaded window osd_debug
2012-12-25 21:45:59.599683 I  OSD: Loaded OSD: size 1844x1038 offset 38+21
2012-12-25 21:45:59.599725 I  EnableCaptions(0) msg:  On
2012-12-25 21:45:59.599739 I  Player(1): ClearAfterSeek(1)
2012-12-25 21:45:59.599745 I  VideoOutputXv: ClearAfterSeek()
2012-12-25 21:45:59.599752 I  VideoOutputXv: DiscardFrames(0)
2012-12-25 21:45:59.599786 I  VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:45:59.599816 I  VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:45:59.599845 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:45:59.599866 I  Player(1): LoadFilters(''..) -> 0x0
2012-12-25 21:45:59.599890 I  Player(1): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan
2012-12-25 21:45:59.599903 I  Player(1): Enabled deinterlacing
2012-12-25 21:45:59.599985 I  AFD: EIA-708 caption service #1 is in the English language.
2012-12-25 21:45:59.599994 I  AFD: Using ffmpeg for video decoding
2012-12-25 21:45:59.600003 I  AFD: Looking for decoder for MPEG2VIDEO
2012-12-25 21:45:59.600132 I  AFD: Opened codec 0xad06e50, id(MPEG2VIDEO) type(Video)
2012-12-25 21:45:59.600150 I  AFD: Stream #1, has id 0x801 codec id AC3, type Audio, bitrate 384000 at 0xad05760
2012-12-25 21:45:59.600160 I  AFD: codec AC3 has 6 channels
2012-12-25 21:45:59.600167 I  AFD: Looking for decoder for AC3
2012-12-25 21:45:59.600616 I  AFD: Opened codec 0xadde8e0, id(AC3) type(Audio)
2012-12-25 21:45:59.609124 I  AO: Opening audio device 'iec958:CARD=NVidia,DEV=0' ch 2(6) sr 48000 sf signed 16 bit reenc 0
2012-12-25 21:45:59.610018 E  ALSA: Setting hardware audio buffer size to 128
2012-12-25 21:45:59.610105 E  ALSA: Error opening /proc/asound/card0/pcm1p/sub0/prealloc: Permission denied. 
2012-12-25 21:45:59.610118 E  ALSA: Try to manually increase audio buffer with: echo 128 | sudo tee /proc/asound/card0/pcm1p/sub0/prealloc
2012-12-25 21:45:59.610136 E  ALSA: Unable to sufficiently increase ALSA hardware buffer size - underruns are likely
2012-12-25 21:45:59.618188 I  Dec: Selected track #1 in the Unknown language(0)
2012-12-25 21:45:59.618269 I  Dec: Selected track #1 in the English language(6647399)
2012-12-25 21:45:59.618289 I  Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
2012-12-25 21:45:59.619038 I  Dec: Position map filled from DB to: 15
2012-12-25 21:45:59.619051 I  Dec: SyncPositionMap watchingrecording, from DB: 2 entries
2012-12-25 21:45:59.619065 I  Player(1): Filling position map from 16 to end
2012-12-25 21:45:59.619536 I  Dec: Position map filled from Encoder to: 30
2012-12-25 21:45:59.619551 I  Dec: SyncPositionMap watchingrecording total: 3 entries
2012-12-25 21:45:59.619566 I  Dec: SyncPositionMap, new totframes: 30, new length: 1, posMap size: 3
2012-12-25 21:45:59.621037 I  AFD: Partial position map found
2012-12-25 21:45:59.621052 I  AFD: Successfully opened decoder for file: "myth://192.168.1.210:6543/2161_20121225214558.mpg". novideo(0)
2012-12-25 21:45:59.625203 N  AFD: Resetting byte context eof (livetv 1 was eof 0)
2012-12-25 21:45:59.929590 I  Player(1): Play(  1.0, normal 1, unpause audio 1)
2012-12-25 21:45:59.930348 I  Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
2012-12-25 21:45:59.930371 I  Player(1): Play speed: rate: 29.97 speed: 1 skip: 1 => new interval 33366
2012-12-25 21:45:59.930421 I  Player(1): Stretch Factor 1, allow passthru 
2012-12-25 21:45:59.930442 I  Player(1): JumpToProgram - end
2012-12-25 21:45:59.930476 I  Player(1): Waiting for video buffers...
2012-12-25 21:45:59.932642 I  Dec: Position map filled from DB to: 15
2012-12-25 21:45:59.932671 I  Dec: SyncPositionMap watchingrecording, from DB: 2 entries
2012-12-25 21:45:59.932701 I  Player(1): Filling position map from 16 to end
2012-12-25 21:45:59.933791 I  Dec: Position map filled from Encoder to: 45
2012-12-25 21:45:59.933831 I  Dec: SyncPositionMap watchingrecording total: 4 entries
2012-12-25 21:45:59.933859 I  Dec: SyncPositionMap, new totframes: 45, new length: 1, posMap size: 4
2012-12-25 21:45:59.978597 I  Detect Letterbox: YV12 frame format detected
2012-12-25 21:46:00.034640 N  Player(1): Waited 104ms for video buffers uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.139017 N  Player(1): Waited 208ms for video buffers uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.243487 N  Player(1): Waited 313ms for video buffers uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.348310 N  Player(1): Waited 418ms for video buffers uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.452221 N  Player(1): Waited 522ms for video buffers uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.556282 N  Player(1): Waited 626ms for video buffers uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.585670 I  Detect Letterbox: YV12 frame format detected
2012-12-25 21:46:00.657226 N  Player(1): Waited 727ms for video buffers UUUULUULAAAAAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.759765 N  Player(1): Waited 829ms for video buffers UUUUUUUuUULLAAAAAAAAAAAAAAAAAAAP
2012-12-25 21:46:00.782373 I  Player(1): Video Aspect ratio changed from 1.33333 to 1.77778
2012-12-25 21:46:00.782430 I  Display Rect  left: 0, top: 0, width: 1280, height: 720, aspect: 1.77778
2012-12-25 21:46:00.782463 I  Video Rect    left: 38, top: 22, width: 1843, height: 1037, aspect: 1.77778
2012-12-25 21:46:00.783981 I  OSD: Base theme size: 1280x720
2012-12-25 21:46:00.784028 I  OSD: Scaling factors: 1.44062x1.44167
2012-12-25 21:46:00.798323 I  OSD: Loaded window osd_message
2012-12-25 21:46:00.814874 I  OSD: Loaded window osd_input
2012-12-25 21:46:00.820221 I  Detect Letterbox: The source is already in widescreen (aspect: 1.77778)
2012-12-25 21:46:00.836684 I  OSD: Loaded window program_info
2012-12-25 21:46:00.849061 I  OSD: Loaded window browse_info
2012-12-25 21:46:00.861908 I  OSD: Loaded window osd_status
2012-12-25 21:46:00.869321 I  OSD: Loaded window osd_program_editor
2012-12-25 21:46:00.887259 I  OSD: Loaded window osd_debug
2012-12-25 21:46:00.887290 I  OSD: Loaded OSD: size 1844x1038 offset 38+21
2012-12-25 21:46:00.887344 I  EnableCaptions(0) msg:  On
2012-12-25 21:46:00.887362 I  Player(1): Enabled deinterlacing
2012-12-25 21:46:00.887372 I  VideoOutput: OSD size changed.
2012-12-25 21:46:00.979110 I  VideoOutput: Created YV12 OSD.
2012-12-25 21:46:01.045030 I  Player(1): Video is 5.23737 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.048625 I  Player(1): Video is 6.6928 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.052105 I  Player(1): Video is 7.8818 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.056874 I  Player(1): Video is 8.52628 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.060808 I  Player(1): Video is 8.48516 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.065737 I  Player(1): Video is 8.19957 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.068768 I  Player(1): Video is 7.74561 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.071792 I  Player(1): Video is 7.15789 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.074751 I  Player(1): Video is 6.43985 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.078065 I  Player(1): Video is 5.65408 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.081062 I  Player(1): Video is 4.80999 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.084790 I  Player(1): Video is 3.92966 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.088596 I  Player(1): Video is 3.02964 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:01.393676 I  Player(1): Waiting for video buffers...
2012-12-25 21:46:01.497600 N  Player(1): Waited 104ms for video buffers uLUUAuAAAAAAAAAAAAAAAAUAAUUUUUUP
2012-12-25 21:46:01.729650 I  Player(1): Waiting for video buffers...
2012-12-25 21:46:01.994694 I  OSD: Base theme size: 1280x720
2012-12-25 21:46:01.994726 I  OSD: Scaling factors: 1.44062x1.44167
2012-12-25 21:46:02.155287 I  Player(1): Video is 3.59681 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:02.157343 I  AFD: EIA-708 caption service #1 is in the English language.
2012-12-25 21:46:02.157370 I  AFD: EIA-608 caption service #1 is in the English language.
2012-12-25 21:46:02.157474 I  Dec: Selected track #1 in the English language(6647399)
2012-12-25 21:46:02.163355 I  Player(1): Video is 4.36097 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:02.172270 I  Player(1): Video is 4.59692 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:02.180616 I  Player(1): Video is 4.52661 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:02.189104 I  Player(1): Video is 4.22664 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:02.195307 I  Player(1): Video is 3.75439 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:02.201186 I  Player(1): Video is 3.13046 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:04.053217 I  Player(1): FPS:   32.85 Mean: 30439 Std.Dev: 20372 CPUs: 100% 100% 
2012-12-25 21:46:06.746837 I  Player(1): FPS:   28.88 Mean: 34625 Std.Dev:  6282 CPUs: 79% 77% 
2012-12-25 21:46:07.717008 I  Player(1): FPS:   29.92 Mean: 33425 Std.Dev:   363 CPUs: 82% 81% 
2012-12-25 21:46:08.687383 I  Player(1): FPS:   29.91 Mean: 33431 Std.Dev:  1299 CPUs: 87% 68% 
2012-12-25 21:46:09.482337 I  RingBuf(myth://192.168.1.210:6543/2161_20121225214558.mpg): Waited 0.2 seconds for data 
			to become available... 0 < 32768
2012-12-25 21:46:09.594260 I  Player(1): Video is 3.02095 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:10.586855 I  AFD: EIA-708 caption service #1 is in the English language.
2012-12-25 21:46:10.586885 I  AFD: EIA-708 caption service #2 is in the Undetermined language.
2012-12-25 21:46:10.586895 I  AFD: EIA-608 caption service #1 is in the English language.
2012-12-25 21:46:10.640837 I  AFD: EIA-708 caption service #1 is in the English language.
2012-12-25 21:46:10.640859 I  AFD: EIA-708 caption service #2 is in the Undetermined language.
2012-12-25 21:46:10.640869 I  AFD: EIA-608 caption service #1 is in the English language.
2012-12-25 21:46:10.640880 I  AFD: EIA-608 caption service #3 is in the Undetermined language.
2012-12-25 21:46:12.971346 I  Player(1): FPS:   30.14 Mean: 33181 Std.Dev:  2767 CPUs: 75% 81% 
2012-12-25 21:46:13.974307 I  Player(1): 400 interlaced frames seen.
2012-12-25 21:46:16.953331 I  Player(1): FPS:   29.89 Mean: 33452 Std.Dev:   224 CPUs: 85% 68% 
2012-12-25 21:46:20.936037 I  Player(1): FPS:   29.89 Mean: 33458 Std.Dev:  1489 CPUs: 84% 70% 
2012-12-25 21:46:21.082198 I  Player(1): Video is 3.00477 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:24.884540 I  Player(1): FPS:   30.15 Mean: 33171 Std.Dev:  3190 CPUs: 83% 72% 
2012-12-25 21:46:26.249124 I  RingBuf(myth://192.168.1.210:6543/2161_20121225214558.mpg): Waited 0.2 seconds for data 
			to become available... 0 < 32768
2012-12-25 21:46:26.279482 I  AFD: EIA-708 caption service #1 is in the English language.
2012-12-25 21:46:26.279501 I  AFD: EIA-608 caption service #1 is in the English language.
2012-12-25 21:46:26.772269 I  AFD: EIA-708 caption service #1 is in the English language.
2012-12-25 21:46:26.772302 I  AFD: EIA-708 caption service #2 is in the Undetermined language.
2012-12-25 21:46:26.772314 I  AFD: EIA-608 caption service #1 is in the English language.
2012-12-25 21:46:27.326481 I  Player(1): 800 interlaced frames seen.
2012-12-25 21:46:28.866400 I  Player(1): FPS:   29.89 Mean: 33452 Std.Dev:   340 CPUs: 76% 76% 
2012-12-25 21:46:32.849099 I  Player(1): FPS:   29.89 Mean: 33459 Std.Dev:  1029 CPUs: 78% 73% 
2012-12-25 21:46:33.152710 I  Player(1): Video is 3.00683 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:36.797383 I  Player(1): FPS:   30.15 Mean: 33170 Std.Dev:  2987 CPUs: 67% 82% 
2012-12-25 21:46:40.678794 I  Player(1): 1200 interlaced frames seen.
2012-12-25 21:46:40.779629 I  Player(1): FPS:   29.89 Mean: 33455 Std.Dev:   270 CPUs: 76% 78% 
2012-12-25 21:46:44.762267 I  Player(1): FPS:   29.89 Mean: 33458 Std.Dev:   463 CPUs: 74% 75% 
2012-12-25 21:46:45.333334 I  Player(1): Video is 3.01436 frames behind audio (too slow), dropping frame to catch up.
2012-12-25 21:46:45.958111 I  RingBuf(myth://192.168.1.210:6543/2161_20121225214558.mpg): Waited 0.2 seconds for data 
			to become available... 0 < 32768
2012-12-25 21:46:47.806698 I  TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2012-12-25 21:46:47.806729 I  TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2012-12-25 21:46:47.841611 I  TV: HandleStateChange(0) -- begin
2012-12-25 21:46:47.841638 I  TV: Attempting to change from WatchingLiveTV to None
2012-12-25 21:46:47.841661 I  TV: StopStuff() for player ctx 0 -- begin
2012-12-25 21:46:47.841678 I  TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2012-12-25 21:46:47.841699 I  TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2012-12-25 21:46:47.841712 I  Player(1): StopPlaying - begin
2012-12-25 21:46:47.844210 I  Player(1): Decoder thread exiting.
2012-12-25 21:46:47.844573 I  Player(1): Exited decoder loop.
2012-12-25 21:46:47.845219 I  VideoOutputXv: dtor
2012-12-25 21:46:47.845238 I  VideoOutputXv: DiscardFrames(1)
2012-12-25 21:46:47.845285 I  VideoBuffers::DiscardFrames(1): UUAUUUUUUUuUULUUAUUAUUAAAUAAUAAP
2012-12-25 21:46:47.845344 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done
2012-12-25 21:46:47.845387 I  VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAP -- done()
2012-12-25 21:46:47.857253 I  VideoOutputXv: Closing XVideo port 281
2012-12-25 21:46:47.890681 W  MythPainter: 9 images not yet de-allocated.
2012-12-25 21:46:47.937224 I  Player(1): StopPlaying - end
2012-12-25 21:46:47.937244 I  TV: StopStuff(): stopping ring buffer
2012-12-25 21:46:48.090459 I  TV: StopStuff(): stopping player
2012-12-25 21:46:48.090485 I  TV: StopStuff(): stopping recorder
2012-12-25 21:46:48.168863 I  TV: StopStuff() -- end
2012-12-25 21:46:48.168911 I  TV: Changing from WatchingLiveTV to None
2012-12-25 21:46:48.169474 I  TV: HandleStateChange(0) -- end
2012-12-25 21:46:48.169508 I  TV: Exiting main playback loop.
2012-12-25 21:46:48.169526 I  TV: StartTV -- process events 2 begin
2012-12-25 21:46:48.170275 I  TV: StartTV -- process events 2 end
2012-12-25 21:46:48.170320 I  TV::~TV() -- begin
2012-12-25 21:46:48.180887 I  TV::~TV() -- lock
2012-12-25 21:46:48.182320 I  Player(1): StopPlaying - begin
2012-12-25 21:46:48.182364 I  Player(1): Exited decoder loop.
2012-12-25 21:46:48.182382 I  Player(1): StopPlaying - end
2012-12-25 21:46:48.192126 I  TV::~TV() -- end
2012-12-25 21:46:48.215755 N  Resuming idle timer
2012-12-25 21:46:48.215790 I  TV: StartTV -- end
2012-12-25 21:46:50.269066 N  Resuming idle timer
2012-12-25 21:46:50.273451 N  Resuming idle timer
2012-12-25 21:46:50.279376 I  Bonjour: De-registering service '_mythfrontend._tcp.' on 'Mythfrontend on LinHES'
2012-12-25 21:46:50.280218 I  RAOP Device: Cleaning up.
2012-12-25 21:46:50.280256 I  AirPay: Cleaning up.
2012-12-25 21:46:50.280275 I  Deleting UPnP client...
2012-12-25 21:46:51.939256 I  OpenGL1: Deleting OpenGL Resources
2012-12-25 21:46:51.939362 I  OpenGL: Deleting OpenGL Resources
2012-12-25 21:46:51.971409 I  Waiting for threads to exit.
greedyhdeint: size changed from 0 x 0 -> 720 x 576
greedyhdeint: size changed from 0 x 0 -> 720 x 576
