MythTV / mythtv

The official MythTV repository
https://www.mythtv.org
GNU General Public License v2.0
706 stars 347 forks source link

MacOS: OSD is scaled incorrectly when using high DPI/retina screens #206

Closed mark-kendall closed 4 years ago

mark-kendall commented 4 years ago

Refs:

https://code.mythtv.org/trac/ticket/13618 https://code.mythtv.org/trac/ticket/13646

The fix in 19e8d9d0cf81bca056471d9a1522a96832f7e40c is not working correctly.

mark-kendall commented 4 years ago

Test patch (for v31)

https://gist.github.com/mark-kendall/ab2324dbcffac8427465d44b452ae47b

jhoyt4 commented 4 years ago

Mark, here's my testing results:

Test Status
Menus + good
Menus - Settings + good
Recording Playback 1080p + good
Recording Playback OSD 1080p + good
Video Playback 480i + good
Video Playback OSD 480i + good
Video Playback 720p + good
Video Playback OSD 720p + good
Video Playback 1080p + good
Video Playback OSD 1080p + good
Video - Display Program Guide - broken - shows up in upper left hand quarter of screen
Program Guide (from menu) + good
Live TV - broken - plays zoomed in on 1080p video to bottom left hand quarter of video
Live TV - Display Program Guide - broken - not visible / black screen
MythMusic Album Art Visualizer + good
MythMusic Other Visualizers - broken (did not work in previous build)
mark-kendall commented 4 years ago

John - so to be clear:-

With current fixes/31 code:

Working: UI, video playback Not working: OSD scaling, guide grid while playing video

With patch applied:

Working: UI, video playback, OSD Not working: live tv and guide grid while playing video

So I'm assuming the patch fixes the OSD scaling. As mentioned I wasn't expecting the guide grid to work properly (before or after)

But I'm not sure if the livetv problem is present without the patch applied?

Could you attach full logs from 'mythfrontend -v playback' when playing livetv with and without the patch applied?

wrt visualisers - I was more interested in the visualisers in the video playback code (Bring up the OSD menu - audio->visualisers-> select one.. ). They should be working ok.

jhoyt4 commented 4 years ago

Mark,

I just tested and confirmed the visualizers to work in video playback.

As far as I can tell, the patch does correct the OSD scaling in playback.

Checking Live TV on the unpatched version - same behavior. The screen is zoomed into bottom left quarter of the video.

An interesting note - now that I can see the OSD - the icon in the bottom right corner indicates that the channel is SD. This is strange because the video fed into my recorder (collossus2) is forced to 1080p at the STB.. I've attached a screenshot from last night when testing showing the SD icon. Ignore the black screen - the colossus2 takes FOREVER to get a signal lock

Also in both, when I try to bring up the guide during live playback, I just get a black screen.

[image: Screen Shot 2020-09-14 at 7.09.57 PM.png]

On Tue, Sep 15, 2020 at 5:42 AM Mark Kendall notifications@github.com wrote:

John - so to be clear:-

With current fixes/31 code:

Working: UI, video playback Not working: OSD scaling, guide grid while playing video

With patch applied:

Working: UI, video playback, OSD Not working: live tv and guide grid while playing video

So I'm assuming the patch fixes the OSD scaling. As mentioned I wasn't expecting the guide grid to work properly (before or after)

But I'm not sure if the livetv problem is present without the patch applied?

Could you attach full logs from 'mythfrontend -v playback' when playing livetv with and without the patch applied?

wrt visualisers - I was more interested in the visualisers in the video playback code (Bring up the OSD menu - audio->visualisers-> select one.. ). They should be working ok.

— You are receiving this because you are subscribed to this thread. Reply to this email directly, view it on GitHub https://github.com/MythTV/mythtv/issues/206#issuecomment-692600471, or unsubscribe https://github.com/notifications/unsubscribe-auth/AGBZ2EX5UIGPUX3JYCJ3IBDSF4ZHJANCNFSM4REVRA4Q .

% ./mythfrontend_patched.app/Contents/MacOS/mythfrontend -v playback 2020-09-15 06:26:37.365674 I Setup Interrupt: 2 handler 2020-09-15 06:26:37.365700 I Setup Terminated: 15 handler 2020-09-15 06:26:37.365708 I Setup Segmentation fault: 11 handler 2020-09-15 06:26:37.365715 I Setup Abort trap: 6 handler 2020-09-15 06:26:37.365722 I Setup Bus error: 10 handler 2020-09-15 06:26:37.365729 I Setup Floating point exception: 8 handler 2020-09-15 06:26:37.365737 I Setup Illegal instruction: 4 handler 2020-09-15 06:26:37.365746 I Setup User defined signal 1: 30 handler 2020-09-15 06:26:37.365753 I Setup User defined signal 2: 31 handler 2020-09-15 06:26:37.365760 I Setup Hangup: 1 handler 2020-09-15 06:26:37.365866 C mythfrontend version: fixes/31 [v31.0-92-g2cff5c78b2-dirty] www.mythtv.org 2020-09-15 06:26:37.365876 C Qt version: compile: 5.14.2, runtime: 5.14.2 2020-09-15 06:26:37.365901 I macOS 10.15 (x86_64) 2020-09-15 06:26:37.365909 N Enabled verbose msgs: general playback 2020-09-15 06:26:37.365929 N Setting Log Level to LOG_INFO 2020-09-15 06:26:37.376295 I Added logging to the console 2020-09-15 06:26:37.376392 N Using runtime prefix = /Users/XXX/Downloads/mythfrontend_patched.app/Contents/Resources 2020-09-15 06:26:37.376401 N Using configuration directory = /Users/XXX/.mythtv 2020-09-15 06:26:37.376458 I Assumed character encoding: en_US.UTF-8 2020-09-15 06:26:37.377877 I Loading en_us translation for module mythfrontend 2020-09-15 06:26:37.378206 I Empty LocalHostName. This is typical. 2020-09-15 06:26:37.378217 I Using a profile name of: 'XXX' (Usually the same as this host's name.) 2020-09-15 06:26:37.378282 I UPNP Search up to 2 secs 2020-09-15 06:26:37.791795 I UPNP Search up to 1 secs 2020-09-15 06:26:38.104014 I UPNP Search up to 1 secs 2020-09-15 06:26:39.548623 A Cannot find default UPnP backend 2020-09-15 06:26:39.548698 I Start up testing connections. DB 192.168.0.9, BE , attempt 0, status dbAwake, Delay: 2000 2020-09-15 06:26:41.286208 N Setting QT default locale to en_US 2020-09-15 06:26:41.286224 I Current locale en_US 2020-09-15 06:26:41.287287 N Reading locale defaults from /Users/XXX/Downloads/mythfrontend_patched.app/Contents/Resources/share/mythtv//locales/en_us.xml 2020-09-15 06:26:41.506423 I Display: Found screen 'Color LCD' 2020-09-15 06:26:41.506454 I Display: Using screen 'Color LCD' (Make: Unknown Model: Unknown) 2020-09-15 06:26:41.506470 I Display: Qt screen pixel ratio: 2.00 2020-09-15 06:26:41.506491 I Display: Geometry: 1792x1120+0+0 Size(Qt): 344.824mmx214.702mm 2020-09-15 06:26:41.515122 N Display: Desktop video mode: 1792x1120 60.000Hz dbus[25320]: Dynamic session lookup supported but failed: launchd did not provide a socket path, verify that org.freedesktop.dbus-session.plist is loaded! 2020-09-15 06:26:42.059674 I Power: Battery at 94% 2020-09-15 06:26:42.059795 I Power: Supported actions: Suspend,Restart,Shutdown 2020-09-15 06:26:42.428941 I Listening on TCP 0.0.0.0:6547 2020-09-15 06:26:42.446973 I Listening on TCP [::]:6547 2020-09-15 06:26:48.799557 I Loading en_us translation for module mythfrontend 2020-09-15 06:26:49.082332 E LIRC: Failed to connect to Unix socket '/var/run/lirc/lircd' eno: No such file or directory (2) 2020-09-15 06:26:49.083063 E AppleRemote::_findAppleRemoteDevice(AppleIRController) failed 2020-09-15 06:26:49.083081 E AppleRemote::_findAppleRemoteDevice(AppleTVIRReceiver) failed 2020-09-15 06:26:49.083088 E AppleRemote::startListening() failed 2020-09-15 06:26:49.083115 I UDPListener: Enabling 2020-09-15 06:26:49.100562 I Binding to UDP 0.0.0.0:6948 2020-09-15 06:26:49.100613 I Binding to UDP [::]:6948 2020-09-15 06:26:51.030164 I Using Frameless Window 2020-09-15 06:26:51.030176 I Using Full Screen Window 2020-09-15 06:26:51.052954 I Display: Have main widget 2020-09-15 06:26:51.052965 I Display: Have main window 2020-09-15 06:26:51.081652 I Display: Found screen 'Color LCD' 2020-09-15 06:26:51.121952 I UI Screen Resolution: 1792 x 1120 2020-09-15 06:26:51.246843 I OpenGL: OpenGL vendor : Intel Inc. 2020-09-15 06:26:51.246854 I OpenGL: OpenGL renderer : Intel(R) UHD Graphics 630 2020-09-15 06:26:51.246864 I OpenGL: OpenGL version : 2.1 INTEL-14.7.8 2020-09-15 06:26:51.246872 I OpenGL: Qt platform : cocoa 2020-09-15 06:26:51.246878 I OpenGL: Qt OpenGL format : OpenGL 2.1 2020-09-15 06:26:51.246884 I OpenGL: Qt OpenGL surface : RGBA: 8880 Depth: 0 Stencil: 0 2020-09-15 06:26:51.246890 I OpenGL: Max texture size : 16384 2020-09-15 06:26:51.246898 I OpenGL: Max texture units : 16 2020-09-15 06:26:51.246906 I OpenGL: Shaders : Yes 2020-09-15 06:26:51.246912 I OpenGL: NPOT textures : Yes 2020-09-15 06:26:51.246918 I OpenGL: Multitexturing : Yes 2020-09-15 06:26:51.246925 I OpenGL: Rectangular textures : Yes 2020-09-15 06:26:51.246931 I OpenGL: Buffer mapping : Yes 2020-09-15 06:26:51.246939 I OpenGL: Framebuffer objects : Yes 2020-09-15 06:26:51.246946 I OpenGL: 16bit framebuffers : Yes 2020-09-15 06:26:51.246952 I OpenGL: Unpack Subimage : Yes 2020-09-15 06:26:51.246959 I OpenGL: GL_RED/GL_R8 : Yes 2020-09-15 06:26:51.256118 I OpenGL: Initialised MythRenderOpenGL 2020-09-15 06:26:51.256129 I OpenGL: Using full range output 2020-09-15 06:26:51.256186 I High DPI scaling enabled 2020-09-15 06:26:51.294681 I MythUIHelper: Pruning cache directory: /Users/XXX/.mythtv/cache/remotecache 2020-09-15 06:26:51.294972 I MythUIHelper: Kept 3 files, deleted 0 files, stat error on 0 files 2020-09-15 06:26:51.294986 I MythUIHelper: Pruning cache directory: /Users/XXX/.mythtv/cache/thumbnails 2020-09-15 06:26:51.308143 I MythUIHelper: Kept 289 files, deleted 0 files, stat error on 0 files 2020-09-15 06:26:52.207977 I MythCoreContext::ConnectCommandSocket(): Connecting to backend server: 192.168.0.9:6543 (try 1 of 1) 2020-09-15 06:26:52.222205 I MythCoreContext::CheckProtoVersion(): Using protocol version 91 BuzzOff dlopen(libcec.4.dylib, 1): no suitable image found. Did find: /Users/XXX/Downloads/mythfrontend_patched.app/Contents/MacOS/../Frameworks/libcec.4.0.5.dylib/libcec.4.dylib: stat() failed with errno=20 2020-09-15 06:26:52.285381 E CECAdapter: Failed to load libcec. 2020-09-15 06:26:52.307566 E RAOP Conn: Failed to Read Key From: /Users/XXX/.mythtv/RAOPKey.rsa 2020-09-15 06:26:52.307579 E RAOP Device: Aborting startup - no key found. 2020-09-15 06:26:52.331949 I AirPlay: Created airplay objects. 2020-09-15 06:26:52.332104 I Listening on TCP 0.0.0.0:5100 2020-09-15 06:26:52.332158 I Listening on TCP [::]:5100 2020-09-15 06:26:52.538087 I Current MythTV Schema Version (DBSchemaVer): 1361 2020-09-15 06:26:52.575102 I VTBDec: Supported/available VideoToolbox decoders: 2020-09-15 06:26:52.575117 I VTBDec: H264 2020-09-15 06:26:52.575123 I VTBDec: HEVC 2020-09-15 06:26:52.575178 I VDP: decoder<->render support: ffmpeg null opengl opengl-yv12 2020-09-15 06:26:52.575187 I VDP: decoder<->render support: vtb opengl-hw 2020-09-15 06:26:52.575194 I VDP: decoder<->render support: vtb-dec null opengl opengl-yv12 2020-09-15 06:26:53.096511 I Bonjour: Service registration complete: name 'MythTV on ' type '_airplay._tcp.' domain: 'local.' 2020-09-15 06:26:55.342852 I Display: Available modes: 2020-09-15 06:26:55.342869 I 3584x2240 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342881 I 3072x1920 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342892 I 2688x1680 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342902 I 2304x1440 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342913 I 1650x1050 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342923 I 1536x960 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342934 I 1440x900 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342966 I 1280x800 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342977 I 1152x720 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342988 I 1024x768 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.342999 I 840x524 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.343010 I 800x600 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:55.343020 I 640x480 60.00 59.94 50.00 48.00 47.95 2020-09-15 06:26:59.433122 N Registering Internal as a media playback plugin. 2020-09-15 06:26:59.459465 N MediaMonitor disabled by user setting. 2020-09-15 06:26:59.551050 N Registering WebBrowser as a media playback plugin. 2020-09-15 06:26:59.551162 I Loading en_us translation for module mythbrowser 2020-09-15 06:26:59.630164 I Loading en_us translation for module mythgame 2020-09-15 06:26:59.681054 I Current MythMusic Schema Version (MusicDBSchemaVer): 1024 2020-09-15 06:27:00.150519 I Loading en_us translation for module mythmusic 2020-09-15 06:27:00.217527 I Loading en_us translation for module mythnews 2020-09-15 06:27:00.322032 I Loading en_us translation for module mythweather 2020-09-15 06:27:00.446 mythfrontend.real[25320:610496] not in fullscreen state 2020-09-15 06:27:00.402328 I Using Frameless Window 2020-09-15 06:27:00.402338 I Using Full Screen Window 2020-09-15 06:27:00.410064 I Display: Have main widget 2020-09-15 06:27:00.410074 I Display: Have main window 2020-09-15 06:27:00.420094 I Display: Found screen 'Color LCD' 2020-09-15 06:27:00.420120 I Display: Waiting for new screen 2020-09-15 06:27:00.428431 I Bonjour: Service registration complete: name 'Mythfrontend on XXX' type '_mythfrontend._tcp.' domain: 'local.' 2020-09-15 06:27:00.945154 W Display: Timed out waiting for new screen 2020-09-15 06:27:00.965926 I UI Screen Resolution: 1792 x 1120 2020-09-15 06:27:01.029826 I OpenGL: Initialised MythRenderOpenGL 2020-09-15 06:27:01.029838 I OpenGL: Using full range output 2020-09-15 06:27:01.029874 I High DPI scaling enabled 2020-09-15 06:27:01.070337 I MythUIHelper: Pruning cache directory: /Users/XXX/.mythtv/cache/remotecache 2020-09-15 06:27:01.070798 I MythUIHelper: Kept 3 files, deleted 0 files, stat error on 0 files 2020-09-15 06:27:01.070824 I MythUIHelper: Pruning cache directory: /Users/XXX/.mythtv/cache/thumbnails 2020-09-15 06:27:01.087791 I MythUIHelper: Kept 289 files, deleted 0 files, stat error on 0 files dlopen(libcec.4.dylib, 1): no suitable image found. Did find: /Users/XXX/Downloads/mythfrontend_patched.app/Contents/MacOS/../Frameworks/libcec.4.0.5.dylib/libcec.4.dylib: stat() failed with errno=20 2020-09-15 06:27:01.305888 E CECAdapter: Failed to load libcec. 2020-09-15 06:27:01.305944 W MythPainter: 1 images not yet de-allocated. 2020-09-15 06:27:01.305963 I Clearing OpenGL painter cache. 2020-09-15 06:27:01.307669 I OpenGL: MythRenderOpenGL closing 2020-09-15 06:27:01.429343 N Found mainmenu.xml for theme 'MythCenter' 2020-09-15 06:27:01.503545 I Checking for theme updates every hour 2020-09-15 06:27:01.517262 I Starting HouseKeeper. 2020-09-15 06:27:01.517486 I Starting process manager 2020-09-15 06:27:01.517512 I Starting process signal handler 2020-09-15 06:27:01.517741 I Starting IO manager (read) 2020-09-15 06:27:01.517912 I Starting IO manager (write) 2020-09-15 06:27:02.020002 I Power: Battery at 93% 2020-09-15 06:27:03.972787 I TV::TV(): Creating TV object 2020-09-15 06:27:04.093964 I TV::TV(): Finished creating TV object 2020-09-15 06:27:04.093987 N Suspending idle timer 2020-09-15 06:27:04.117913 I TV::Init(): Created TvPlayWindow. 2020-09-15 06:27:04.221957 I TV::HandleStateChange(): Attempting to change from None to WatchingLiveTV 2020-09-15 06:27:04.263872 I MythCoreContext::ConnectCommandSocket(): Connecting to backend server: 192.168.0.9:6543 (try 1 of 1) 2020-09-15 06:27:04.475130 I LiveTVChain(live-XXX-2020-09-15T10:27:04Z): ReloadAll(): Added 1 recording(s) 2020-09-15 06:27:04.475204 I LiveTVChain(live-XXX-2020-09-15T10:27:04Z): LiveTVChain has 1 entries

2020-09-15 06:27:04.621436 I TV::HandleStateChange(): playbackURL(myth://mythtv/20510_20200915102704.ts) inputtype(DUMMY) 2020-09-15 06:27:04.632977 I TV::StartRecorder(): Took 3 ms to start recorder. 2020-09-15 06:27:04.633022 I TV::StartPlayer(): Elapsed time since TV constructor was called: 660 ms 2020-09-15 06:27:05.105660 W CoreAudioData Warning:CoreAudioData: "" not found, using default device 75. 2020-09-15 06:27:05.124424 N AudioPlayer: Enabling Audio 2020-09-15 06:27:05.124458 I Player(0): Opening 'myth://mythtv/20510_20200915102704.ts' 2020-09-15 06:27:05.124536 I Player(0): SetFrameInterval Interval:40000 Speed:1 Scan:Progressive Scan (Multiplier: 1) 2020-09-15 06:27:05.124569 I Player(0): detectInterlace(Ignore Scan, Interlaced Scan, 25, 576) ->Interlaced Scan 2020-09-15 06:27:05.233674 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl-yv12) deint(high:shader,high:shader) 2020-09-15 06:27:05.233763 I Player(0): Stretch Factor 1, allow passthru 2020-09-15 06:27:05.233802 I VideoOutput: Allowed renderers for ffmpeg (Decoder: dummy): 'opengl,opengl-yv12' 2020-09-15 06:27:05.233817 I VDP: Safe renderers for 'dummy': null,opengl,opengl-yv12,opengl-hw 2020-09-15 06:27:05.233837 I VideoOutput: Allowed renderers (filt: dummy): opengl,opengl-yv12 2020-09-15 06:27:05.258996 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl-yv12) deint(high:shader,high:shader) 2020-09-15 06:27:05.259034 I VDP: LoadBestPreferences(720x576, 25.000, ) 2020-09-15 06:27:05.259061 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:27:05.259081 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:27:05.259101 I VideoOutput: Preferred renderer: opengl-yv12 2020-09-15 06:27:05.259114 I VideoOutput: Trying video renderer: 'opengl-yv12' QObject::connect: signal not found in MythDisplay libpng warning: iCCP: known incorrect sRGB profile libpng warning: iCCP: known incorrect sRGB profile libpng warning: iCCP: known incorrect sRGB profile 2020-09-15 06:27:05.424999 I GLVid: Chroma upsampling filter disabled 2020-09-15 06:27:05.425147 I Clearing OpenGL painter cache. 2020-09-15 06:27:05.438111 I VideoWin: Window using screen Color LCD 1792x1120 2020-09-15 06:27:05.438145 I VideoWin: Window Rect: 3584x2240+0+0 2020-09-15 06:27:05.438166 I VideoWin: Display Rect: 2787x2240+398+0 Aspect: 1.60748 2020-09-15 06:27:05.438184 I VideoWin: Video Rect: 720x576+0+0 Aspect: 1.25 2020-09-15 06:27:05.438227 I ColourSpace: PictureAttributes: Brightness,Contrast,Colour,Hue,Range 2020-09-15 06:27:05.438261 I VideoOutput: Display aspect ratio: 1.60748 (Detected) 2020-09-15 06:27:05.444585 I Created 16 YUV420P (720x576) video buffers 2020-09-15 06:27:05.488094 I OSD: Base theme size: 800x600 2020-09-15 06:27:05.488108 I Player(0): Decoder thread starting. 2020-09-15 06:27:05.488110 I OSD: Scaling factors: 4.48x3.73333 2020-09-15 06:27:05.490212 I OSD: Loaded window osd_message 2020-09-15 06:27:05.491990 I OSD: Loaded window osd_input 2020-09-15 06:27:05.496299 I OSD: Loaded window program_info 2020-09-15 06:27:05.498916 I OSD: Loaded window browse_info 2020-09-15 06:27:05.501333 I OSD: Loaded window osd_status 2020-09-15 06:27:05.504304 I OSD: Loaded window osd_program_editor 2020-09-15 06:27:05.516093 I OSD: Loaded window osd_debug 2020-09-15 06:27:05.516106 I OSD: Loaded OSD: size 3584x2240 offset 0+0 2020-09-15 06:27:05.516177 I OSD: Base theme size: 800x600 2020-09-15 06:27:05.516185 I OSD: Scaling factors: 4.48x3.73333 2020-09-15 06:27:05.516276 I OSD: Created window aa_OSD_SUBTITLES 2020-09-15 06:27:05.516305 I Player(0): ClearAfterSeek(0) 2020-09-15 06:27:05.516363 I VideoOutput: SetDeinterlacing (Doublerate 1): Single High|CPU|GLSL Double High|CPU|GLSL 2020-09-15 06:27:05.516391 I Player(0): Display Refresh Rate: 59.999 Video Frame Rate: 25.000 2020-09-15 06:27:05.516400 I Player(0): SetFrameInterval Interval:40000 Speed:1 Scan:Interlaced Scan (Multiplier: 1) 2020-09-15 06:27:05.517220 I playCtx: StartPlaying(): took 0 ms to start player. 2020-09-15 06:27:05.517269 I TV::StartPlayer(): Created player. 2020-09-15 06:27:05.517317 I TV::HandleStateChange(): Changing from None to WatchingLiveTV 2020-09-15 06:27:05.517340 I TV::HandleStateChange(): State is LiveTV & mctx == ctx 2020-09-15 06:27:05.527998 I TV::HandleStateChange(): UpdateOSDInput done 2020-09-15 06:27:05.528013 I TV::HandleStateChange(): UpdateLCD done 2020-09-15 06:27:05.536631 I TV::HandleStateChange(): ITVRestart done 2020-09-15 06:27:05.542672 I TV::HandleStateChange(): Main UI disabled. 2020-09-15 06:27:05.542703 I TV::StartTV(): Entering main playback loop. 2020-09-15 06:27:29.250677 I LiveTVChain(live-XXX-2020-09-15T10:27:04Z): ReloadAll(): Added 1 recording(s) 2020-09-15 06:27:29.250725 I LiveTVChain(live-XXX-2020-09-15T10:27:04Z): LiveTVChain has 2 entries

2020-09-15 06:27:29.250858 I LiveTVChain(live-XXX-2020-09-15T10:27:04Z): SwitchTo(1) 2020-09-15 06:27:29.250878 I Player(0): JumpToProgram - start 2020-09-15 06:27:29.328422 I Player(0): Play speed: rate: 25 speed: 0 skip: 0 => new interval 40000 2020-09-15 06:27:29.328467 I VidOutGL: (1): AAAAAAAAAAAAAAAA 2020-09-15 06:27:29.328492 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA 2020-09-15 06:27:29.328524 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA -- done 2020-09-15 06:27:29.378899 I FileRingBuf(myth://mythtv/20510_20200915102704.ts): OpenFile(myth://mythtv/20510_20200915102729.ts, 10000 ms) 2020-09-15 06:27:30.248258 I Player(0): Opening 'myth://mythtv/20510_20200915102729.ts' 2020-09-15 06:27:31.909498 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl-yv12) deint(high:shader,high:shader) 2020-09-15 06:27:31.919995 I AFD: PlayerFlags: 0xc0, AudioReadAhead: 100 msec 2020-09-15 06:27:31.920248 I Player(0): Stretch Factor 1, allow passthru 2020-09-15 06:27:31.973486 I AFD: Buffer size: 32768 Streamed 1 Seekable 1 Available 458752 2020-09-15 06:27:32.059687 I AFD: Stream #0: ID: 0x1011 Codec ID: H264 Type: Video(1920x1080) Bitrate: 0 2020-09-15 06:27:32.059707 I AFD: Stream #1: ID: 0x1100 Codec ID: AC3 Type: Audio Bitrate: 0 2020-09-15 06:27:32.059717 I AFD: codec AC3 has 0 channels 2020-09-15 06:27:32.059726 I AFD: Looking for decoder for AC3 2020-09-15 06:27:32.059840 I AFD: Opened codec 0x7f9d2e90dc00, id(AC3) type(Audio) 2020-09-15 06:27:32.059925 I AFD: Trying to select best video track 2020-09-15 06:27:32.059954 I AFD: Selected track #0: ID: 0x1011 Codec ID: H264 Profile: High Type: Video(1920x1080) Bitrate: 0 2020-09-15 06:27:32.059985 I AFD: Selected FPS: 29.97 (Avg:29.97 Mult:1 Codec:0 Container:90000 Estimated:29.97) 2020-09-15 06:27:32.060003 I VDP: LoadBestPreferences(1920x1080, 29.970, h264) 2020-09-15 06:27:32.060025 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:27:32.060038 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:27:32.060052 I AFD: Using 2 CPUs for decoding 2020-09-15 06:27:32.060063 I AFD: InitVideoCodec ID:H264 Type:Video Size:1920x1080 2020-09-15 06:27:32.060098 I Player(0): SetFrameInterval Interval:33367 Speed:0 Scan:Progressive Scan (Multiplier: 1) 2020-09-15 06:27:32.060111 I VidOutGL: Video frame rate changed: 25->29.97 2020-09-15 06:27:32.060121 I VDP: LoadBestPreferences(720x576, 29.970, ) 2020-09-15 06:27:32.060136 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:27:32.060148 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:27:32.060174 I VidOutGL: Video changed: 720x576 (720x576) 'None' (Aspect 1.25 Refs 2)-> 1920x1080 (1920x1080) 'H.264' (Aspect 1.77778 Refs 3) 2020-09-15 06:27:32.060202 I DiscardAndRecreate: AAAAAAAAAAAAAAAA 2020-09-15 06:27:32.086579 I Created 17 YUV420P (1920x1080) video buffers 2020-09-15 06:27:32.086612 I DiscardAndRecreate: AAAAAAAAAAAAAAAA 2020-09-15 06:27:32.086634 I Player(0): ClearAfterSeek(1) 2020-09-15 06:27:32.086664 I Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan 2020-09-15 06:27:32.086682 I VideoOutput: SetDeinterlacing (Doublerate 0): Single High|CPU|GLSL Double None 2020-09-15 06:27:32.086715 I AFD: Using ffmpeg for video decoding 2020-09-15 06:27:32.087163 I AFD: Opened codec 0x7f9d2e9c4000, id(H264) type(Video) 2020-09-15 06:27:32.249515 N AudioPlayer: Enabling Audio 2020-09-15 06:27:32.249543 I Dec: Selected track #1 (type 2) in the Unknown language(0) 2020-09-15 06:27:32.249553 I Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0) 2020-09-15 06:27:32.270512 I Dec: Position map filled from DB to: 34 2020-09-15 06:27:32.270536 I Dec: Duration map filled from DB to: 34 2020-09-15 06:27:32.270552 I Dec: SyncPositionMap watchingrecording, from DB: 6 entries 2020-09-15 06:27:32.270577 I Player(0): Filling position map from 35 to end 2020-09-15 06:27:32.278810 I Dec: Position map filled from Encoder to: 34 2020-09-15 06:27:32.278828 I Dec: Duration map filled from Encoder to: 34 2020-09-15 06:27:32.278846 I Dec: SyncPositionMap watchingrecording total: 6 entries 2020-09-15 06:27:32.278857 I Dec: SyncPositionMap, new totframes: 34, new length: 1, posMap size: 6 2020-09-15 06:27:32.288677 I AFD: Partial position map found 2020-09-15 06:27:32.288697 I AFD: Successfully opened decoder for file: "myth://mythtv/20510_20200915102729.ts". novideo(0) 2020-09-15 06:27:32.565367 I Player(0): Play( 1.0, normal 1, unpause audio 1) 2020-09-15 06:27:32.566174 I Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1) 2020-09-15 06:27:32.566249 I Player(0): Play speed: rate: 29.97 speed: 1 skip: 1 => new interval 33366 2020-09-15 06:27:32.566284 I Player(0): Stretch Factor 1, allow passthru 2020-09-15 06:27:32.566344 I Player(0): JumpToProgram - end 2020-09-15 06:27:32.566372 I Player(0): Waiting for video buffers... 2020-09-15 06:27:32.614522 I Dec: Position map filled from DB to: 34 2020-09-15 06:27:32.614541 I Dec: Duration map filled from DB to: 34 2020-09-15 06:27:32.614553 I Dec: SyncPositionMap watchingrecording, from DB: 6 entries 2020-09-15 06:27:32.614568 I Player(0): Filling position map from 35 to end 2020-09-15 06:27:32.622845 I Dec: Position map filled from Encoder to: 46 2020-09-15 06:27:32.622866 I Dec: Duration map filled from Encoder to: 46 2020-09-15 06:27:32.622881 I Dec: SyncPositionMap watchingrecording total: 8 entries 2020-09-15 06:27:32.622895 I Dec: SyncPositionMap, new totframes: 46, new length: 1, posMap size: 8 2020-09-15 06:27:32.669124 N Player(0): Waited 103ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:32.771162 N Player(0): Waited 204ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:32.872313 N Player(0): Waited 306ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:32.974270 N Player(0): Waited 408ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:33.078930 N Player(0): Waited 512ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:33.182449 N Player(0): Waited 616ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:33.283825 N Player(0): Waited 717ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:33.352712 I AOBase: Opening audio device '' ch 2(6) sr 48000 sf 32 bit floating point reenc 0 2020-09-15 06:27:33.383741 W CoreAudioData Warning:Audio device is not configured. You should configure your speaker layout with the "Audio Midi Setup" utility in /Applications/Utilities. 2020-09-15 06:27:33.417345 N Player(0): Waited 851ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:27:33.518584 N Player(0): Waited 952ms for video buffers (au)LULLAAAAAAAAAAA 2020-09-15 06:27:33.620979 N Player(0): To see more buffering messages use -v playback 2020-09-15 06:27:33.621021 N Player(0): Waited 1054ms for video buffers (au)LUuLAAAAAAAAAAA 2020-09-15 06:27:33.723564 N Player(0): Waited 1157ms for video buffers (au)uUUUuLLAAAAAAAA 2020-09-15 06:27:33.824487 N Player(0): Waited 1258ms for video buffers (AU)uUUUuuLLAAAAAAA 2020-09-15 06:27:33.848824 I Player(0): Unlocking frame scan 2020-09-15 06:27:33.848839 I Player(0): Progressive frame seen after 2 interlaced frames 2020-09-15 06:27:33.848909 I VideoWin: New video parameters: Size 1920x1080 DisplaySize: 1920x1080 Aspect: 1.77778 2020-09-15 06:27:33.848925 I VideoWin: Window Rect: 3584x2240+0+0 2020-09-15 06:27:33.848938 I VideoWin: Display Rect: 3584x2025+0+107 Aspect: 1.60748 2020-09-15 06:27:33.848951 I VideoWin: Video Rect: 1920x1080+0+0 Aspect: 1.77778 2020-09-15 06:27:33.848976 I VDP: LoadBestPreferences(1920x1080, 29.970, h264) 2020-09-15 06:27:33.849001 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:27:33.849016 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:27:33.849051 I VideoWin: Window using screen Color LCD 1792x1120 2020-09-15 06:27:33.849063 I VideoWin: Window Rect: 7168x4480+0+0 2020-09-15 06:27:33.849075 I VideoWin: Display Rect: 7168x4051+0+214 Aspect: 1.60748 2020-09-15 06:27:33.849087 I VideoWin: Video Rect: 1920x1080+0+0 Aspect: 1.77778 2020-09-15 06:27:33.849107 I ColourSpace: PictureAttributes: Brightness,Contrast,Colour,Hue,Range 2020-09-15 06:27:33.849127 I VideoOutput: Display aspect ratio: 1.60748 (Detected) 2020-09-15 06:27:33.849142 I VideoOutput: Window aspect ratio: 1.60748 2020-09-15 06:27:33.849197 W GLVid: New frame format: None:None 1920x1080 (Tex: 2D) -> YUV420P:YUV420P 1920x1080 (Tex: 2D) 2020-09-15 06:27:33.849346 I GLVid: Created 3 input textures for 'opengl-yv12' 2020-09-15 06:27:33.857197 I GLVid: Created deinterlacer 'GLSL Kernel' (YUV420P->YUV420P) 2020-09-15 06:27:33.857223 I ColourSpace: Input : bt709(Detected) Depth:8 Range:Limited 2020-09-15 06:27:33.857236 I ColourSpace: Input : Primaries:bt709 Transfer: bt709 2020-09-15 06:27:33.857244 I ColourSpace: Output: Range:Full Primaries: bt709 2020-09-15 06:27:33.864501 I GLVid: Resizing from 1920x1080 to 7168x4051 for Performance 2020-09-15 06:27:33.914902 I Player(0): Dropping frame: Video is behind by 32ms 2020-09-15 06:27:33.914941 I VideoOutput: Disabled all deinterlacing 2020-09-15 06:27:33.914949 I Player(0): AV Sync: Audio ahead by 73 ms 2020-09-15 06:27:33.924112 I Player(0): Waiting for video buffers... 2020-09-15 06:27:33.924153 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:33.924162 N Player(0): Played: 3 Avail: 78 Buffered: 7 Margin: 89 2020-09-15 06:27:33.947982 I Player(0): AV Sync: Audio ahead by 50 ms 2020-09-15 06:27:34.043318 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.043363 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.043374 N Player(0): Played: 7 Avail: 78 Buffered: 7 Margin: 89 2020-09-15 06:27:34.068958 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.069010 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.069023 N Player(0): Played: 8 Avail: 78 Buffered: 7 Margin: 89 2020-09-15 06:27:34.106745 I Player(0): AV Sync: Audio behind by 21 ms 2020-09-15 06:27:34.108660 I Player(0): AV Sync: Audio behind by 54 ms 2020-09-15 06:27:34.142035 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.142081 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.142092 N Player(0): Played: 10 Avail: 92 Buffered: 7 Margin: 89 2020-09-15 06:27:34.243145 N Player(0): Waited 101ms for video buffers uALAAAAUAAAuUUuL 2020-09-15 06:27:34.271590 I Player(0): AV Sync: Audio behind by 56 ms 2020-09-15 06:27:34.274372 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.274418 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.274430 N Player(0): Played: 11 Avail: 92 Buffered: 7 Margin: 89 2020-09-15 06:27:34.279446 I Player(0): AV Sync: Audio behind by 89 ms 2020-09-15 06:27:34.281415 I Player(0): AV Sync: Audio behind by 122 ms 2020-09-15 06:27:34.319422 I Player(0): AV Sync: Audio behind by 113 ms 2020-09-15 06:27:34.358106 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.358149 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.358160 N Player(0): Played: 14 Avail: 92 Buffered: 7 Margin: 89 2020-09-15 06:27:34.436681 I Player(0): AV Sync: Audio behind by 114 ms 2020-09-15 06:27:34.439659 I Player(0): AV Sync: Audio behind by 136 ms 2020-09-15 06:27:34.479824 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.479925 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.479951 N Player(0): Played: 16 Avail: 92 Buffered: 7 Margin: 89 2020-09-15 06:27:34.545973 I Player(0): AV Sync: Audio behind by 128 ms 2020-09-15 06:27:34.547152 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.547198 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.547211 N Player(0): Played: 17 Avail: 92 Buffered: 7 Margin: 89 2020-09-15 06:27:34.604442 I Player(0): AV Sync: Audio behind by 161 ms 2020-09-15 06:27:34.605571 I Player(0): AV Sync: Audio behind by 194 ms 2020-09-15 06:27:34.649583 I Player(0): AV Sync: Audio behind by 185 ms 2020-09-15 06:27:34.693673 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.693770 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.693797 N Player(0): Played: 20 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:34.713638 I Player(0): AV Sync: Audio behind by 175 ms 2020-09-15 06:27:34.714803 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.714852 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.714865 N Player(0): Played: 21 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:34.773685 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.773728 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.773739 N Player(0): Played: 22 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:34.780850 I Player(0): AV Sync: Audio ahead by 311 ms 2020-09-15 06:27:34.814213 I Player(0): AV Sync: Audio ahead by 277 ms 2020-09-15 06:27:34.836418 I Player(0): AV Sync: Audio ahead by 244 ms 2020-09-15 06:27:34.854322 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.854423 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.854450 N Player(0): Played: 26 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:34.868442 I Player(0): AV Sync: Audio ahead by 211 ms 2020-09-15 06:27:34.869968 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.870031 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.870047 N Player(0): Played: 27 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:34.874641 I Player(0): AV Sync: Audio ahead by 177 ms 2020-09-15 06:27:34.878197 I Player(0): AV Sync: Audio ahead by 144 ms 2020-09-15 06:27:34.897817 I Player(0): AV Sync: Audio ahead by 132 ms 2020-09-15 06:27:34.921273 I Player(0): AV Sync: Audio ahead by 120 ms 2020-09-15 06:27:34.945419 I Player(0): AV Sync: Audio ahead by 119 ms 2020-09-15 06:27:34.971069 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.971134 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.971153 N Player(0): Played: 32 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:34.989639 I Player(0): AV Sync: Audio ahead by 106 ms 2020-09-15 06:27:34.990706 I Player(0): Waiting for video buffers... 2020-09-15 06:27:34.990747 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:34.990761 N Player(0): Played: 33 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:35.034237 I Player(0): AV Sync: Audio ahead by 73 ms 2020-09-15 06:27:35.035367 I Player(0): Waiting for video buffers... 2020-09-15 06:27:35.035413 N Player(0): Pause to allow live tv catch up 2020-09-15 06:27:35.035426 N Player(0): Played: 34 Avail: 107 Buffered: 7 Margin: 89 2020-09-15 06:27:35.126864 I Player(0): AV Sync: Audio ahead by 40 ms 2020-09-15 06:27:37.294869 I Player(0): FPS: 29.02 Mean: 34455 Std.Dev: 22074 CPUs: 10% 0% 8% 0% 6% 0% 4% 0% 2020-09-15 06:27:38.229509 I TV::HandleStateChange(): Attempting to change from WatchingLiveTV to None 2020-09-15 06:27:38.229678 I Player(0): StopPlaying - begin 2020-09-15 06:27:38.247756 I VidOutGL: (1): UuUAuuUUULUULUUU 2020-09-15 06:27:38.247799 I VideoBuffers::DiscardFrames(1): UuUAuuUUULUULUUU 2020-09-15 06:27:38.247893 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA -- done 2020-09-15 06:27:38.248996 I Player(0): Decoder thread exiting. 2020-09-15 06:27:38.249225 I Player(0): Exited decoder loop. 2020-09-15 06:27:38.253071 I VidOutGL: (1): AAAAAAAAAAAAAAAA 2020-09-15 06:27:38.253100 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA 2020-09-15 06:27:38.253132 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA -- done 2020-09-15 06:27:38.450785 I Player(0): StopPlaying - end 2020-09-15 06:27:38.450798 I TV::StopStuff(): Stopping ring buffer 2020-09-15 06:27:38.574584 I TV::StopStuff(): Stopping player 2020-09-15 06:27:38.574602 I TV::StopStuff(): stopping recorder 2020-09-15 06:27:40.214374 I TV::HandleStateChange(): Changing from WatchingLiveTV to None 2020-09-15 06:27:40.216816 I TV::StartTV(): Exiting main playback loop. 2020-09-15 06:27:40.216826 I TV::StartTV(): -- process events 2 begin 2020-09-15 06:27:40.217543 I TV::StartTV(): -- process events 2 end 2020-09-15 06:27:40.228486 I TV::~TV(): -- lock 2020-09-15 06:27:40.229831 I Player(0): StopPlaying - begin 2020-09-15 06:27:40.229857 I Player(0): Exited decoder loop. 2020-09-15 06:27:40.229869 I Player(0): StopPlaying - end 2020-09-15 06:27:40.263128 N Resuming idle timer 2020-09-15 06:27:42.788069 I TV::TV(): Creating TV object 2020-09-15 06:27:42.877491 I TV::TV(): Finished creating TV object 2020-09-15 06:27:42.877502 N Suspending idle timer 2020-09-15 06:27:42.896979 I TV::Init(): Created TvPlayWindow. 2020-09-15 06:27:42.976443 I TV::HandleStateChange(): Attempting to change from None to WatchingLiveTV 2020-09-15 06:27:42.976471 I MythCoreContext::ConnectCommandSocket(): Connecting to backend server: 192.168.0.9:6543 (try 1 of 1) 2020-09-15 06:27:43.161781 I LiveTVChain(live-XXX-2020-09-15T10:27:42Z): ReloadAll(): Added 1 recording(s) 2020-09-15 06:27:43.161802 I LiveTVChain(live-XXX-2020-09-15T10:27:42Z): LiveTVChain has 1 entries

2020-09-15 06:27:43.229888 I TV::HandleStateChange(): playbackURL(myth://mythtv/20510_20200915102743.ts) inputtype(DUMMY) 2020-09-15 06:27:43.240169 I TV::StartRecorder(): Took 2 ms to start recorder. 2020-09-15 06:27:43.240179 I TV::StartPlayer(): Elapsed time since TV constructor was called: 452 ms 2020-09-15 06:27:43.348550 W CoreAudioData Warning:CoreAudioData: "" not found, using default device 75. 2020-09-15 06:27:43.349050 N AudioPlayer: Enabling Audio 2020-09-15 06:27:43.349072 I Player(0): Opening 'myth://mythtv/20510_20200915102743.ts' 2020-09-15 06:27:43.349099 I Player(0): SetFrameInterval Interval:40000 Speed:1 Scan:Progressive Scan (Multiplier: 1) 2020-09-15 06:27:43.349122 I Player(0): detectInterlace(Ignore Scan, Interlaced Scan, 25, 576) ->Interlaced Scan QObject::connect: signal not found in MythDisplay 2020-09-15 06:27:43.374789 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl-yv12) deint(high:shader,high:shader) 2020-09-15 06:27:43.374826 I Player(0): Stretch Factor 1, allow passthru 2020-09-15 06:27:43.374853 I VideoOutput: Allowed renderers for ffmpeg (Decoder: dummy): 'opengl,opengl-yv12' 2020-09-15 06:27:43.374873 I VDP: Safe renderers for 'dummy': null,opengl,opengl-yv12,opengl-hw 2020-09-15 06:27:43.374896 I VideoOutput: Allowed renderers (filt: dummy): opengl,opengl-yv12 2020-09-15 06:27:43.401665 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl-yv12) deint(high:shader,high:shader) 2020-09-15 06:27:43.401698 I VDP: LoadBestPreferences(720x576, 25.000, ) 2020-09-15 06:27:43.401727 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:27:43.401748 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:27:43.401766 I VideoOutput: Preferred renderer: opengl-yv12 2020-09-15 06:27:43.401779 I VideoOutput: Trying video renderer: 'opengl-yv12' 2020-09-15 06:27:43.401954 I GLVid: Chroma upsampling filter disabled 2020-09-15 06:27:43.401991 I Clearing OpenGL painter cache. 2020-09-15 06:27:43.404573 I VideoWin: Window using screen Color LCD 1792x1120 2020-09-15 06:27:43.404594 I VideoWin: Window Rect: 3584x2240+0+0 2020-09-15 06:27:43.404620 I VideoWin: Display Rect: 2787x2240+398+0 Aspect: 1.60748 2020-09-15 06:27:43.404639 I VideoWin: Video Rect: 720x576+0+0 Aspect: 1.25 2020-09-15 06:27:43.404669 I ColourSpace: PictureAttributes: Brightness,Contrast,Colour,Hue,Range 2020-09-15 06:27:43.404701 I VideoOutput: Display aspect ratio: 1.60748 (Detected) 2020-09-15 06:27:43.410642 I Created 16 YUV420P (720x576) video buffers 2020-09-15 06:27:43.428338 I OSD: Base theme size: 800x600 2020-09-15 06:27:43.428358 I OSD: Scaling factors: 4.48x3.73333 2020-09-15 06:27:43.428406 I Player(0): Decoder thread starting. 2020-09-15 06:27:43.431063 I OSD: Loaded window osd_message 2020-09-15 06:27:43.433554 I OSD: Loaded window osd_input 2020-09-15 06:27:43.437312 I OSD: Loaded window program_info 2020-09-15 06:27:43.439629 I OSD: Loaded window browse_info 2020-09-15 06:27:43.441973 I OSD: Loaded window osd_status 2020-09-15 06:27:43.444206 I OSD: Loaded window osd_program_editor 2020-09-15 06:27:43.452471 I OSD: Loaded window osd_debug 2020-09-15 06:27:43.452484 I OSD: Loaded OSD: size 3584x2240 offset 0+0 2020-09-15 06:27:43.452505 I OSD: Base theme size: 800x600 2020-09-15 06:27:43.452514 I OSD: Scaling factors: 4.48x3.73333 2020-09-15 06:27:43.452544 I OSD: Created window aa_OSD_SUBTITLES 2020-09-15 06:27:43.452562 I Player(0): ClearAfterSeek(0) 2020-09-15 06:27:43.452613 I VideoOutput: SetDeinterlacing (Doublerate 1): Single High|CPU|GLSL Double High|CPU|GLSL 2020-09-15 06:27:43.452627 I Player(0): Display Refresh Rate: 59.999 Video Frame Rate: 25.000 2020-09-15 06:27:43.452639 I Player(0): SetFrameInterval Interval:40000 Speed:1 Scan:Interlaced Scan (Multiplier: 1) 2020-09-15 06:27:43.453701 I playCtx: StartPlaying(): took 0 ms to start player. 2020-09-15 06:27:43.453745 I TV::StartPlayer(): Created player. 2020-09-15 06:27:43.453769 I TV::HandleStateChange(): Changing from None to WatchingLiveTV 2020-09-15 06:27:43.453777 I TV::HandleStateChange(): State is LiveTV & mctx == ctx 2020-09-15 06:27:43.465765 I TV::HandleStateChange(): UpdateOSDInput done 2020-09-15 06:27:43.465794 I TV::HandleStateChange(): UpdateLCD done 2020-09-15 06:27:43.478050 I TV::HandleStateChange(): ITVRestart done 2020-09-15 06:27:43.482382 I TV::HandleStateChange(): Main UI disabled. 2020-09-15 06:27:43.482415 I TV::StartTV(): Entering main playback loop. 2020-09-15 06:28:08.919448 I LiveTVChain(live-XXX-2020-09-15T10:27:42Z): ReloadAll(): Added 1 recording(s) 2020-09-15 06:28:08.919494 I LiveTVChain(live-XXX-2020-09-15T10:27:42Z): LiveTVChain has 2 entries

2020-09-15 06:28:08.919577 I LiveTVChain(live-XXX-2020-09-15T10:27:42Z): SwitchTo(1) 2020-09-15 06:28:08.919593 I Player(0): JumpToProgram - start 2020-09-15 06:28:08.990915 I Player(0): Play speed: rate: 25 speed: 0 skip: 0 => new interval 40000 2020-09-15 06:28:08.990989 I VidOutGL: (1): AAAAAAAAAAAAAAAA 2020-09-15 06:28:08.991023 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA 2020-09-15 06:28:08.991062 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA -- done 2020-09-15 06:28:09.022719 I FileRingBuf(myth://mythtv/20510_20200915102743.ts): OpenFile(myth://mythtv/20510_20200915102808.ts, 10000 ms) 2020-09-15 06:28:09.901873 I Player(0): Opening 'myth://mythtv/20510_20200915102808.ts' 2020-09-15 06:28:11.617424 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(ffmpeg) cpus(2) skiploop(enabled) rend(opengl-yv12) deint(high:shader,high:shader) 2020-09-15 06:28:11.617582 I AFD: PlayerFlags: 0xc0, AudioReadAhead: 100 msec 2020-09-15 06:28:11.618497 I Player(0): Stretch Factor 1, allow passthru 2020-09-15 06:28:11.683092 I AFD: Buffer size: 32768 Streamed 1 Seekable 1 Available 458752 2020-09-15 06:28:11.772944 I AFD: Stream #0: ID: 0x1011 Codec ID: H264 Type: Video(1920x1080) Bitrate: 0 2020-09-15 06:28:11.772961 I AFD: Stream #1: ID: 0x1100 Codec ID: AC3 Type: Audio Bitrate: 0 2020-09-15 06:28:11.772972 I AFD: codec AC3 has 0 channels 2020-09-15 06:28:11.772981 I AFD: Looking for decoder for AC3 2020-09-15 06:28:11.773107 I AFD: Opened codec 0x7f9d2e2bac00, id(AC3) type(Audio) 2020-09-15 06:28:11.773145 I AFD: Trying to select best video track 2020-09-15 06:28:11.773168 I AFD: Selected track #0: ID: 0x1011 Codec ID: H264 Profile: High Type: Video(1920x1080) Bitrate: 0 2020-09-15 06:28:11.773199 I AFD: Selected FPS: 29.97 (Avg:29.97 Mult:1 Codec:0 Container:90000 Estimated:29.97) 2020-09-15 06:28:11.773214 I VDP: LoadBestPreferences(1920x1080, 29.970, h264) 2020-09-15 06:28:11.773238 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:28:11.773253 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:28:11.773271 I AFD: Using 2 CPUs for decoding 2020-09-15 06:28:11.773281 I AFD: InitVideoCodec ID:H264 Type:Video Size:1920x1080 2020-09-15 06:28:11.773309 I Player(0): SetFrameInterval Interval:33367 Speed:0 Scan:Progressive Scan (Multiplier: 1) 2020-09-15 06:28:11.773324 I VidOutGL: Video frame rate changed: 25->29.97 2020-09-15 06:28:11.773336 I VDP: LoadBestPreferences(720x576, 29.970, ) 2020-09-15 06:28:11.773354 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:28:11.773369 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:28:11.773396 I VidOutGL: Video changed: 720x576 (720x576) 'None' (Aspect 1.25 Refs 2)-> 1920x1080 (1920x1080) 'H.264' (Aspect 1.77778 Refs 3) 2020-09-15 06:28:11.773428 I DiscardAndRecreate: AAAAAAAAAAAAAAAA 2020-09-15 06:28:11.799667 I Created 17 YUV420P (1920x1080) video buffers 2020-09-15 06:28:11.799699 I DiscardAndRecreate: AAAAAAAAAAAAAAAA 2020-09-15 06:28:11.799720 I Player(0): ClearAfterSeek(1) 2020-09-15 06:28:11.799745 I Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan 2020-09-15 06:28:11.799764 I VideoOutput: SetDeinterlacing (Doublerate 0): Single High|CPU|GLSL Double None 2020-09-15 06:28:11.799792 I AFD: Using ffmpeg for video decoding 2020-09-15 06:28:11.800134 I AFD: Opened codec 0x7f9d2e2ba600, id(H264) type(Video) 2020-09-15 06:28:11.859971 N AudioPlayer: Enabling Audio 2020-09-15 06:28:11.859993 I Dec: Selected track #1 (type 2) in the Unknown language(0) 2020-09-15 06:28:11.860004 I Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0) 2020-09-15 06:28:11.886521 I Dec: SyncPositionMap watchingrecording, from DB: 0 entries 2020-09-15 06:28:11.886531 I Dec: SyncPositionMap watchingrecording no entries from encoder, try DB 2020-09-15 06:28:11.906546 I Dec: Position map filled from DB to: 0 2020-09-15 06:28:11.906563 I Dec: Duration map filled from DB to: 0 2020-09-15 06:28:11.906575 I Dec: SyncPositionMap watchingrecording total: 1 entries 2020-09-15 06:28:11.906587 I Dec: SyncPositionMap, new totframes: 0, new length: 0, posMap size: 1 2020-09-15 06:28:11.918761 I AFD: Partial position map found 2020-09-15 06:28:11.918782 I AFD: Successfully opened decoder for file: "myth://mythtv/20510_20200915102808.ts". novideo(0) 2020-09-15 06:28:12.115586 I Player(0): Play( 1.0, normal 1, unpause audio 1) 2020-09-15 06:28:12.116538 I Dec: Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1) 2020-09-15 06:28:12.116582 I Player(0): Play speed: rate: 29.97 speed: 1 skip: 1 => new interval 33366 2020-09-15 06:28:12.116615 I Player(0): Stretch Factor 1, allow passthru 2020-09-15 06:28:12.116649 I Player(0): JumpToProgram - end 2020-09-15 06:28:12.116675 I Player(0): Waiting for video buffers... 2020-09-15 06:28:12.162157 I Dec: Position map filled from DB to: 0 2020-09-15 06:28:12.162171 I Dec: Duration map filled from DB to: 0 2020-09-15 06:28:12.162181 I Dec: SyncPositionMap watchingrecording, from DB: 1 entries 2020-09-15 06:28:12.162194 I Player(0): Filling position map from 1 to end 2020-09-15 06:28:12.169996 I Dec: Position map filled from Encoder to: 0 2020-09-15 06:28:12.170027 I Dec: Duration map filled from Encoder to: 0 2020-09-15 06:28:12.170050 I Dec: SyncPositionMap watchingrecording total: 1 entries 2020-09-15 06:28:12.218422 N Player(0): Waited 102ms for video buffers (AL)LAAAAAAAAAAAAAA 2020-09-15 06:28:12.321409 N Player(0): Waited 205ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:12.423739 N Player(0): Waited 307ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:12.525220 N Player(0): Waited 409ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:12.630455 N Player(0): Waited 514ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:12.732987 N Player(0): Waited 616ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:12.836338 N Player(0): Waited 720ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:12.940914 N Player(0): Waited 824ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:13.042317 N Player(0): Waited 926ms for video buffers (au)LLAAAAAAAAAAAAA 2020-09-15 06:28:13.071232 I AOBase: Opening audio device '' ch 2(6) sr 48000 sf 32 bit floating point reenc 0 2020-09-15 06:28:13.072811 W CoreAudioData Warning:Audio device is not configured. You should configure your speaker layout with the "Audio Midi Setup" utility in /Applications/Utilities. 2020-09-15 06:28:13.143828 N Player(0): To see more buffering messages use -v playback 2020-09-15 06:28:13.143864 N Player(0): Waited 1027ms for video buffers (au)LuLAAAAAAAAAAAA 2020-09-15 06:28:13.246572 N Player(0): Waited 1130ms for video buffers (au)LUUuLAAAAAAAAAA 2020-09-15 06:28:13.349695 N Player(0): Waited 1233ms for video buffers (au)uUUULLAAAAAAAAA 2020-09-15 06:28:13.452242 N Player(0): Waited 1336ms for video buffers (au)uUUULUuLAAAAAAA 2020-09-15 06:28:13.557575 N Player(0): Waited 1441ms for video buffers (au)uUUULUuLAAAAAAA 2020-09-15 06:28:13.562563 I Player(0): Unlocking frame scan 2020-09-15 06:28:13.562577 I Player(0): Progressive frame seen after 2 interlaced frames 2020-09-15 06:28:13.562620 I VideoWin: New video parameters: Size 1920x1080 DisplaySize: 1920x1080 Aspect: 1.77778 2020-09-15 06:28:13.562638 I VideoWin: Window Rect: 3584x2240+0+0 2020-09-15 06:28:13.562651 I VideoWin: Display Rect: 3584x2025+0+107 Aspect: 1.60748 2020-09-15 06:28:13.562663 I VideoWin: Video Rect: 1920x1080+0+0 Aspect: 1.77778 2020-09-15 06:28:13.562689 I VDP: LoadBestPreferences(1920x1080, 29.970, h264) 2020-09-15 06:28:13.562714 I VDP: LoadBestPreferences result: priority:1 width: height: fps: codecs: 2020-09-15 06:28:13.562730 I VDP: decoder:ffmpeg renderer:opengl-yv12 deint0:high:shader deint1:high:shader cpus:2 2020-09-15 06:28:13.562766 I VideoWin: Window using screen Color LCD 1792x1120 2020-09-15 06:28:13.562778 I VideoWin: Window Rect: 7168x4480+0+0 2020-09-15 06:28:13.562790 I VideoWin: Display Rect: 7168x4051+0+214 Aspect: 1.60748 2020-09-15 06:28:13.562802 I VideoWin: Video Rect: 1920x1080+0+0 Aspect: 1.77778 2020-09-15 06:28:13.562821 I ColourSpace: PictureAttributes: Brightness,Contrast,Colour,Hue,Range 2020-09-15 06:28:13.562842 I VideoOutput: Display aspect ratio: 1.60748 (Detected) 2020-09-15 06:28:13.562857 I VideoOutput: Window aspect ratio: 1.60748 2020-09-15 06:28:13.562884 W GLVid: New frame format: None:None 1920x1080 (Tex: 2D) -> YUV420P:YUV420P 1920x1080 (Tex: 2D) 2020-09-15 06:28:13.562977 I GLVid: Created 3 input textures for 'opengl-yv12' 2020-09-15 06:28:13.570457 I GLVid: Created deinterlacer 'GLSL Kernel' (YUV420P->YUV420P) 2020-09-15 06:28:13.570472 I ColourSpace: Input : bt709(Detected) Depth:8 Range:Limited 2020-09-15 06:28:13.570481 I ColourSpace: Input : Primaries:bt709 Transfer: bt709 2020-09-15 06:28:13.570488 I ColourSpace: Output: Range:Full Primaries: bt709 2020-09-15 06:28:13.571319 I GLVid: Resizing from 1920x1080 to 7168x4051 for Performance 2020-09-15 06:28:13.618933 I Player(0): AV Sync: Audio ahead by 101 ms 2020-09-15 06:28:13.620504 I VideoOutput: Disabled all deinterlacing 2020-09-15 06:28:13.620514 I Player(0): AV Sync: Audio ahead by 79 ms 2020-09-15 06:28:13.627840 I Player(0): Waiting for video buffers... 2020-09-15 06:28:13.627879 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:13.627889 N Player(0): Played: 3 Avail: 75 Buffered: 7 Margin: 89 2020-09-15 06:28:13.676518 I Player(0): AV Sync: Audio ahead by 45 ms 2020-09-15 06:28:13.679754 I Player(0): Waiting for video buffers... 2020-09-15 06:28:13.679836 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:13.679848 N Player(0): Played: 4 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:13.728508 I Player(0): Waiting for video buffers... 2020-09-15 06:28:13.728553 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:13.728566 N Player(0): Played: 5 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:13.738104 I Player(0): AV Sync: Audio behind by 22 ms 2020-09-15 06:28:13.740921 I Player(0): AV Sync: Audio behind by 55 ms 2020-09-15 06:28:13.773182 I Player(0): Waiting for video buffers... 2020-09-15 06:28:13.773290 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:13.773317 N Player(0): Played: 7 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:13.855909 I Player(0): AV Sync: Audio behind by 56 ms 2020-09-15 06:28:13.858279 I Player(0): Waiting for video buffers... 2020-09-15 06:28:13.858321 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:13.858332 N Player(0): Played: 8 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:13.892243 I Player(0): AV Sync: Audio behind by 90 ms 2020-09-15 06:28:13.893370 I Player(0): Waiting for video buffers... 2020-09-15 06:28:13.893414 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:13.893427 N Player(0): Played: 9 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:13.902485 I Player(0): AV Sync: Audio behind by 123 ms 2020-09-15 06:28:13.907491 I Player(0): AV Sync: Audio behind by 156 ms 2020-09-15 06:28:13.943680 I Player(0): Waiting for video buffers... 2020-09-15 06:28:13.943744 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:13.943762 N Player(0): Played: 11 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:14.006641 I Player(0): AV Sync: Audio behind by 148 ms 2020-09-15 06:28:14.007926 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.007965 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.007976 N Player(0): Played: 12 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:14.060307 I Player(0): AV Sync: Audio behind by 181 ms 2020-09-15 06:28:14.061537 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.061574 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.061586 N Player(0): Played: 13 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:14.074218 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.074286 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.074301 N Player(0): Played: 14 Avail: 89 Buffered: 7 Margin: 89 2020-09-15 06:28:14.149987 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.154943 I Player(0): AV Sync: Audio ahead by 263 ms 2020-09-15 06:28:14.184504 I Player(0): AV Sync: Audio ahead by 240 ms 2020-09-15 06:28:14.208034 I Player(0): AV Sync: Audio ahead by 207 ms 2020-09-15 06:28:14.227326 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.227394 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.227412 N Player(0): Played: 18 Avail: 105 Buffered: 7 Margin: 89 2020-09-15 06:28:14.315771 I Player(0): AV Sync: Audio ahead by 174 ms 2020-09-15 06:28:14.318350 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.318404 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.318417 N Player(0): Played: 19 Avail: 105 Buffered: 7 Margin: 89 2020-09-15 06:28:14.323369 I Player(0): AV Sync: Audio ahead by 140 ms 2020-09-15 06:28:14.325919 I Player(0): AV Sync: Audio ahead by 107 ms 2020-09-15 06:28:14.347073 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.347135 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.347153 N Player(0): Played: 21 Avail: 105 Buffered: 7 Margin: 89 2020-09-15 06:28:14.437496 I Player(0): AV Sync: Audio ahead by 95 ms 2020-09-15 06:28:14.439900 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.439941 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.439953 N Player(0): Played: 22 Avail: 105 Buffered: 7 Margin: 89 2020-09-15 06:28:14.484121 I Player(0): AV Sync: Audio ahead by 61 ms 2020-09-15 06:28:14.485481 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.485534 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.485547 N Player(0): Played: 23 Avail: 105 Buffered: 7 Margin: 89 2020-09-15 06:28:14.490186 I Player(0): AV Sync: Audio ahead by 28 ms 2020-09-15 06:28:14.588335 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.588435 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.588461 N Player(0): Played: 27 Avail: 105 Buffered: 7 Margin: 89 2020-09-15 06:28:14.609066 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.609117 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.609131 N Player(0): Played: 28 Avail: 105 Buffered: 7 Margin: 89 2020-09-15 06:28:14.656341 I Player(0): AV Sync: Audio behind by 43 ms 2020-09-15 06:28:14.657526 I Player(0): Waiting for video buffers... 2020-09-15 06:28:14.657573 N Player(0): Pause to allow live tv catch up 2020-09-15 06:28:14.657586 N Player(0): Played: 29 Avail: 115 Buffered: 7 Margin: 89 2020-09-15 06:28:14.666632 I Player(0): AV Sync: Audio behind by 76 ms 2020-09-15 06:28:14.674504 I Player(0): AV Sync: Audio behind by 110 ms 2020-09-15 06:28:14.704547 I Player(0): AV Sync: Audio behind by 111 ms 2020-09-15 06:28:14.744000 I Player(0): AV Sync: Audio behind by 101 ms 2020-09-15 06:28:14.784369 I Player(0): AV Sync: Audio behind by 92 ms 2020-09-15 06:28:14.822405 I Player(0): AV Sync: Audio behind by 93 ms 2020-09-15 06:28:14.863787 I Player(0): AV Sync: Audio behind by 85 ms 2020-09-15 06:28:14.901934 I Player(0): AV Sync: Audio behind by 75 ms 2020-09-15 06:28:14.940948 I Player(0): AV Sync: Audio behind by 76 ms 2020-09-15 06:28:14.979812 I Player(0): AV Sync: Audio behind by 67 ms 2020-09-15 06:28:15.018218 I Player(0): AV Sync: Audio behind by 58 ms 2020-09-15 06:28:15.055359 I Player(0): AV Sync: Audio behind by 59 ms 2020-09-15 06:28:15.093274 I Player(0): AV Sync: Audio behind by 50 ms 2020-09-15 06:28:15.128828 I Player(0): AV Sync: Audio behind by 51 ms 2020-09-15 06:28:15.166011 I Player(0): AV Sync: Audio behind by 42 ms 2020-09-15 06:28:15.202424 I Player(0): AV Sync: Audio behind by 43 ms 2020-09-15 06:28:15.238902 I Player(0): AV Sync: Audio behind by 44 ms 2020-09-15 06:28:15.274968 I Player(0): AV Sync: Audio behind by 36 ms 2020-09-15 06:28:15.311969 I Player(0): AV Sync: Audio behind by 36 ms 2020-09-15 06:28:15.347511 I Player(0): AV Sync: Audio behind by 38 ms 2020-09-15 06:28:15.383479 I Player(0): AV Sync: Audio behind by 29 ms 2020-09-15 06:28:15.419035 I Player(0): AV Sync: Audio behind by 30 ms 2020-09-15 06:28:15.453721 I Player(0): AV Sync: Audio behind by 31 ms 2020-09-15 06:28:15.488613 I Player(0): AV Sync: Audio behind by 22 ms 2020-09-15 06:28:15.525064 I Player(0): AV Sync: Audio behind by 23 ms 2020-09-15 06:28:15.559839 I Player(0): AV Sync: Audio behind by 25 ms 2020-09-15 06:28:17.114323 I Player(0): FPS: 28.16 Mean: 35513 Std.Dev: 19287 CPUs: 10% 0% 8% 0% 6% 0% 4% 0% 2020-09-15 06:28:18.284506 I VideoWin: New embedding rect: 448x280+1299+127 2020-09-15 06:28:18.284560 I VideoWin: Window Rect: 7168x4480+0+0 2020-09-15 06:28:18.284574 I VideoWin: Display Rect: 448x253+1299+140 Aspect: 1.60748 2020-09-15 06:28:18.284585 I VideoWin: Video Rect: 1920x1080+0+0 Aspect: 1.77778 2020-09-15 06:28:18.295975 I Player(0): Dropping frame: Video is behind by 81ms 2020-09-15 06:28:18.296960 I Player(0): Dropping frame: Video is behind by 49ms 2020-09-15 06:28:18.298023 I Player(0): AV Sync: Audio behind by 70 ms 2020-09-15 06:28:18.353214 I GLVid: Disabled resizing 2020-09-15 06:28:18.360849 I Player(0): Dropping frame: Video is behind by 43ms 2020-09-15 06:28:18.360948 I Player(0): AV Sync: Audio ahead by 44 ms 2020-09-15 06:28:18.867702 I Player(0): AV Sync: Audio ahead by 45 ms 2020-09-15 06:28:18.872994 I Player(0): AV Sync: Audio ahead by 23 ms 2020-09-15 06:28:20.450981 I Player(0): FPS: 29.97 Mean: 33363 Std.Dev: 14895 CPUs: 27% 0% 21% 0% 16% 0% 10% 0% libpng warning: iCCP: known incorrect sRGB profile libpng warning: iCCP: known incorrect sRGB profile libpng warning: iCCP: known incorrect sRGB profile 2020-09-15 06:28:22.141355 I Player(0): Dropping frame: Video is behind by 89ms 2020-09-15 06:28:22.141700 I VideoWin: Stopped embedding 2020-09-15 06:28:22.141715 I VideoWin: Window Rect: 7168x4480+0+0 2020-09-15 06:28:22.141728 I VideoWin: Display Rect: 7168x4051+0+214 Aspect: 1.60748 2020-09-15 06:28:22.141738 I VideoWin: Video Rect: 1920x1080+0+0 Aspect: 1.77778 2020-09-15 06:28:22.142254 I OSD: Base theme size: 800x600 2020-09-15 06:28:22.142265 I OSD: Scaling factors: 8.96x7.46667 2020-09-15 06:28:22.144546 I OSD: Loaded window osd_message 2020-09-15 06:28:22.146546 I OSD: Loaded window osd_input 2020-09-15 06:28:22.150705 I OSD: Loaded window program_info 2020-09-15 06:28:22.154855 I OSD: Loaded window browse_info 2020-09-15 06:28:22.158467 I OSD: Loaded window osd_status 2020-09-15 06:28:22.161069 I OSD: Loaded window osd_program_editor 2020-09-15 06:28:22.169921 I OSD: Loaded window osd_debug 2020-09-15 06:28:22.169937 I OSD: Loaded OSD: size 7168x4480 offset 0+0 2020-09-15 06:28:22.169964 I EnableCaptions(0) msg: On 2020-09-15 06:28:22.170013 I Clearing OpenGL painter cache. 2020-09-15 06:28:22.173372 I Player(0): Dropping frame: Video is behind by 88ms 2020-09-15 06:28:22.173431 I Player(0): Dropping frame: Video is behind by 55ms 2020-09-15 06:28:22.173469 I Player(0): AV Sync: Audio behind by 100 ms 2020-09-15 06:28:22.175972 I GLVid: Resizing from 1920x1080 to 7168x4051 for Performance 2020-09-15 06:28:22.176971 I Player(0): AV Sync: Audio ahead by 26 ms 2020-09-15 06:28:23.787951 I Player(0): FPS: 29.97 Mean: 33366 Std.Dev: 13585 CPUs: 27% 1% 20% 1% 16% 1% 14% 1% 2020-09-15 06:28:24.023193 I TV::HandleStateChange(): Attempting to change from WatchingLiveTV to None 2020-09-15 06:28:24.023311 I Player(0): StopPlaying - begin 2020-09-15 06:28:24.023450 I VidOutGL: (1): UuULUUuuUUULUUUU 2020-09-15 06:28:24.023488 I VideoBuffers::DiscardFrames(1): UuULUUuuUUULUUUU 2020-09-15 06:28:24.023585 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA -- done 2020-09-15 06:28:24.024552 I Player(0): Decoder thread exiting. 2020-09-15 06:28:24.024793 I Player(0): Exited decoder loop. 2020-09-15 06:28:24.036204 I VidOutGL: (1): AAAAAAAAAAAAAAAA 2020-09-15 06:28:24.036229 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA 2020-09-15 06:28:24.036256 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAA -- done 2020-09-15 06:28:24.238163 I Player(0): StopPlaying - end 2020-09-15 06:28:24.238175 I TV::StopStuff(): Stopping ring buffer 2020-09-15 06:28:24.339483 I TV::StopStuff(): Stopping player 2020-09-15 06:28:24.339511 I TV::StopStuff(): stopping recorder 2020-09-15 06:28:25.925695 I TV::HandleStateChange(): Changing from WatchingLiveTV to None 2020-09-15 06:28:25.929152 I TV::StartTV(): Exiting main playback loop. 2020-09-15 06:28:25.929180 I TV::StartTV(): -- process events 2 begin 2020-09-15 06:28:25.935182 I TV::StartTV(): -- process events 2 end 2020-09-15 06:28:25.946304 I TV::~TV(): -- lock 2020-09-15 06:28:25.948144 I Player(0): StopPlaying - begin 2020-09-15 06:28:25.948181 I Player(0): Exited decoder loop. 2020-09-15 06:28:25.948193 I Player(0): StopPlaying - end 2020-09-15 06:28:25.977284 N Resuming idle timer 2020-09-15 06:28:31.216664 I MythUIHelper: Pruning cache directory: /Users/XXX/.mythtv/cache/remotecache 2020-09-15 06:28:31.217052 I MythUIHelper: Kept 3 files, deleted 0 files, stat error on 0 files 2020-09-15 06:28:31.217075 I MythUIHelper: Pruning cache directory: /Users/XXX/.mythtv/cache/thumbnails 2020-09-15 06:28:31.234435 I MythUIHelper: Kept 289 files, deleted 0 files, stat error on 0 files 2020-09-15 06:28:31.244837 N Resuming idle timer 2020-09-15 06:28:31.244882 N Resuming idle timer 2020-09-15 06:28:31.306710 I Bonjour: De-registering service '_mythfrontend._tcp.' on 'Mythfrontend on XXX' 2020-09-15 06:28:31.333856 W MythPainter: 58 images not yet de-allocated. 2020-09-15 06:28:31.333892 I Clearing OpenGL painter cache. 2020-09-15 06:28:31.335940 I OpenGL: MythRenderOpenGL closing 2020-09-15 06:28:31.340763 I Display: Deleting 2020-09-15 06:28:31.355037 I RAOP Device: Cleaning up. 2020-09-15 06:28:31.355087 I AirPlay: Cleaning up. 2020-09-15 06:28:31.355475 I Bonjour: De-registering service '_airplay._tcp.' on 'MythTV on XXX' 2020-09-15 06:28:31.356006 I Shutting down UPnP client... 2020-09-15 06:28:38.049323 I Waiting for threads to exit. 2020-09-15 06:28:45.262253 I Exiting

./mythfrontend.app/Contents/MacOS/mythfrontend -v playback 2020-09-15 06:36:05.506952 I Setup Interrupt: 2 handler 2020-09-15 06:36:05.506978 I Setup Terminated: 15 handler 2020-09-15 06:36:05.506986 I Setup Segmentation fault: 11 handler 2020-09-15 06:36:05.506994 I Setup Abort trap: 6 handler 2020-09-15 06:36:05.507001 I Setup Bus error: 10 handler 2020-09-15 06:36:05.507008 I Setup Floating point exception: 8 handler 2020-09-15 06:36:05.507015 I Setup Illegal instruction: 4 handler 2020-09-15 06:36:05.507024 I Setup User defined signal 1: 30 handler 2020-09-15 06:36:05.507032 I Setup User defined signal 2: 31 handler 2020-09-15 06:36:05.507039 I Setup Hangup: 1 handler 2020-09-15 06:36:05.507144 C mythfrontend version: fixes/31 [v31.0-94-gb033cd7b75] www.mythtv.org 2020-09-15 06:36:05.507154 C Qt version: compile: 5.14.2, runtime: 5.14.2 2020-09-15 06:36:05.507179 I macOS 10.15 (x86_64) 2020-09-15 06:36:05.507191 N Enabled verbose msgs: general playback 2020-09-15 06:36:05.507212 N Setting Log Level to LOG_INFO 2020-09-15 06:36:05.518639 I Added logging to the console 2020-09-15 06:36:05.518893 N Using runtime prefix = /Users/XXX/Downloads/mythfrontend.app/Contents/Resources 2020-09-15 06:36:05.518922 N Using configuration directory = /Users/XXX/.mythtv 2020-09-15 06:36:05.519056 I Assumed charac

mark-kendall commented 4 years ago

Mark, I just tested and confirmed the visualizers to work in video playback.

Good - thanks

As far as I can tell, the patch does correct the OSD scaling in playback.

Excellent.

Checking Live TV on the unpatched version - same behavior. The screen is zoomed into bottom left quarter of the video. An interesting note - now that I can see the OSD - the icon in the bottom right corner indicates that the channel is SD. This is strange because the video fed into my recorder (collossus2) is forced to 1080p at the STB.

I think this is a more generic issue. Seem to be a few reports of this behaviour cropping up in 0.31. I need to have a look - but suspect it is not relevant to the scaling issue.

mark-kendall commented 4 years ago

VideoWin: Window Rect: 7168x4480+0+0 VideoWin: Display Rect: 7168x4051+0+214 Aspect: 1.60748 VideoWin: Video Rect: 1920x1080+0+0 Aspect: 1.77778

Actually it looks like the scaling is being applied twice for some reason during live tv. ergh.

mark-kendall commented 4 years ago

John

New patch should get everything working except the program guide.

https://gist.github.com/mark-kendall/9b4475cd8e518934510b0aa4438c85c1

jhoyt4 commented 4 years ago

Thanks Mark, I'll try to test tonight when I get back from the office.

On Wed, Sep 16, 2020, 7:06 AM Mark Kendall notifications@github.com wrote:

John

New patch should get everything working except the program guide.

https://gist.github.com/mark-kendall/9b4475cd8e518934510b0aa4438c85c1

— You are receiving this because you are subscribed to this thread. Reply to this email directly, view it on GitHub https://github.com/MythTV/mythtv/issues/206#issuecomment-693334941, or unsubscribe https://github.com/notifications/unsubscribe-auth/AGBZ2ES5OP5QIOTHXDM7BRTSGCL4DANCNFSM4REVRA4Q .

jhoyt4 commented 4 years ago

Mark, it looks like the Live TV playback and the OSD are good to go. The only issue I came across was the program guide rendering in the upper left quarter of the screen.

Test Status
Menus + good
Menus - Settings + good
Recording Playback 1080p + good
Recording Playback OSD 1080p + good
Recording Playback - Display Program Guide - broken - shows up in upper left hand quarter of screen
Video Playback 480i + good
Video Playback OSD 480i + good
Video Playback 720p + good
Video Playback OSD 720p + good
Video Playback 1080p + good
Video Playback OSD 1080p + good
Video Playback UHD + good
Video Playback OSD UHD + good
Video Playback - Visualizers + good
Video - Display Program Guide - broken - shows up in upper left hand quarter of screen
Program Guide (from menu) + good
Live TV playback +good
Live TV - OSD + good
Live TV - Display Program Guide - broken - shows up in upper left hand quarter of screen
Live TV - EPG - embedded playback + good plays back in correct spot
mark-kendall commented 4 years ago

John - previous patch has been pushed to master and .31.

New patch for 0.31 should address embedded programme guide (already pushed to master).

Could you test with high dpi scaling ignored/disabled as well? (I forget the macOS setting)

https://gist.github.com/mark-kendall/7bf045849ab147658a18a6dd61e22105

jhoyt4 commented 4 years ago

Mark - will do shortly, compiling now.

A couple notes - I had trouble getting the patch to apply on the latest v31. I was able to manually apply the failed line.

patch -p1 < ../patches/gistfile1.txt

patching file mythtv/libs/libmythtv/opengl/mythvideooutopengl.cpp
patching file mythtv/libs/libmythui/opengl/mythpainteropengl.cpp
patching file mythtv/libs/libmythui/opengl/mythpainteropengl.h
patch unexpectedly ends in middle of line
Hunk #3 FAILED at 89.
1 out of 3 hunks FAILED -- saving rejects to file mythtv/libs/libmythui/opengl/mythpainteropengl.h.rej

cat mythtv/libs/libmythui/opengl/mythpainteropengl.h.rej

***************
*** 81,84 ****
      bool                       m_mappedBufferPoolReady { false };
  };

--- 89,94 ----
      bool                       m_mappedBufferPoolReady { false };
  };

+ Q_DECLARE_OPERATORS_FOR_FLAGS(MythOpenGLPainter::ViewControls)
+ 

To disable High Resolution Mode on a mac app you can either add the following to the App's Info.plist:

        <key>NSHighResolutionCapable</key>
        <false/>

Alternatively, "get info" on the .app file and check the box next to "Open in Low Resolution"

jhoyt4 commented 4 years ago

Mark - so close. The guide now renders correctly in recording/video/Live TV playback. The only issue I could tell was that in HDPI while in Live TV and the guide is up, the live tv preview is still rendering scaled down and in the upper left corner

Test HDPI Low Res
Menus
Menus - Settings
Recording Playback 1080p
Recording Playback OSD 1080p
Recording Playback - Display Program Guide
Video Playback 480i
Video Playback OSD 480i
Video Playback 720p
Video Playback OSD 720p
Video Playback 1080p
Video Playback OSD 1080p
Video Playback UHD N/A
Video Playback OSD UHD N/A
Video Playback - Visualizers
Video - Display Program Guide
Program Guide (from menu)
Live TV playback
Live TV - OSD
Live TV - Display Program Guide
Live TV - EPG - embedded playback x - still rendering small in upper left quarter of screen
mark-kendall commented 4 years ago

Thanks John - could you attach a screenshot? (Of the embedded video playback livtev)

jhoyt4 commented 4 years ago

Screenshot attached

Screen Shot 2020-09-18 at 9 03 04 AM
mark-kendall commented 4 years ago

OK - confirms what I realised I missed:) Here's v2

https://gist.github.com/mark-kendall/2cb2bb6f387caf1f461637a70d7f7a7f

jhoyt4 commented 4 years ago

That fixed it! I verified there were no regressions.

Thanks for getting this working!

mark-kendall commented 4 years ago

John - many thanks for all of the help. Please get in touch if I break something again:)

This should be working in master and .31 - so time to close.