Ticket #13580: frontend-output.txt

2020-02-09 01:53:29.420628 I  Setup Interrupt handler
2020-02-09 01:53:29.420663 I  Setup Terminated handler
2020-02-09 01:53:29.420675 I  Setup Segmentation fault handler
2020-02-09 01:53:29.420686 I  Setup Aborted handler
2020-02-09 01:53:29.420697 I  Setup Bus error handler
2020-02-09 01:53:29.420709 I  Setup Floating point exception handler
2020-02-09 01:53:29.420720 I  Setup Illegal instruction handler
2020-02-09 01:53:29.420734 I  Setup Real-time signal 0 handler
2020-02-09 01:53:29.420746 I  Setup User defined signal 1 handler
2020-02-09 01:53:29.420757 I  Setup User defined signal 2 handler
2020-02-09 01:53:29.420769 I  Setup Hangup handler
2020-02-09 01:53:29.420911 C  mythfrontend version:  [v30.0] www.mythtv.org
2020-02-09 01:53:29.420921 C  Qt version: compile: 5.9.5, runtime: 5.9.5
2020-02-09 01:53:29.420926 N  Enabled verbose msgs:  general
2020-02-09 01:53:29.420946 N  Setting Log Level to LOG_INFO
2020-02-09 01:53:29.431439 N  Using runtime prefix = /usr
2020-02-09 01:53:29.431449 N  Using configuration directory = /home/jarnos/.mythtv
2020-02-09 01:53:29.431463 I  Added logging to the console
2020-02-09 01:53:29.431561 I  Assumed character encoding: en_US.UTF-8
2020-02-09 01:53:29.431915 I  Added syslogging
2020-02-09 01:53:29.432241 I  Loading en_us translation for module mythfrontend
2020-02-09 01:53:29.432807 I  Empty LocalHostName. This is typical.
2020-02-09 01:53:29.432825 I  Using a profile name of: 'jarnos-8510w' (Usually the same as this host's name.)
2020-02-09 01:53:29.432966 I  Start up testing connections. DB 192.168.100.51, BE , attempt 0, status dbAwake, Delay: 2000
2020-02-09 01:53:31.135137 N  Setting QT default locale to en_FI
2020-02-09 01:53:31.135169 I  Current locale en_FI
2020-02-09 01:53:31.135251 E  No locale defaults file for en_FI, skipping
2020-02-09 01:53:31.144729 I  Starting process signal handler
2020-02-09 01:53:31.148268 I  Starting IO manager (read)
2020-02-09 01:53:31.149911 I  Starting IO manager (write)
2020-02-09 01:53:31.150052 I  Starting process manager
2020-02-09 01:53:31.196067 I  ScreenSaverX11Private: DPMS is disabled.
2020-02-09 01:53:31.355410 N  Desktop video mode: 1920x1080 50.000 Hz
2020-02-09 01:53:31.923404 I  Listening on TCP 0.0.0.0:6547
2020-02-09 01:53:31.935028 I  Listening on TCP [::]:6547
2020-02-09 01:53:34.844011 I  Loading en_us translation for module mythfrontend
2020-02-09 01:53:34.916383 E  LIRC: Failed to connect to Unix socket '/var/run/lirc/lircd'
                        eno: No such file or directory (2)
2020-02-09 01:53:34.916459 I  No joystick configuration found, not enabling joystick control
2020-02-09 01:53:35.215670 E  CECAdapter: Failed to find any CEC devices.
2020-02-09 01:53:35.215860 I  CECAdapter: Closing down CEC.
2020-02-09 01:53:35.215906 I  UDPListener: Enabling
2020-02-09 01:53:35.222132 I  Binding to UDP 0.0.0.0:6948
2020-02-09 01:53:35.223468 I  Binding to UDP [::]:6948
2020-02-09 01:53:35.716594 I  Using Frameless Window
2020-02-09 01:53:35.716607 I  Using Full Screen Window
2020-02-09 01:53:35.757596 I  UI Screen Resolution: 1920 x 1080
2020-02-09 01:53:35.807799 I  Using the Qt painter
2020-02-09 01:53:35.844542 I  MythUIHelper: Pruning cache directory: /home/jarnos/.mythtv/cache/remotecache
2020-02-09 01:53:35.845188 I  MythUIHelper: Kept 58 files, deleted 0 files, stat error on 0 files
2020-02-09 01:53:35.845243 I  MythUIHelper: Pruning cache directory: /home/jarnos/.mythtv/cache/thumbnails
2020-02-09 01:53:35.845580 I  MythUIHelper: Kept 30 files, deleted 0 files, stat error on 0 files
libpng warning: iCCP: known incorrect sRGB profile
libpng warning: iCCP: known incorrect sRGB profile
2020-02-09 01:53:36.369223 I  MythUIWebBrowser: Loading css from - file:///usr/share/mythtv/themes/default/htmls/mythbrowser.css
2020-02-09 01:53:36.378896 I  MythCoreContext::ConnectCommandSocket(): Connecting to backend server: 192.168.100.51:6543 (try 1 of 1)
2020-02-09 01:53:36.387270 I  MythCoreContext::CheckProtoVersion(): Using protocol version 91 BuzzOff
2020-02-09 01:53:36.390572 I  MythUIWebBrowser: enabling plugins
2020-02-09 01:53:36.483272 E  RAOP Device: Aborting startup - no key found.
2020-02-09 01:53:36.494996 I  AirPlay: Created airplay objects.
2020-02-09 01:53:36.495357 I  Listening on TCP 0.0.0.0:5100
2020-02-09 01:53:36.495410 I  Listening on TCP [::]:5100
2020-02-09 01:53:36.550582 I  Current MythTV Schema Version (DBSchemaVer): 1350
2020-02-09 01:53:37.438755 I  Bonjour: Service registration complete: name 'MythTV on jarnos-8510w' type '_airplay._tcp.' domain: 'local.'
2020-02-09 01:53:40.710693 N  Registering Internal as a media playback plugin.
2020-02-09 01:53:40.724082 A  MMUnix:CheckMountable: DBus interface error: The name org.freedesktop.UDisks was not provided by any .service files
2020-02-09 01:53:40.726539 W  MMUnix:UDisks2 service found. Media Monitor does not support this yet!
2020-02-09 01:53:40.735687 W  No plugins directory /usr/lib/mythtv/plugins
2020-02-09 01:53:40.842467 N  Found mainmenu.xml for theme 'Mythbuntu'
2020-02-09 01:53:40.896757 I  Checking for theme updates every hour
2020-02-09 01:53:40.897100 I  Registering HouseKeeperTask 'HardwareProfiler'.
2020-02-09 01:53:40.918784 I  Queueing HouseKeeperTask 'HardwareProfiler'.
2020-02-09 01:53:40.918799 I  Starting HouseKeeper.
2020-02-09 01:53:41.166460 I  Bonjour: Service registration complete: name 'Mythfrontend on jarnos-8510w' type '_mythfrontend._tcp.' domain: 'local.'
2020-02-09 01:53:52.476578 I  TV::TV(): Creating TV object
2020-02-09 01:53:52.542321 N  Suspending idle timer
2020-02-09 01:53:52.576177 I  TV::Init(): Created TvPlayWindow.
2020-02-09 01:53:52.695670 I  TV::HandleStateChange(): Attempting to change from None to WatchingPreRecorded
2020-02-09 01:53:53.021363 E  ALSA: snd_pcm_info_get_card: Operation not permitted
2020-02-09 01:53:53.051490 N  AudioPlayer: Enabling Audio
2020-02-09 01:53:57.168210 I  AFD: codec AC3 has 0 channels
2020-02-09 01:53:57.168729 I  AFD: Opened codec 0x564fd7ad8640, id(AC3) type(Audio)
2020-02-09 01:53:57.168838 I  AFD: codec AC3 has 0 channels
2020-02-09 01:53:57.169392 I  AFD: Opened codec 0x564fd7945540, id(AC3) type(Audio)
2020-02-09 01:53:57.169446 I  AFD: codec AC3 has 0 channels
2020-02-09 01:53:57.169990 I  AFD: Opened codec 0x564fd7ad4e00, id(AC3) type(Audio)
2020-02-09 01:53:57.277376 I  VDPAU: Version 1
2020-02-09 01:53:57.277397 I  VDPAU: Information NVIDIA VDPAU Driver Shared Library  340.107  Thu May 24 21:44:57 PDT 2018
2020-02-09 01:53:57.288934 I  AFD: Using vdpau for video decoding
2020-02-09 01:53:57.289039 I  AFD: Opened codec 0x564fd7aaec00, id(H264) type(Video)
2020-02-09 01:53:57.289945 W  Enabling buffering optimisations for low bitrate stream.
2020-02-09 01:53:57.302577 W  Enabling buffering optimisations for low bitrate stream.
2020-02-09 01:53:57.325991 N  AudioPlayer: Enabling Audio
2020-02-09 01:53:58.324674 I  VDPAU: Created 2 output surfaces.
2020-02-09 01:53:58.324704 I  VDPAU: Created VDPAU render device 1920x1080
2020-02-09 01:53:58.489833 E  Player(0): Video sync method can't support double framerate (refresh rate too low for 2x deint)
2020-02-09 01:53:58.516775 I  Player(0): Video timing method: USleep with busy wait
2020-02-09 01:53:58.517665 I  TV::StartPlayer(): Created player.
2020-02-09 01:53:58.518114 I  TV::HandleStateChange(): Changing from None to WatchingPreRecorded
2020-02-09 01:53:58.519017 I  AFD: codec AC3 has 0 channels
2020-02-09 01:53:58.520323 I  AFD: Opened codec 0x7f341c065780, id(AC3) type(Audio)
2020-02-09 01:53:58.520423 I  AFD: codec AC3 has 0 channels
2020-02-09 01:53:58.521164 I  AFD: Opened codec 0x7f341c06a240, id(AC3) type(Audio)
2020-02-09 01:53:58.541771 I  TV::HandleStateChange(): Main UI disabled.
2020-02-09 01:53:58.541855 I  TV::StartTV(): Entering main playback loop.
2020-02-09 01:53:58.640876 I  AFD: Using vdpau for video decoding
2020-02-09 01:53:58.641091 I  AFD: Opened codec 0x7f341c06e480, id(H264) type(Video)
2020-02-09 01:53:58.641104 W  Enabling buffering optimisations for low bitrate stream.
2020-02-09 01:53:58.646711 N  Player(0): Waited 102ms for video buffers AAAAAAAAAAAAAA
2020-02-09 01:53:58.652476 I  AOBase: Opening audio device 'pulse' ch 2(2) sr 48000 sf 32 bit floating point reenc 0
2020-02-09 01:53:58.712726 W  MythPainter: 25 images not yet de-allocated.
2020-02-09 01:53:58.712755 I  VDPAU Painter: Clearing VDPAU painter cache.
2020-02-09 01:53:58.751824 N  Player(0): Waited 207ms for video buffers               
2020-02-09 01:53:58.844696 I  VDPAU: Created 2 output surfaces.
2020-02-09 01:53:58.844717 I  VDPAU: Created VDPAU render device 1920x1080
2020-02-09 01:53:58.852489 N  Player(0): Waited 308ms for video buffers AAAAAAAAAAAAAA
2020-02-09 01:53:58.957000 N  Player(0): Waited 412ms for video buffers AAAAAAAAAAAAAA
2020-02-09 01:53:58.994034 I  VidOutVDPAU: Added 2 new buffers. New buffer size 16 (4 decode and 12 process)
2020-02-09 01:53:59.054373 E  VDPAU: Error at mythrender_vdpau.cpp:762 (#23, The system does not have enough resources to complete the requested operation at this time.)
2020-02-09 01:53:59.054395 E  VidOutVDPAU: Failed to create decoder.
2020-02-09 01:53:59.055042 I  MythCodecContext: Disabled hardware decoder based deinterlacer.
2020-02-09 01:53:59.059155 N  Player(0): Waited 515ms for video buffers (AL)(AL)LLuAAAAAAAAA  
2020-02-09 01:53:59.061025 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.061647 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.063129 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.063967 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.064247 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.064792 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.066581 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.068125 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.068511 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.070094 E  VidOutVDPAU: IsErrored() in DrawSlice
2020-02-09 01:53:59.070487 E  Player(0): AVSync: Unknown error in videoOutput, aborting playback.
2020-02-09 01:53:59.130412 I  TV::HandleStateChange(): Attempting to change from WatchingPreRecorded to None
2020-02-09 01:53:59.230627 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:53:59.330762 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:53:59.430901 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:53:59.531035 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:53:59.631169 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:53:59.731304 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:53:59.831454 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:53:59.931615 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.031749 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.131883 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.232017 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.332162 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.432290 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.532424 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.632566 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.732729 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.832878 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:00.933019 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.033193 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.133356 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.233522 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.333690 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.433833 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.533969 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.634104 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.734252 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.834388 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:01.934529 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.034669 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.134803 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.234941 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.335077 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.435224 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.535356 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.635492 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.735627 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.835752 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:02.935902 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.036044 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.136166 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.236308 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.336447 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.436590 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.536734 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.636870 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.737004 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.837140 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:03.937258 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.037423 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.137589 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.237766 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.337928 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.438048 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.538271 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.638420 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.738564 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.838702 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:04.938840 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.038973 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.139107 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.239248 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.339382 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.439520 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.539648 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.639782 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.739906 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.840028 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:05.940144 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.040271 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.140397 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.240563 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.340699 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.440849 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.540995 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.641114 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.741247 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.841392 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:06.941548 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.041718 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.141868 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.242015 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.342164 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.442301 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.542453 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.642575 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.742697 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.842821 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:07.942953 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.043105 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.143231 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.243381 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.343529 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.443856 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.543989 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.644135 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.744279 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.844426 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:08.955114 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:09.055270 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:09.155429 W  Player(0): Waited 100ms for decoder to pause
2020-02-09 01:54:09.181810 I  VDPAU Painter: Clearing VDPAU painter cache.
2020-02-09 01:54:09.181835 I  VDPAU Painter: Clearing VDPAU painter cache.
2020-02-09 01:54:09.235329 I  VDPAU Painter: Clearing VDPAU painter cache.
2020-02-09 01:54:09.247328 I  TV::HandleStateChange(): Changing from WatchingPreRecorded to None
2020-02-09 01:54:09.247391 I  TV::StartTV(): Exiting main playback loop.
2020-02-09 01:54:09.282068 N  Resuming idle timer
2020-02-09 01:54:40.996012 I  Running HouseKeeperTask 'HardwareProfiler'.
2020-02-09 01:54:41.029253 I  HouseKeeperTask 'HardwareProfiler' Failed.