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